builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0245 starttime: 1479506492.72 results: success (0) buildid: 20161118070428 builduid: c123361a476643a3b4591fdbee8e2568 revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.725090) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.725812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.726230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.870772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.871192) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 14:01:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.4M=0s 2016-11-18 14:01:32 (24.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.989985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:32.990354) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025105 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:33.115998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 14:01:33.116348) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 14:01:33,213 truncating revision to first 12 chars 2016-11-18 14:01:33,213 Setting DEBUG logging. 2016-11-18 14:01:33,213 attempt 1/10 2016-11-18 14:01:33,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/26b31d10e8cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 14:01:34,390 unpacking tar archive at: cedar-26b31d10e8cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 14:01:34.596909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:34.597512) ========= script_repo_revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:34.598196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:34.598650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 14:01:34.619897) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-18 14:01:34.620594) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:01:34 INFO - MultiFileLogger online at 20161118 14:01:34 in /builds/slave/test 14:01:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 14:01:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:34 INFO - {'append_to_log': False, 14:01:34 INFO - 'base_work_dir': '/builds/slave/test', 14:01:34 INFO - 'blob_upload_branch': 'Cedar', 14:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:34 INFO - 'branch': 'Cedar', 14:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:34 INFO - 'config_files': ('talos/mac_config.py',), 14:01:34 INFO - 'default_actions': ('clobber', 14:01:34 INFO - 'read-buildbot-config', 14:01:34 INFO - 'download-and-extract', 14:01:34 INFO - 'populate-webroot', 14:01:34 INFO - 'create-virtualenv', 14:01:34 INFO - 'install', 14:01:34 INFO - 'run-tests'), 14:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:34 INFO - 'download_minidump_stackwalk': True, 14:01:34 INFO - 'download_symbols': 'ondemand', 14:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:34 INFO - 'installer_path': 'installer.exe', 14:01:34 INFO - 'log_level': 'info', 14:01:34 INFO - 'log_name': 'talos', 14:01:34 INFO - 'log_to_console': True, 14:01:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:01:34 INFO - 'opt_config_files': (), 14:01:34 INFO - 'pip_index': False, 14:01:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:34 INFO - 'cmd': ('bash', 14:01:34 INFO - '-c', 14:01:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:34 INFO - 'enabled': True, 14:01:34 INFO - 'halt_on_failure': False, 14:01:34 INFO - 'name': 'check_screen_resolution'},), 14:01:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:34 INFO - 'cmd': ('bash', 14:01:34 INFO - '-c', 14:01:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:34 INFO - 'enabled': True, 14:01:34 INFO - 'halt_on_failure': False, 14:01:34 INFO - 'name': 'check_screen_resolution'},), 14:01:34 INFO - 'run_cmd_checks_enabled': True, 14:01:34 INFO - 'sps_profile': False, 14:01:34 INFO - 'sps_profile_interval': 0, 14:01:34 INFO - 'suite': 'dromaeojs', 14:01:34 INFO - 'system_bits': '32', 14:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:34 INFO - 'title': 't-yosemite-r7-0245', 14:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:34 INFO - 'use_talos_json': True, 14:01:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:34 INFO - 'work_dir': 'build'} 14:01:34 INFO - [mozharness: 2016-11-18 22:01:34.823499Z] Running clobber step. 14:01:34 INFO - Running pre-action listener: _resource_record_pre_action 14:01:34 INFO - Running main action method: clobber 14:01:34 INFO - rmtree: /builds/slave/test/build 14:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:37 INFO - Running post-action listener: _resource_record_post_action 14:01:37 INFO - [mozharness: 2016-11-18 22:01:37.100041Z] Finished clobber step (success) 14:01:37 INFO - [mozharness: 2016-11-18 22:01:37.100202Z] Running read-buildbot-config step. 14:01:37 INFO - Running pre-action listener: _resource_record_pre_action 14:01:37 INFO - Running main action method: read_buildbot_config 14:01:37 INFO - Using buildbot properties: 14:01:37 INFO - { 14:01:37 INFO - "project": "", 14:01:37 INFO - "product": "firefox", 14:01:37 INFO - "script_repo_revision": "default", 14:01:37 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 14:01:37 INFO - "repository": "", 14:01:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 14:01:37 INFO - "buildid": "20161118070428", 14:01:37 INFO - "pgo_build": "False", 14:01:37 INFO - "basedir": "/builds/slave/test", 14:01:37 INFO - "buildnumber": 1, 14:01:37 INFO - "slavename": "t-yosemite-r7-0245", 14:01:37 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:01:37 INFO - "platform": "yosemite_r7", 14:01:37 INFO - "scheduler": "tests-cedar-macosx64-talos", 14:01:37 INFO - "branch": "cedar", 14:01:37 INFO - "repo_path": "projects/cedar", 14:01:37 INFO - "revision": "26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c", 14:01:37 INFO - "stage_platform": "macosx64", 14:01:37 INFO - "builduid": "c123361a476643a3b4591fdbee8e2568", 14:01:37 INFO - "slavebuilddir": "test" 14:01:37 INFO - } 14:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:01:37 INFO - Running post-action listener: _resource_record_post_action 14:01:37 INFO - [mozharness: 2016-11-18 22:01:37.103432Z] Finished read-buildbot-config step (success) 14:01:37 INFO - [mozharness: 2016-11-18 22:01:37.103569Z] Running download-and-extract step. 14:01:37 INFO - Running pre-action listener: _resource_record_pre_action 14:01:37 INFO - Running main action method: download_and_extract 14:01:37 INFO - mkdir: /builds/slave/test/build/tests 14:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:01:37 INFO - trying https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:01:37 INFO - Downloading https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:01:38 INFO - Downloaded 1199 bytes. 14:01:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:01:38 INFO - Using the following test package requirements: 14:01:38 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:01:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:01:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:01:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'jsshell-mac.zip'], 14:01:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:01:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:01:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:01:38 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:01:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:01:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:01:38 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:01:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:01:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:01:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:01:38 INFO - Fetch https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:01:39 INFO - Http code: 200 14:01:39 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:01:39 INFO - x-amz-cf-id: _AbP0NTLymF2ZfoRBWZz8iGJLi_Ha32qjhHreTfDgpGx2PPQi2apbg== 14:01:39 INFO - x-amz-version-id: xvjTfIzLwSuHJ75cEQ3VRYrE_J9sPB7f 14:01:39 INFO - Expected file size: 16222973 14:01:39 INFO - Obtained file size: 16222973 14:01:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:01:46 INFO - Http code: 200 14:01:46 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:01:46 INFO - x-amz-cf-id: Fba5oku05NGXzGHNEpL2G9EaFay_qSdDo3ifGI7wKDnOvS0KPtfkxA== 14:01:46 INFO - x-amz-version-id: xvjTfIzLwSuHJ75cEQ3VRYrE_J9sPB7f 14:01:46 INFO - Expected file size: 16222973 14:01:46 INFO - Obtained file size: 16222973 14:01:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:01:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:01:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:01:54 INFO - Http code: 200 14:01:54 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 14:01:54 INFO - x-amz-cf-id: ODvAPq4vihQCkaT3W8zQY3FXbNZEnHU58flIYjEz7aJz0l-NbJBmlQ== 14:01:54 INFO - x-amz-version-id: pK4I4WOsmOg9SS5gwqzO0BEa9xJ_z_Dv 14:01:54 INFO - Expected file size: 14409392 14:01:54 INFO - Obtained file size: 14409392 14:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:01:54 INFO - trying https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:01:54 INFO - Downloading https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:01:57 INFO - Downloaded 107379208 bytes. 14:01:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:01:57 INFO - mkdir: /builds/slave/test/properties 14:01:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:57 INFO - Contents: 14:01:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:01:58 INFO - Running post-action listener: _resource_record_post_action 14:01:58 INFO - Running post-action listener: set_extra_try_arguments 14:01:58 INFO - [mozharness: 2016-11-18 22:01:58.187760Z] Finished download-and-extract step (success) 14:01:58 INFO - [mozharness: 2016-11-18 22:01:58.187906Z] Running populate-webroot step. 14:01:58 INFO - Running pre-action listener: _resource_record_pre_action 14:01:58 INFO - Running main action method: populate_webroot 14:01:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:58 INFO - '--tppagecycles', 14:01:58 INFO - '7'], 14:01:58 INFO - 'tests': ['tsvgm']}}, 14:01:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:01:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:01:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['damp', 'tps']}, 14:01:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'tests': ['damp', 'tps']}, 14:01:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['dromaeo_dom']}, 14:01:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['basic_compositor_video']}, 14:01:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:01:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'other-e10s': {'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['a11yr', 14:01:58 INFO - 'ts_paint', 14:01:58 INFO - 'tpaint', 14:01:58 INFO - 'sessionrestore', 14:01:58 INFO - 'sessionrestore_no_auto_restore', 14:01:58 INFO - 'tabpaint']}, 14:01:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['tsvgx', 14:01:58 INFO - 'tsvgr_opacity', 14:01:58 INFO - 'tart', 14:01:58 INFO - 'tscrollx', 14:01:58 INFO - 'cart']}, 14:01:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:01:58 INFO - 'tsvgr_opacity', 14:01:58 INFO - 'tart', 14:01:58 INFO - 'tscrollx', 14:01:58 INFO - 'cart']}, 14:01:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'talos_options': ['--disable-e10s'], 14:01:58 INFO - 'tests': ['tp5o']}, 14:01:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:01:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'talos_options': ['--disable-e10s', 14:01:58 INFO - '--xperf_path', 14:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:58 INFO - 'tests': ['tp5n']}, 14:01:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:01:58 INFO - 'talos_options': ['--xperf_path', 14:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:58 INFO - 'tests': ['tp5n']}}, 14:01:58 INFO - 'talos.zip': {'path': '', 14:01:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:58 INFO - Running post-action listener: _resource_record_post_action 14:01:58 INFO - [mozharness: 2016-11-18 22:01:58.206071Z] Finished populate-webroot step (success) 14:01:58 INFO - [mozharness: 2016-11-18 22:01:58.206197Z] Running create-virtualenv step. 14:01:58 INFO - Running pre-action listener: _resource_record_pre_action 14:01:58 INFO - Running main action method: create_virtualenv 14:01:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:01:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:58 INFO - Using real prefix '/tools/python27' 14:01:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:01 INFO - Installing pip.................done. 14:02:01 INFO - Return code: 0 14:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:02:02 INFO - Reading from file tmpfile_stdout 14:02:02 INFO - Output received: 14:02:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:02:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:02 INFO - 'HOME': '/Users/cltbld', 14:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:02 INFO - 'LOGNAME': 'cltbld', 14:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:02 INFO - 'MOZ_NO_REMOTE': '1', 14:02:02 INFO - 'NO_EM_RESTART': '1', 14:02:02 INFO - 'PAGER': '/bin/cat', 14:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:02 INFO - 'PWD': '/builds/slave/test', 14:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:02 INFO - 'SHELL': '/bin/bash', 14:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:02 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:02 INFO - 'USER': 'cltbld', 14:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:02 INFO - 'XPC_FLAGS': '0x0', 14:02:02 INFO - 'XPC_SERVICE_NAME': '0', 14:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:02:02 INFO - Cleaning up... 14:02:02 INFO - Return code: 0 14:02:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:02 INFO - 'HOME': '/Users/cltbld', 14:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:02 INFO - 'LOGNAME': 'cltbld', 14:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:02 INFO - 'MOZ_NO_REMOTE': '1', 14:02:02 INFO - 'NO_EM_RESTART': '1', 14:02:02 INFO - 'PAGER': '/bin/cat', 14:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:02 INFO - 'PWD': '/builds/slave/test', 14:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:02 INFO - 'SHELL': '/bin/bash', 14:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:02 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:02 INFO - 'USER': 'cltbld', 14:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:02 INFO - 'XPC_FLAGS': '0x0', 14:02:02 INFO - 'XPC_SERVICE_NAME': '0', 14:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:02 INFO - Downloading/unpacking psutil>=3.1.1 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:06 INFO - Installing collected packages: psutil 14:02:06 INFO - Running setup.py install for psutil 14:02:06 INFO - building 'psutil._psutil_osx' extension 14:02:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:02:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:02:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:02:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:02:06 INFO - building 'psutil._psutil_posix' extension 14:02:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:02:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:02:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:02:07 INFO - ^ 14:02:07 INFO - 1 warning generated. 14:02:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:02:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:07 INFO - Successfully installed psutil 14:02:07 INFO - Cleaning up... 14:02:07 INFO - Return code: 0 14:02:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:07 INFO - 'HOME': '/Users/cltbld', 14:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:07 INFO - 'LOGNAME': 'cltbld', 14:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:07 INFO - 'MOZ_NO_REMOTE': '1', 14:02:07 INFO - 'NO_EM_RESTART': '1', 14:02:07 INFO - 'PAGER': '/bin/cat', 14:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:07 INFO - 'PWD': '/builds/slave/test', 14:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:07 INFO - 'SHELL': '/bin/bash', 14:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:07 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:07 INFO - 'USER': 'cltbld', 14:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:07 INFO - 'XPC_FLAGS': '0x0', 14:02:07 INFO - 'XPC_SERVICE_NAME': '0', 14:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:02:10 INFO - Installing collected packages: mozsystemmonitor 14:02:10 INFO - Running setup.py install for mozsystemmonitor 14:02:10 INFO - Successfully installed mozsystemmonitor 14:02:10 INFO - Cleaning up... 14:02:10 INFO - Return code: 0 14:02:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:10 INFO - 'HOME': '/Users/cltbld', 14:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:10 INFO - 'LOGNAME': 'cltbld', 14:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:10 INFO - 'MOZ_NO_REMOTE': '1', 14:02:10 INFO - 'NO_EM_RESTART': '1', 14:02:10 INFO - 'PAGER': '/bin/cat', 14:02:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:10 INFO - 'PWD': '/builds/slave/test', 14:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:10 INFO - 'SHELL': '/bin/bash', 14:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:10 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:10 INFO - 'USER': 'cltbld', 14:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:10 INFO - 'XPC_FLAGS': '0x0', 14:02:10 INFO - 'XPC_SERVICE_NAME': '0', 14:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:13 INFO - warning: no files found matching '*.txt' 14:02:13 INFO - no previously-included directories found matching 'build' 14:02:13 INFO - no previously-included directories found matching 'dist' 14:02:13 INFO - no previously-included directories found matching '.git*' 14:02:13 INFO - Installing collected packages: jsonschema, functools32 14:02:13 INFO - Running setup.py install for functools32 14:02:13 INFO - warning: no files found matching '*.txt' 14:02:13 INFO - no previously-included directories found matching 'build' 14:02:13 INFO - no previously-included directories found matching 'dist' 14:02:13 INFO - no previously-included directories found matching '.git*' 14:02:13 INFO - Successfully installed jsonschema functools32 14:02:13 INFO - Cleaning up... 14:02:13 INFO - Return code: 0 14:02:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:13 INFO - 'HOME': '/Users/cltbld', 14:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:13 INFO - 'LOGNAME': 'cltbld', 14:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:13 INFO - 'MOZ_NO_REMOTE': '1', 14:02:13 INFO - 'NO_EM_RESTART': '1', 14:02:13 INFO - 'PAGER': '/bin/cat', 14:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:13 INFO - 'PWD': '/builds/slave/test', 14:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:13 INFO - 'SHELL': '/bin/bash', 14:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:13 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:13 INFO - 'USER': 'cltbld', 14:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:13 INFO - 'XPC_FLAGS': '0x0', 14:02:13 INFO - 'XPC_SERVICE_NAME': '0', 14:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:02:14 INFO - Cleaning up... 14:02:14 INFO - Return code: 0 14:02:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:14 INFO - 'HOME': '/Users/cltbld', 14:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:14 INFO - 'LOGNAME': 'cltbld', 14:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:14 INFO - 'MOZ_NO_REMOTE': '1', 14:02:14 INFO - 'NO_EM_RESTART': '1', 14:02:14 INFO - 'PAGER': '/bin/cat', 14:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:14 INFO - 'PWD': '/builds/slave/test', 14:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:14 INFO - 'SHELL': '/bin/bash', 14:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:14 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:14 INFO - 'USER': 'cltbld', 14:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:14 INFO - 'XPC_FLAGS': '0x0', 14:02:14 INFO - 'XPC_SERVICE_NAME': '0', 14:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:18 INFO - Downloading docopt-0.6.1.tar.gz 14:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:18 INFO - Running setup.py install for blobuploader 14:02:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:18 INFO - Running setup.py install for requests 14:02:19 INFO - Running setup.py install for docopt 14:02:19 INFO - Successfully installed blobuploader requests docopt 14:02:19 INFO - Cleaning up... 14:02:19 INFO - Return code: 0 14:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:19 INFO - 'HOME': '/Users/cltbld', 14:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:19 INFO - 'LOGNAME': 'cltbld', 14:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:19 INFO - 'MOZ_NO_REMOTE': '1', 14:02:19 INFO - 'NO_EM_RESTART': '1', 14:02:19 INFO - 'PAGER': '/bin/cat', 14:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:19 INFO - 'PWD': '/builds/slave/test', 14:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:19 INFO - 'SHELL': '/bin/bash', 14:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:19 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:19 INFO - 'USER': 'cltbld', 14:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:19 INFO - 'XPC_FLAGS': '0x0', 14:02:19 INFO - 'XPC_SERVICE_NAME': '0', 14:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:19 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-zgJkfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-AcLW3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:19 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-9RDjtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-UnQDlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ZNJQZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-GVFx7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-gyxskm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-8mnNuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-z38I4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-hmJkHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-sqa8pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-sAoRi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:20 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Kxg4PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:21 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-8j3JWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:21 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Oto1MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:21 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-NZBlDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:21 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-5fnvt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:21 INFO - Running setup.py install for manifestparser 14:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozcrash 14:02:21 INFO - Running setup.py install for mozdebug 14:02:21 INFO - Running setup.py install for mozdevice 14:02:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozfile 14:02:22 INFO - Running setup.py install for mozhttpd 14:02:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozinfo 14:02:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozInstall 14:02:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozleak 14:02:22 INFO - Running setup.py install for mozlog 14:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for moznetwork 14:02:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Running setup.py install for mozprocess 14:02:23 INFO - Running setup.py install for mozprofile 14:02:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Running setup.py install for mozrunner 14:02:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Running setup.py install for mozscreenshot 14:02:23 INFO - Running setup.py install for moztest 14:02:23 INFO - Running setup.py install for mozversion 14:02:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:24 INFO - Cleaning up... 14:02:24 INFO - Return code: 0 14:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:24 INFO - 'HOME': '/Users/cltbld', 14:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:24 INFO - 'LOGNAME': 'cltbld', 14:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:24 INFO - 'MOZ_NO_REMOTE': '1', 14:02:24 INFO - 'NO_EM_RESTART': '1', 14:02:24 INFO - 'PAGER': '/bin/cat', 14:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:24 INFO - 'PWD': '/builds/slave/test', 14:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:24 INFO - 'SHELL': '/bin/bash', 14:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:24 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:24 INFO - 'USER': 'cltbld', 14:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:24 INFO - 'XPC_FLAGS': '0x0', 14:02:24 INFO - 'XPC_SERVICE_NAME': '0', 14:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-yNt70n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-kzqNae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-BrTHRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ISfKmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-hJ5y67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-a96EG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:24 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ahVeN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ZCkqfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-iEW7Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-_WS1L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-bC8_f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-d__tsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-KxXAG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-3nvv7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-3X2jCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:25 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-JfaDSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:26 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-D4dxJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:28 INFO - Downloading blessings-1.6.tar.gz 14:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:28 INFO - Installing collected packages: blessings 14:02:28 INFO - Running setup.py install for blessings 14:02:28 INFO - Successfully installed blessings 14:02:28 INFO - Cleaning up... 14:02:28 INFO - Return code: 0 14:02:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:29 INFO - Reading from file tmpfile_stdout 14:02:29 INFO - Current package versions: 14:02:29 INFO - blessings == 1.6 14:02:29 INFO - blobuploader == 1.2.4 14:02:29 INFO - docopt == 0.6.1 14:02:29 INFO - functools32 == 3.2.3-2 14:02:29 INFO - jsonschema == 2.5.1 14:02:29 INFO - manifestparser == 1.1 14:02:29 INFO - mozInstall == 1.12 14:02:29 INFO - mozcrash == 1.0 14:02:29 INFO - mozdebug == 0.1 14:02:29 INFO - mozdevice == 0.48 14:02:29 INFO - mozfile == 1.2 14:02:29 INFO - mozhttpd == 0.7 14:02:29 INFO - mozinfo == 0.9 14:02:29 INFO - mozleak == 0.1 14:02:29 INFO - mozlog == 3.4 14:02:29 INFO - moznetwork == 0.27 14:02:29 INFO - mozprocess == 0.23 14:02:29 INFO - mozprofile == 0.28 14:02:29 INFO - mozrunner == 6.13 14:02:29 INFO - mozscreenshot == 0.1 14:02:29 INFO - mozsystemmonitor == 0.3 14:02:29 INFO - moztest == 0.7 14:02:29 INFO - mozversion == 1.4 14:02:29 INFO - psutil == 3.1.1 14:02:29 INFO - requests == 1.2.3 14:02:29 INFO - wsgiref == 0.1.2 14:02:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:30 INFO - 'HOME': '/Users/cltbld', 14:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PAGER': '/bin/cat', 14:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:30 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - 'XPC_FLAGS': '0x0', 14:02:30 INFO - 'XPC_SERVICE_NAME': '0', 14:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:30 INFO - Cleaning up... 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e243f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac58d6ed80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:30 INFO - 'HOME': '/Users/cltbld', 14:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PAGER': '/bin/cat', 14:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:02:30 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - 'XPC_FLAGS': '0x0', 14:02:30 INFO - 'XPC_SERVICE_NAME': '0', 14:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:02:31 INFO - Cleaning up... 14:02:31 INFO - Return code: 0 14:02:31 INFO - Running post-action listener: _resource_record_post_action 14:02:31 INFO - Running post-action listener: _start_resource_monitoring 14:02:31 INFO - Starting resource monitoring. 14:02:31 INFO - [mozharness: 2016-11-18 22:02:31.262961Z] Finished create-virtualenv step (success) 14:02:31 INFO - [mozharness: 2016-11-18 22:02:31.263828Z] Running install step. 14:02:31 INFO - Running pre-action listener: _resource_record_pre_action 14:02:31 INFO - Running main action method: install 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Output received: 14:02:31 INFO - Usage: mozinstall [options] installer 14:02:31 INFO - Options: 14:02:31 INFO - -h, --help show this help message and exit 14:02:31 INFO - -d DEST, --destination=DEST 14:02:31 INFO - Directory to install application into. [default: 14:02:31 INFO - "/builds/slave/test"] 14:02:31 INFO - --app=APP Application being installed. [default: firefox] 14:02:31 INFO - mkdir: /builds/slave/test/build/application 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:03:04 INFO - Reading from file tmpfile_stdout 14:03:04 INFO - Output received: 14:03:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:03:04 INFO - Running post-action listener: _resource_record_post_action 14:03:04 INFO - [mozharness: 2016-11-18 22:03:04.314045Z] Finished install step (success) 14:03:04 INFO - [mozharness: 2016-11-18 22:03:04.314177Z] Running run-tests step. 14:03:04 INFO - Running pre-action listener: _resource_record_pre_action 14:03:04 INFO - Running main action method: run_tests 14:03:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:03:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:03:04 INFO - 2016-11-18 14:03:04.327 screenresolution[1630:7320] starting screenresolution argv=screenresolution get 14:03:04 INFO - 2016-11-18 14:03:04.329 screenresolution[1630:7320] Display 0: 1600x1200x32@60 14:03:04 INFO - 2016-11-18 14:03:04.335 screenresolution[1631:7322] starting screenresolution argv=screenresolution list 14:03:04 INFO - Available Modes on Display 0 14:03:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:03:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:03:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:03:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:03:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:03:04 INFO - Intel Iris: 14:03:04 INFO - Chipset Model: Intel Iris 14:03:04 INFO - Type: GPU 14:03:04 INFO - Bus: Built-In 14:03:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:03:04 INFO - Vendor: Intel (0x8086) 14:03:04 INFO - Device ID: 0x0a2e 14:03:04 INFO - Revision ID: 0x0009 14:03:04 INFO - Displays: 14:03:04 INFO - Display: 14:03:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:03:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:03:04 INFO - Display Serial Number: 1600x1200 60 14:03:04 INFO - Main Display: Yes 14:03:04 INFO - Mirror: Off 14:03:04 INFO - Online: Yes 14:03:04 INFO - Rotation: Supported 14:03:04 INFO - Return code: 0 14:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:04 INFO - Python 2.7.3 14:03:04 INFO - Return code: 0 14:03:04 INFO - grabbing minidump binary from tooltool 14:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c3ad30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aa1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c32b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:03:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:03:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:04 INFO - Return code: 0 14:03:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:03:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:03:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0245 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Slkc3X2N76/Render', 14:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:04 INFO - 'HOME': '/Users/cltbld', 14:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PAGER': '/bin/cat', 14:03:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners', 14:03:04 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 14:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - 'XPC_FLAGS': '0x0', 14:03:04 INFO - 'XPC_SERVICE_NAME': '0', 14:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:03:04 INFO - mozversion application_buildid: 20161118070428 14:03:04 INFO - mozversion application_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 14:03:04 INFO - mozversion application_display_name: Nightly 14:03:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:04 INFO - mozversion application_name: Firefox 14:03:04 INFO - mozversion application_remotingname: firefox 14:03:04 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 14:03:04 INFO - mozversion application_vendor: Mozilla 14:03:04 INFO - mozversion application_version: 53.0a1 14:03:04 INFO - mozversion platform_buildid: 20161118070428 14:03:04 INFO - mozversion platform_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 14:03:04 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 14:03:04 INFO - mozversion platform_version: 53.0a1 14:03:04 INFO - using testdate: 1479506584 14:03:04 INFO - actual date: 1479506584 14:03:04 INFO - starting webserver on 'localhost:49246' 14:03:04 INFO - SUITE-START | Running 2 tests 14:03:04 INFO - TEST-START | dromaeo_css 14:03:04 INFO - operating with platform_type : mac_ 14:03:04 INFO - Initialising browser for dromaeo_css test... 14:03:04 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpBydCnQ/profile http://localhost:49246/getInfo.html) 14:03:07 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 14:03:07 INFO - PROCESS | 1641 | colorDepth:24 14:03:07 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 14:03:07 INFO - PROCESS | 1641 | __metrics 14:03:07 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:03:07 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:08 INFO - TEST-INFO | 1641: exit 0 14:03:08 INFO - Browser initialized. 14:03:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:08 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpBydCnQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:20 INFO - PROCESS | 1643 | RSS: Main: 236093440 14:03:20 INFO - PROCESS | 1643 | 14:04:12 INFO - PROCESS | 1643 | 1479506652558 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:06:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 14:06:27 INFO - PROCESS | 1643 | RSS: Main: 398700544 14:06:27 INFO - PROCESS | 1643 | 14:09:29 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 14:09:30 INFO - PROCESS | 1643 | RSS: Main: 369713152 14:09:30 INFO - PROCESS | 1643 | 14:12:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 14:12:33 INFO - PROCESS | 1643 | RSS: Main: 345239552 14:12:33 INFO - PROCESS | 1643 | 14:15:35 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 14:15:36 INFO - PROCESS | 1643 | RSS: Main: 340180992 14:15:36 INFO - PROCESS | 1643 | 14:18:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 14:18:40 INFO - PROCESS | 1643 | RSS: Main: 329211904 14:18:40 INFO - PROCESS | 1643 | 14:21:43 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 14:21:43 INFO - PROCESS | 1643 | RSS: Main: 445702144 14:21:43 INFO - PROCESS | 1643 | 14:21:43 INFO - PROCESS | 1643 | __start_tp_report 14:21:43 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:21:43 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:21:43 INFO - PROCESS | 1643 | |i|pagename|runs| 14:21:43 INFO - PROCESS | 1643 | |0;dojo.html;3296.8351582420883;3317.1375442384974;3326.218338690408;3343.465045592706;3377.7466689998255;4460.598546130847;5131.743412829358;5483.862903427416;5576.832695019146;5619.859503512414;4859.173940430126;5412.2152287918225;5584.078627026536;5698.202251684757;5709.4290570942985;5048.293238946532;5059.342285502879;5067;5094.388673359202;5120.436751957282;5094.923576146361;5230.607704422165;5233.947660523384;5240.711760853152;5243.187305967562;5064.037832811754;5092.949070509321;5179.870503237412;5251.448597897223;5259.789608415697;5136.383633963911;5139.948600513984;5144.871378215537;5150.407703114152;5154.896902061975;5053.797848086072;5100.515451032146;5108.080545501808;5125.564327032207;5129.1024070787835;4672.299155126724;5527.309086364205;5604.243427137325;5630.239917611111;5637.71811409432;6070.9679354509835;6075.33171351151;6082.787102451393;6118.571699981003;6139.938600613981;6133.539984501135;6156.907646385308;6169;6171.59884607499;6172.691365431755;5594.13290939905;5644.8024319148635;5645.435456454404;5657.660540367591;5689.857753556153;6113.385090541919;6126.9561142435105;6130.417610327012;6132.397922269778;6141.915626108677;6044.818655440344;6054.39456054391;6055.424734650202;6060.969695151584;6117;6029.728662210211;6091.695415229221;6129;6145.96927015371;6147.047207682816;4945.925811112764;6038.667873266924;6039.4262545058145;6057.939420605738;6136.8953588354525;5968.820935371859;6095.35998720128;6112.572119951649;6118.265808103056;6123.846903827351;4877.6829506081995;4886.804527818847;4890.779914903838;4893.755312234445;4901.142300097468;4326.567343265711;4352.630026447788;4379.080393117481;4408.162449134654;4434.645228381722;4548.931766023512;4743.335932969387;5273.1035723927025;5388.625900395374;5667.829965100971;6053.576249662569;6183.598066125687;6204.937950620526;6224.035274532454;6231.626102433868;5468.72656367188;5482.5888058394985;5503.449655034545;5619.8595035124445;5629.493345598916;5257.342832145981;5283.630145889828;5287.841364759063;5309.097453432925;5354.651947623392;6264.21697287839;6298.244210694746;6320;6342.809715708536;6384;6047.727852246748;6182.258129024546;6202.162708034358;6209.565330427007;6211.161493198541;6172.197614310111;6248.0940263660605;6281.96859015702;6297.874042519215;6308.243010838729;6104.85328883332;6114.966544785144;6131.743695906945;6134.467201660849;6135.324535308442;6126.969365153146;6130.570860039933;6157.753689852356;6174.753009879554;6190.442860142609;5804.970975145097;5870.5010074142465;5870.765169393348;5943.524518038633;6018.7291571878495;5931.881362372815;5966.463018328372;5982.222311099529;6058.454739073504;6100.450959413674;5891.23413956183;5907.822765317047;5909.2908850938165;5915.142304365757;5915.526757859275;6006.519478441802;6028.728707208274;6084.330723620486;6099.146119543356;6099.420555047263;5685.374608793112;5737.770489180386;5768.826935191951;5811.680357580373;5846.795362162304 14:21:43 INFO - PROCESS | 1643 | |1;ext.html;489.8359049718344;509.93370861787963;512.4542362384063;527.3355571979306;527.42247239273;29955.65199566019;38814.41778373323;39700.40449393261;39789.40315895264;39790;40562.98592535188;41089.79455102728;41475.96310092249;41541.792291038575;41579.79210103945;9205.58574864131;9434.528273586327;9439.575219115122;9441.24470042395;9447.196988256006;7916.683332666716;9334.906650933472;9340.15938565529;9342.579583918707;9343.813123737522;9281.35030547862;9352.579133938954;9360.765980850465;9362.578683959204;9364.391314564566;9288.256939444862;9339.486328251944;9348.626054957827;9350.67272645454;9360.71917842459;9144.40561363516;9195.862062069074;9225.492597907112;9228.077192280785;9249.953750231272;38642.8407147786;38917.41623875616;38943.61056389428;38960.83117506479;38985.41521877174;3290.2925870937866;3312.188513814131;3385.9661403386144;3518.8416521256604;3656.8902932912056;23334.416639583975;29431.558526622117;29490.557641635394;30170.84914575435;30480.237994050105;3121.32891428344;3159.699828516287;3161.1148878314107;3194.361127774431;3283.83580820958;445454;468331.6583417095;469077.65461172815;470303;470445;57634.55913602193;57831;57858;57895.71052144797;58063;33893;34615.307693845985;34684.13289667728;56666.583335416944;56874.7156264216;15237;15684.843151568339;15709.607259818367;15753.606159845865;15758.527244182693;11894.405279735978;12015.699607509707;12027.458764355624;12029.518819247132;12050.39748012596;18754.812451875307;18756.81243187578;18762;18771.530711732317;18797.718034229496;6828.897566536506;7536.924630753732;7642.235776422313;7676.961615192;7703.807404814813;851.6933903794629;920.8158368326227;989.5299732626945;1042.1298215989582;1051.5373235776235;27778.02776902839;28739.856300718362;29151.979680711072;29409.85295073511;29562.817487300697;1019.99490002551;1044.12815299226;1072.9195310351754;1095.4358505369742;1115.4645770030268;14482.058666186664;14925.104493730194;14956;15373.692526149414;15801.683966320608;634179;640386;641913;643123;645394;55807.720961395746;56103;56235.71882140563;56236.71881640647;56348.71825640846;1300.2978391668582;1340.162398500937;1358.0900796466194;1362.128237927727;1362.1338765890794;24605.87697061503;25447.982080717306;28915.7108428913;29153.708462915947;29672.851635741685;49646;49842.504724858314;49906.75046624744;49929.75175620639;49942.75028624834;568347;571059.1447042738;571154;571660;572464;21446.356609301747;25468.853901574104;25845.353866153495;26195.869020655537;26218.344541386617;44660;45752.313715294964;45802;45970.31044534268;46389.84025399392;33426;34851.9544413668;35922;36481.63518364782;37403.625963741106;36745.63254367422;36801;37876.62123378841;38027.61972380241;38311.80844095762;31898.362032758752;36299.81850090838;36389;36611.01049445548;37497.81251093836;31084.68915310818;31643.20891977627;32930;33228.66771332256;33339.333213335114;24434.389140270923;24456.877715611306;24779.87610061938;24960.251192464257;24972.37569060788 14:21:43 INFO - PROCESS | 1643 | |2;jquery.html;347.96520347965225;366.90277076574705;368.5080417642447;376.25689263704186;395.4838935189578;14400.351984160712;14874.330655120519;15580.922095389522;19735.5066123347;20209.494762630904;18386.264549418007;18559.90720046401;20278.49303767403;20389.694154587694;20481.897590512064;5193.195054766517;5500.6424582402215;5502.449755024506;5514.09017512112;5519;4432.180046691356;5420.945790542103;5979.970100149493;6028.397160283958;6072.817815465543;5979.133025711291;6010.75956961721;6013.729382177812;6013.879722405549;6029.336772954972;5242.606804489678;5325.387580428262;5329.866753331159;5367.1680889462195;5380.542653874425;4511.819527218908;5152.768125434327;5182.093133701587;5227.398849132361;5236.057509648262;12394.62816115518;12983.35083245834;13086.803697944539;13092.541761038414;13097.934510327483;2115.6509175985943;2212.3805334506364;2276.6357382818837;2309.445733024079;2857.528507796211;8623.56882155896;9824.06671366219;9854.950725246399;9915.851262231072;10434.739131521697;1787.901665408402;1860.3209828412666;1861.64628720544;1886.9528261793428;1937.053202082705;92401.5379923096;119846.80153198444;121495;125646;125906;9414.19979301767;11082.944585277184;11348.54605815758;11587.304761714324;11640.010599099001;14329.068610540282;14346.641333966734;14347.85652143486;14364.425422982964;14369.497067602584;7989.121196668362;8076.434649574473;8258.793530161794;8283.337333013344;8381.49711017341;7809;8047.275745182962;8194.22154895284;8231.300339471212;8273.751787446387;3837.7505462144873;3896.7272290939927;4325.4593175853015;4410.514843367227;4500.662450316239;1859.6559636467298;1904.8952307622937;1907.9427617171507;1913.6172765446966;1913.8564607654482;790.3884010254183;892.8883889513811;893.78102364921;905.8912930448388;947.545178314413;16726.74909876353;19667.508312292022;21187.576248474943;21468.677969830464;21943.890280548814;873.2882700598991;906.3383729877227;911.7994041310901;953.9284553658504;970.5583959298502;10165.898341016495;10981.890181098086;10994.670159895217;11023.669289921316;11034.779304414027;542509;570845;580044;587089.1291087035;587601;88932.9999999987;121804;123064;126311.36844315719;126488;970.2819913264275;979.6130528441225;1008.1531513528671;1009.2228983682523;1009.2783659683362;17962.730559041887;18051.277948881896;18171.636567268844;18229.179686914387;18259.9044057357;41525.54660586865;46866;51413.7429312866;51568.48431515787;52739.73630131825;56984;61165.38834611597;73018.63490682513;75749;76988;7719.343855772097;7918.287354137925;7941.404394670307;7984.201579842202;8123.512589244664;10217.795644087226;12154.088443366605;12279.868633498401;12350.81473777876;12355.505779768708;8825.823483530421;10504.632337868137;10796.56813727442;10923.453827308762;10949.671509854717;5450.863728406663;6060.878737433589;10534.789304214026;10563.63027294041;10824;10491.422971736627;10545.789084218426;10733.463326833471;11114.222004459934;11182.552697891993;7678;7898.407619428681;7938.5236885784725;8176.305014073871;8184.304334131427;9616.423014619146;10359.63741269052;10801.837972430578;10847.457627118454;10863.185261105291 14:21:43 INFO - PROCESS | 1643 | |3;mootools.html;1330.780421230497;1380.779075347944;1462.217713523265;1635.9345626174954;1857.2106854586789;7366.152892417367;7745.961270193641;7766.378689704817;7768.300852923236;7770.0287464067;6992.6154061526595;7594.974678418412;7952.880706789403;8142.91857081429;8189.1810818918075;2270.19408110121;2304.5045315257216;2305.8040066594276;2308.676785250066;2311.2719493359623;1910.9713354299697;2105.9262925797602;2118.3539020598787;2338.777816107467;2343.7773411525877;2213.214308920334;2242.4505996030994;2245.158065725353;2246.6742322363248;2289.290320000805;2247.168547637368;2255.6503741919946;2281.7376001759844;2283.497630521291;2287.7025986621634;2297.8046866016407;2313.838031337807;2314.67594536765;2315.814734821227;2325.5930212212793;8161.428699991003;8193.50838949659;8254.298384637314;8262.132476089984;8267.421280510367;4986.62600304975;5016.372953380827;5192.58459323257;5192.948070519322;5203.791848326063;3535.717142628609;3624.3294990426593;3627.0569651890432;3627.3289441453417;3627.4921510988484;890.7505898348472;907.7912080221586;923.289067418091;931.3620170183447;935.7379933618598;10691.465426728633;10855.24013319068;10876.075533579655;10883.020528152425;10885.619003334925;4178.874633760992;4346;4431.8670439886855;4442.577955094261;4464.933026004613;8644.740657780276;8705.347098967603;8708.259797917248;8711.47731136134;8738.082501337269;5099.3370861787735;5105.668131571436;5105.8723531912;5113.360829896263;5114.590832733446;4277.465316835395;4426.402435671143;4442.844500442469;4663.696859704109;4747.596454301354;3102.705243001911;3544.096255454894;3608.2422691235133;3661.9633803662155;3701.9444708329397;965.9903400966041;1134.7843909657304;1135.8353038809491;1149.689583812366;1155.5493357590547;759.1649185895582;871.5685735560938;879.1296616349767;881.3566096749408;906.7325139083986;5286.127788914786;5622.57830662702;5734.397888221677;5874.882502350015;6053.727582258721;786.7482405630143;866.7096522664851;889.6886089868624;892.2727976698969;954.374884450686;3381.6980462522106;3524.753267271318;3789.412641040643;3920.9215815684097;3924.6271604197555;9621;9825.164860986753;10088.243381746399;10111.191104711605;10113.797724045478;9912.405255684682;10029.598816047277;10099.69700908974;10110.342827716322;10117.089461948313;7664.540127592362;7669.463137580427;7793.766187014286;7892.763217103496;7958.2041795821115;4633.791479383503;4918.8989801309635;5552.639078459887;5595.384507704231;5643.746031428514;7721.652525636247;9300.581473833558;9362.578683959102;9409.388389754644;9490.28822838276;9404.858927115962;9432.905670943477;9530.714078577654;9568.330216884751;9668.613255469983;5781.797637082682;5885.55858310637;6680.432163265982;6756.6959486822225;6819.2498825128205;7986.241307075818;8061.072976607765;8064;8071.354291656536;8075.515469071875;6990.335918087773;7075.575465472089;7087.184973727881;7181.640917954186;7217.170025446931;6796.082528858738;6993.918764245048;7034;7045.295470452914;7170.139583250043;5954.821355359346;6504.6015106752275;6595.472362210916;6650.600963942179;6721.596704197764;4708.576228139484;4768.880777980578;4776.331313616166;4798.688085274446;4920.6801557898625;4483.910321793611;4645.397337918413;4742.454617718869;4795.712257264575;4892.168331383602 14:21:43 INFO - PROCESS | 1643 | |4;prototype.html;265.9932156786563;297.57744003515006;301.2168362258129;304.89176342398457;313.64244760972497;4303.591158839905;4940.407151141863;4952.628552858532;5113.846584602463;5120.308758317626;4988.700677959325;5029.5221953914415;5038.345015148026;5132.409772876111;5137.974310128454;3473.2879759649336;3777.5844657087837;3963.365861462167;3967.1470633813797;3992.5208974922903;3752.8311225994894;3939.9409008864745;3951.404222157837;3953.7430067045693;3975.264576053425;3255.9837200813963;3276.9672303276902;3282.83585820708;3878.3600705883496;3887.1448281378052;3880.9611903881023;3885.922281554353;3906.570277269498;3925.862594809168;3947.624975627311;2771.764400026;3139.152428844222;3354.5639066921144;3397.7937832069506;3400.25194457219;4186.769727664977;4503.504614492404;5014.548690617826;5053.74731263439;5070.467600901926;4096.467459230281;4443.7111587746695;4445.844395446176;4447.776861363119;4483.843065492725;5080.466551012128;5346.572274218053;5349.759260833272;5369.697635953899;5408.864778380533;3172.98413507931;3621.7102631789658;3700.259948010382;3728.7762734236035;3737;5550.4449555044575;5550.5282051026115;5562.663681253883;5586.748596313217;5591.944080559183;3289.0954987378664;3404.642512536148;3707.740458167956;3712.5916149223563;3731.1045349116016;3619.674229319374;3658.396364599811;3765.981170094132;3786.390783916824;3820.1595648957186;3500.4224302989724;3686.594474607791;4097.262492751333;4347.9565204347555;4374.119128774658;5349.652272602269;5356.91964620531;5361.517463428232;5364.22218778275;5381.946180538144;1028.953697083633;1074.9032587067045;1116.525476672411;1174.3599738142732;1221.5785553983862;684.4319215051495;730.441212472459;806.4636866768815;841.7937605286621;851.6976473351871;3890.630390112935;3901.882943511699;4373.846915357947;4418.365204874153;4525.705829121097;5122.334096567422;5139.6145289102715;5143.897122057538;5160.458151894072;5172.301739265226;4241.830326786894;4494.606671931646;4656.348111264426;4676.134915040729;4680.5085466025575;2313.6298192289155;2496.3274606014015;2515.584928486816;2702.932426689309;2715.1447294102295;4775.976120119377;4855.6115510759055;5148.33071700684;5201.375834899761;5311.3095297611835;5199.688018718889;5222.490272762272;5253.3958594761325;5262.368515778131;5273.947260527422;4405.427294451701;4647.420681521788;5093.567046800989;5277.182036784305;5294.788208471695;4522.819087236474;4846.80612775485;5094.694318340911;5105.617078719037;5194.7272918135295;4313;4797.712137271775;5015.874603134951;5031.371078615173;5032.3206367139965;4568.857785553611;4799.728072060837;5215.4002289735645;5255.500727430888;5336.946630533645;3005.729484346419;3009.5102924052735;3481.8433170506883;3499.4575840744724;3508.8070156140634;4570.154521413549;4929.901401971869;5028.245763135559;5081.577158395655;5086.160783470686;4234.273839021641;4329.8051587678;4672.901868060935;4975.800967961241;5093.643444958817;4685.461171965131;5390.897549955599;5404.675719456845;5420.4850539198715;5435.466946484817;5095.312132862016;5300.349825087456;5304.28392167068;5305.973470132624;5316.494932981361;4205.3271476563605;5097.490250975021;5384.165454354581;5394.433584473573;5407.486288802557;4490.012197316585;4523.7285762854335;4944.983560028308;5263.999520273407;5361.410244873139 14:21:44 INFO - PROCESS | 1643 | |5;yui.html;676.7022510095559;699.4334588982924;729.3654520567104;759.312821896184;788.2314743125457;13459.528916487925;15803.288852001673;16389.344426222935;16619;16688.499345019638;12304.507819687224;15307.693846123071;15539.68920621587;15625.765613515807;15718.135502547355;809.0695699945081;827.4001349021971;830.5390508267909;831.6590198018813;831.9833603327929;647.1522305779444;674.9763758268462;677.0250838792124;831.2269589281965;836.6318819719304;740.4779630360583;840.8192238668685;872.995635021824;883.4610887358706;884.2881480408269;869;869.0483920107472;870.447265986097;871.063606622883;871.9520426376547;498.6563153180068;513.7225898015067;643.707113263464;643.7457204404234;644.1207751419279;11951.103667224907;12291.877081229162;12297.446614902261;12313.876861231363;13883.58349249514;12278.815817762741;12885.742285154338;12892.419841107172;12987.87012129876;13145;10895.455227238606;11121;11217.887821121847;11401.258918170292;11430.25703329281;3051.67957364478;3594.6944509716445;3627.2564124354444;3631.8365673544754;3646.2707458508403;87935.68096478558;88397.55801220953;90303;91988.99999999933;92908;10344.844827327595;10396.896031039592;10416.427096509764;10615.25693201484;10748.467230705959;19334.709979350322;19976.60046799056;20024.898630575168;20117.19531218764;20141.899290503454;7003;7441.1070671519765;7519.699212031567;7580.1661817200065;7592.202818704067;4123.340265557496;4328.675349348749;4361.433013708198;4404.647628189737;4449.3326001100095;3356.9496457553155;3471.965280347164;3479.2171761353998;3481.912952176165;3487.1805125795418;594.6135012242078;598.4853026397295;626.1797045869924;627.8744251149789;631.0376675569701;541.5288698832042;565.2115299157653;639.6961443314482;665.1785045468939;679.0123456790163;7737.49706269102;8584.957075214585;8675.913240867636;8995.23540499065;9166.358354915092;603.8822429626268;619.9101130336076;627.8869803435334;654.3848782144769;660.4914216053612;3926.293267211929;4394.252976993918;4461.57615026572;4466.731996080245;4505.7296562206375;114249;115787.42106289415;116081;116340.41829790967;120090;103422;103666.77999320065;104940;105988.63164841055;107720.4613976925;84010.8997275073;87749.56125219334;90125.09874901298;91830;93604.53197734104;8414.200650938152;9025.427753090338;9395.85906211421;9564.617415303588;9580.281478888972;45937.540624593326;51309.477151744504;51383.48616513787;51593.74203128961;52651.68370790761;68417.65791171012;68968.6551567239;69368.6531567339;69875.30124698688;72815.27184728085;11884.584039558575;11927.224730392496;11971.521139154336;12063;12318.75362492763;13758.93120534391;13997;14248.287585620885;14501.854981450051;14784.926075369554;12801.61595152147;13173.934130329288;13638.181709097486;13660;13806.65483362924;12624.684382890502;12722.936385318384;12912.870871291167;13106.868931310564;13160.276184809927;12557.686057848627;12736.87263127394;12990.740185196431;13371.531996380469;13387.866121339051;10046.296759226783;10348.22388320894;10416.583336666448;10471.21465890046;10783.6225732099;10104.94947525287;10548.261621686715;10556.788864222826;10776.245662803529;10848.67453976382 14:21:44 INFO - PROCESS | 1643 | __end_tp_report 14:21:44 INFO - PROCESS | 1643 | __start_cc_report 14:21:44 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1716 14:21:44 INFO - PROCESS | 1643 | __end_cc_report 14:21:44 INFO - PROCESS | 1643 | __startTimestamp1479507703984__endTimestamp 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:21:44 INFO - PROCESS | 1643 | Number of tests: 6 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5618.01 Median:5870.50 stddev:652.25 (11.1%) stddev-sans-first:628.31 14:21:44 INFO - PROCESS | 1643 | Values: 3296.8 3317.1 3326.2 3343.5 3377.7 4460.6 5131.7 5483.9 5576.8 5619.9 4859.2 5412.2 5584.1 5698.2 5709.4 5048.3 5059.3 5067.0 5094.4 5120.4 5094.9 5230.6 5233.9 5240.7 5243.2 5064.0 5092.9 5179.9 5251.4 5259.8 5136.4 5139.9 5144.9 5150.4 5154.9 5053.8 5100.5 5108.1 5125.6 5129.1 4672.3 5527.3 5604.2 5630.2 5637.7 6071.0 6075.3 6082.8 6118.6 6139.9 6133.5 6156.9 6169.0 6171.6 6172.7 5594.1 5644.8 5645.4 5657.7 5689.9 6113.4 6127.0 6130.4 6132.4 6141.9 6044.8 6054.4 6055.4 6061.0 6117.0 6029.7 6091.7 6129.0 6146.0 6147.0 4945.9 6038.7 6039.4 6057.9 6136.9 5968.8 6095.4 6112.6 6118.3 6123.8 4877.7 4886.8 4890.8 4893.8 4901.1 4326.6 4352.6 4379.1 4408.2 4434.6 4548.9 4743.3 5273.1 5388.6 5667.8 6053.6 6183.6 6204.9 6224.0 6231.6 5468.7 5482.6 5503.4 5619.9 5629.5 5257.3 5283.6 5287.8 5309.1 5354.7 6264.2 6298.2 6320.0 6342.8 6384.0 6047.7 6182.3 6202.2 6209.6 6211.2 6172.2 6248.1 6282.0 6297.9 6308.2 6104.9 6115.0 6131.7 6134.5 6135.3 6127.0 6130.6 6157.8 6174.8 6190.4 5805.0 5870.5 5870.8 5943.5 6018.7 5931.9 5966.5 5982.2 6058.5 6100.5 5891.2 5907.8 5909.3 5915.1 5915.5 6006.5 6028.7 6084.3 6099.1 6099.4 5685.4 5737.8 5768.8 5811.7 5846.8 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68037.41 Median:38477.32 stddev:150804.09 (391.9%) stddev-sans-first:151141.85 14:21:44 INFO - PROCESS | 1643 | Values: 489.8 509.9 512.5 527.3 527.4 29955.7 38814.4 39700.4 39789.4 39790.0 40563.0 41089.8 41476.0 41541.8 41579.8 9205.6 9434.5 9439.6 9441.2 9447.2 7916.7 9334.9 9340.2 9342.6 9343.8 9281.4 9352.6 9360.8 9362.6 9364.4 9288.3 9339.5 9348.6 9350.7 9360.7 9144.4 9195.9 9225.5 9228.1 9250.0 38642.8 38917.4 38943.6 38960.8 38985.4 3290.3 3312.2 3386.0 3518.8 3656.9 23334.4 29431.6 29490.6 30170.8 30480.2 3121.3 3159.7 3161.1 3194.4 3283.8 445454.0 468331.7 469077.7 470303.0 470445.0 57634.6 57831.0 57858.0 57895.7 58063.0 33893.0 34615.3 34684.1 56666.6 56874.7 15237.0 15684.8 15709.6 15753.6 15758.5 11894.4 12015.7 12027.5 12029.5 12050.4 18754.8 18756.8 18762.0 18771.5 18797.7 6828.9 7536.9 7642.2 7677.0 7703.8 851.7 920.8 989.5 1042.1 1051.5 27778.0 28739.9 29152.0 29409.9 29562.8 1020.0 1044.1 1072.9 1095.4 1115.5 14482.1 14925.1 14956.0 15373.7 15801.7 634179.0 640386.0 641913.0 643123.0 645394.0 55807.7 56103.0 56235.7 56236.7 56348.7 1300.3 1340.2 1358.1 1362.1 1362.1 24605.9 25448.0 28915.7 29153.7 29672.9 49646.0 49842.5 49906.8 49929.8 49942.8 568347.0 571059.1 571154.0 571660.0 572464.0 21446.4 25468.9 25845.4 26195.9 26218.3 44660.0 45752.3 45802.0 45970.3 46389.8 33426.0 34852.0 35922.0 36481.6 37403.6 36745.6 36801.0 37876.6 38027.6 38311.8 31898.4 36299.8 36389.0 36611.0 37497.8 31084.7 31643.2 32930.0 33228.7 33339.3 24434.4 24456.9 24779.9 24960.3 24972.4 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:32911.03 Median:2107.00 stddev:95788.65 (4546.2%) stddev-sans-first:96026.15 14:21:44 INFO - PROCESS | 1643 | Values: 348.0 366.9 368.5 376.3 395.5 14400.4 14874.3 15580.9 19735.5 20209.5 18386.3 18559.9 20278.5 20389.7 20481.9 5193.2 5500.6 5502.4 5514.1 5519.0 4432.2 5420.9 5980.0 6028.4 6072.8 5979.1 6010.8 6013.7 6013.9 6029.3 5242.6 5325.4 5329.9 5367.2 5380.5 4511.8 5152.8 5182.1 5227.4 5236.1 12394.6 12983.4 13086.8 13092.5 13097.9 2115.7 2212.4 2276.6 2309.4 2857.5 8623.6 9824.1 9855.0 9915.9 10434.7 1787.9 1860.3 1861.6 1887.0 1937.1 92401.5 119846.8 121495.0 125646.0 125906.0 9414.2 11082.9 11348.5 11587.3 11640.0 14329.1 14346.6 14347.9 14364.4 14369.5 7989.1 8076.4 8258.8 8283.3 8381.5 7809.0 8047.3 8194.2 8231.3 8273.8 3837.8 3896.7 4325.5 4410.5 4500.7 1859.7 1904.9 1907.9 1913.6 1913.9 790.4 892.9 893.8 905.9 947.5 16726.7 19667.5 21187.6 21468.7 21943.9 873.3 906.3 911.8 953.9 970.6 10165.9 10981.9 10994.7 11023.7 11034.8 542509.0 570845.0 580044.0 587089.1 587601.0 88933.0 121804.0 123064.0 126311.4 126488.0 970.3 979.6 1008.2 1009.2 1009.3 17962.7 18051.3 18171.6 18229.2 18259.9 41525.5 46866.0 51413.7 51568.5 52739.7 56984.0 61165.4 73018.6 75749.0 76988.0 7719.3 7918.3 7941.4 7984.2 8123.5 10217.8 12154.1 12279.9 12350.8 12355.5 8825.8 10504.6 10796.6 10923.5 10949.7 5450.9 6060.9 10534.8 10563.6 10824.0 10491.4 10545.8 10733.5 11114.2 11182.6 7678.0 7898.4 7938.5 8176.3 8184.3 9616.4 10359.6 10801.8 10847.5 10863.2 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5324.41 Median:5192.77 stddev:2943.77 (56.7%) stddev-sans-first:2936.72 14:21:44 INFO - PROCESS | 1643 | Values: 1330.8 1380.8 1462.2 1635.9 1857.2 7366.2 7746.0 7766.4 7768.3 7770.0 6992.6 7595.0 7952.9 8142.9 8189.2 2270.2 2304.5 2305.8 2308.7 2311.3 1911.0 2105.9 2118.4 2338.8 2343.8 2213.2 2242.5 2245.2 2246.7 2289.3 2247.2 2255.7 2281.7 2283.5 2287.7 2297.8 2313.8 2314.7 2315.8 2325.6 8161.4 8193.5 8254.3 8262.1 8267.4 4986.6 5016.4 5192.6 5192.9 5203.8 3535.7 3624.3 3627.1 3627.3 3627.5 890.8 907.8 923.3 931.4 935.7 10691.5 10855.2 10876.1 10883.0 10885.6 4178.9 4346.0 4431.9 4442.6 4464.9 8644.7 8705.3 8708.3 8711.5 8738.1 5099.3 5105.7 5105.9 5113.4 5114.6 4277.5 4426.4 4442.8 4663.7 4747.6 3102.7 3544.1 3608.2 3662.0 3701.9 966.0 1134.8 1135.8 1149.7 1155.5 759.2 871.6 879.1 881.4 906.7 5286.1 5622.6 5734.4 5874.9 6053.7 786.7 866.7 889.7 892.3 954.4 3381.7 3524.8 3789.4 3920.9 3924.6 9621.0 9825.2 10088.2 10111.2 10113.8 9912.4 10029.6 10099.7 10110.3 10117.1 7664.5 7669.5 7793.8 7892.8 7958.2 4633.8 4918.9 5552.6 5595.4 5643.7 7721.7 9300.6 9362.6 9409.4 9490.3 9404.9 9432.9 9530.7 9568.3 9668.6 5781.8 5885.6 6680.4 6756.7 6819.2 7986.2 8061.1 8064.0 8071.4 8075.5 6990.3 7075.6 7087.2 7181.6 7217.2 6796.1 6993.9 7034.0 7045.3 7170.1 5954.8 6504.6 6595.5 6650.6 6721.6 4708.6 4768.9 4776.3 4798.7 4920.7 4483.9 4645.4 4742.5 4795.7 4892.2 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4189.27 Median:4651.88 stddev:1294.25 (27.8%) stddev-sans-first:1263.94 14:21:44 INFO - PROCESS | 1643 | Values: 266.0 297.6 301.2 304.9 313.6 4303.6 4940.4 4952.6 5113.8 5120.3 4988.7 5029.5 5038.3 5132.4 5138.0 3473.3 3777.6 3963.4 3967.1 3992.5 3752.8 3939.9 3951.4 3953.7 3975.3 3256.0 3277.0 3282.8 3878.4 3887.1 3881.0 3885.9 3906.6 3925.9 3947.6 2771.8 3139.2 3354.6 3397.8 3400.3 4186.8 4503.5 5014.5 5053.7 5070.5 4096.5 4443.7 4445.8 4447.8 4483.8 5080.5 5346.6 5349.8 5369.7 5408.9 3173.0 3621.7 3700.3 3728.8 3737.0 5550.4 5550.5 5562.7 5586.7 5591.9 3289.1 3404.6 3707.7 3712.6 3731.1 3619.7 3658.4 3766.0 3786.4 3820.2 3500.4 3686.6 4097.3 4348.0 4374.1 5349.7 5356.9 5361.5 5364.2 5381.9 1029.0 1074.9 1116.5 1174.4 1221.6 684.4 730.4 806.5 841.8 851.7 3890.6 3901.9 4373.8 4418.4 4525.7 5122.3 5139.6 5143.9 5160.5 5172.3 4241.8 4494.6 4656.3 4676.1 4680.5 2313.6 2496.3 2515.6 2702.9 2715.1 4776.0 4855.6 5148.3 5201.4 5311.3 5199.7 5222.5 5253.4 5262.4 5273.9 4405.4 4647.4 5093.6 5277.2 5294.8 4522.8 4846.8 5094.7 5105.6 5194.7 4313.0 4797.7 5015.9 5031.4 5032.3 4568.9 4799.7 5215.4 5255.5 5336.9 3005.7 3009.5 3481.8 3499.5 3508.8 4570.2 4929.9 5028.2 5081.6 5086.2 4234.3 4329.8 4672.9 4975.8 5093.6 4685.5 5390.9 5404.7 5420.5 5435.5 5095.3 5300.3 5304.3 5306.0 5316.5 4205.3 5097.5 5384.2 5394.4 5407.5 4490.0 4523.7 4945.0 5264.0 5361.4 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20932.60 Median:4024.82 stddev:31393.73 (780.0%) stddev-sans-first:31444.96 14:21:44 INFO - PROCESS | 1643 | Values: 676.7 699.4 729.4 759.3 788.2 13459.5 15803.3 16389.3 16619.0 16688.5 12304.5 15307.7 15539.7 15625.8 15718.1 809.1 827.4 830.5 831.7 832.0 647.2 675.0 677.0 831.2 836.6 740.5 840.8 873.0 883.5 884.3 869.0 869.0 870.4 871.1 872.0 498.7 513.7 643.7 643.7 644.1 11951.1 12291.9 12297.4 12313.9 13883.6 12278.8 12885.7 12892.4 12987.9 13145.0 10895.5 11121.0 11217.9 11401.3 11430.3 3051.7 3594.7 3627.3 3631.8 3646.3 87935.7 88397.6 90303.0 91989.0 92908.0 10344.8 10396.9 10416.4 10615.3 10748.5 19334.7 19976.6 20024.9 20117.2 20141.9 7003.0 7441.1 7519.7 7580.2 7592.2 4123.3 4328.7 4361.4 4404.6 4449.3 3356.9 3472.0 3479.2 3481.9 3487.2 594.6 598.5 626.2 627.9 631.0 541.5 565.2 639.7 665.2 679.0 7737.5 8585.0 8675.9 8995.2 9166.4 603.9 619.9 627.9 654.4 660.5 3926.3 4394.3 4461.6 4466.7 4505.7 114249.0 115787.4 116081.0 116340.4 120090.0 103422.0 103666.8 104940.0 105988.6 107720.5 84010.9 87749.6 90125.1 91830.0 93604.5 8414.2 9025.4 9395.9 9564.6 9580.3 45937.5 51309.5 51383.5 51593.7 52651.7 68417.7 68968.7 69368.7 69875.3 72815.3 11884.6 11927.2 11971.5 12063.0 12318.8 13758.9 13997.0 14248.3 14501.9 14784.9 12801.6 13173.9 13638.2 13660.0 13806.7 12624.7 12722.9 12912.9 13106.9 13160.3 12557.7 12736.9 12990.7 13371.5 13387.9 10046.3 10348.2 10416.6 10471.2 10783.6 10104.9 10548.3 10556.8 10776.2 10848.7 14:21:44 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:21:44 INFO - PROCESS | 1643 | 14:21:44 INFO - TEST-INFO | 1643: exit 0 14:21:44 INFO - TEST-OK | dromaeo_css | took 1119699ms 14:21:44 INFO - TEST-START | kraken 14:21:44 INFO - operating with platform_type : mac_ 14:21:44 INFO - Initialising browser for kraken test... 14:21:44 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmp6Vx_mv/profile http://localhost:49246/getInfo.html) 14:21:47 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 14:21:47 INFO - PROCESS | 1653 | colorDepth:24 14:21:47 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 14:21:47 INFO - PROCESS | 1653 | __metrics 14:21:47 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:21:47 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:48 INFO - TEST-INFO | 1653: exit 0 14:21:48 INFO - Browser initialized. 14:21:48 INFO - Running cycle 1/1 for kraken test... 14:21:48 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmp6Vx_mv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:00 INFO - PROCESS | 1654 | RSS: Main: 243695616 14:22:00 INFO - PROCESS | 1654 | 14:22:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:04 INFO - PROCESS | 1654 | RSS: Main: 295399424 14:22:04 INFO - PROCESS | 1654 | 14:22:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 14:22:07 INFO - PROCESS | 1654 | RSS: Main: 297185280 14:22:07 INFO - PROCESS | 1654 | 14:22:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 14:22:11 INFO - PROCESS | 1654 | RSS: Main: 387219456 14:22:11 INFO - PROCESS | 1654 | 14:22:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 14:22:13 INFO - PROCESS | 1654 | RSS: Main: 287875072 14:22:13 INFO - PROCESS | 1654 | 14:22:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:16 INFO - PROCESS | 1654 | RSS: Main: 292478976 14:22:16 INFO - PROCESS | 1654 | 14:22:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:19 INFO - PROCESS | 1654 | RSS: Main: 337985536 14:22:19 INFO - PROCESS | 1654 | 14:22:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:23 INFO - PROCESS | 1654 | RSS: Main: 336838656 14:22:23 INFO - PROCESS | 1654 | 14:22:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 14:22:27 INFO - PROCESS | 1654 | RSS: Main: 335409152 14:22:27 INFO - PROCESS | 1654 | 14:22:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:29 INFO - PROCESS | 1654 | RSS: Main: 308899840 14:22:29 INFO - PROCESS | 1654 | 14:22:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:32 INFO - PROCESS | 1654 | RSS: Main: 312705024 14:22:32 INFO - PROCESS | 1654 | 14:22:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:34 INFO - PROCESS | 1654 | RSS: Main: 314953728 14:22:34 INFO - PROCESS | 1654 | 14:22:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:38 INFO - PROCESS | 1654 | RSS: Main: 329547776 14:22:38 INFO - PROCESS | 1654 | 14:22:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:42 INFO - PROCESS | 1654 | RSS: Main: 323416064 14:22:42 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 14:22:44 INFO - PROCESS | 1654 | RSS: Main: 366665728 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | __start_tp_report 14:22:44 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:22:44 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:22:44 INFO - PROCESS | 1654 | |i|pagename|runs| 14:22:44 INFO - PROCESS | 1654 | |0;ai-astar;114;115;115;114;114;124;169;151;114;114 14:22:44 INFO - PROCESS | 1654 | |1;audio-beat-detection;152;112;113;150;112;114;111;112;142;114 14:22:44 INFO - PROCESS | 1654 | |2;audio-dft;185;184;183;187;183;184;185;179;181;183 14:22:44 INFO - PROCESS | 1654 | |3;audio-fft;79;58;59;87;62;59;58;58;83;61 14:22:44 INFO - PROCESS | 1654 | |4;audio-oscillator;83;71;90;69;69;69;90;68;69;92 14:22:44 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;87;90;87;91;86;90;87;90;86 14:22:44 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;93;95;121;146;94;93;94;94;94 14:22:44 INFO - PROCESS | 1654 | |7;imaging-desaturate;94;132;87;85;85;87;86;100;131;75 14:22:44 INFO - PROCESS | 1654 | |8;json-parse-financial;55;55;55;54;54;55;56;56;54;54 14:22:44 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;68;79;76;74;70;74;100;102;92 14:22:44 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;88;88;88;86;89;88;89;100;104;85 14:22:44 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;147;152;153;152;147;147;149;150;217;183 14:22:44 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;214;172;174;173;172;174;173;173;174;173 14:22:44 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;67;67;67;70;80 14:22:44 INFO - PROCESS | 1654 | __end_tp_report 14:22:44 INFO - PROCESS | 1654 | __start_cc_report 14:22:44 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1996 14:22:44 INFO - PROCESS | 1654 | __end_cc_report 14:22:44 INFO - PROCESS | 1654 | __startTimestamp1479507764292__endTimestamp 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:22:44 INFO - PROCESS | 1654 | Number of tests: 14 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:124.40 Median:115.00 stddev:19.48 (16.9%) stddev-sans-first:20.29 14:22:44 INFO - PROCESS | 1654 | Values: 114.0 115.0 115.0 114.0 114.0 124.0 169.0 151.0 114.0 114.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:114.00 stddev:17.32 (15.2%) stddev-sans-first:14.91 14:22:44 INFO - PROCESS | 1654 | Values: 152.0 112.0 113.0 150.0 112.0 114.0 111.0 112.0 142.0 114.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.22 (1.2%) stddev-sans-first:2.28 14:22:44 INFO - PROCESS | 1654 | Values: 185.0 184.0 183.0 187.0 183.0 184.0 185.0 179.0 181.0 183.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:11.68 (19.0%) stddev-sans-first:11.47 14:22:44 INFO - PROCESS | 1654 | Values: 79.0 58.0 59.0 87.0 62.0 59.0 58.0 58.0 83.0 61.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:10.39 (13.5%) stddev-sans-first:10.79 14:22:44 INFO - PROCESS | 1654 | Values: 83.0 71.0 90.0 69.0 69.0 69.0 90.0 68.0 69.0 92.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.87 (2.1%) stddev-sans-first:1.99 14:22:44 INFO - PROCESS | 1654 | Values: 88.0 87.0 90.0 87.0 91.0 86.0 90.0 87.0 90.0 86.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:94.00 stddev:17.78 (18.9%) stddev-sans-first:18.57 14:22:44 INFO - PROCESS | 1654 | Values: 93.0 93.0 95.0 121.0 146.0 94.0 93.0 94.0 94.0 94.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:85.50 stddev:19.68 (23.0%) stddev-sans-first:20.86 14:22:44 INFO - PROCESS | 1654 | Values: 94.0 132.0 87.0 85.0 85.0 87.0 86.0 100.0 131.0 75.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 14:22:44 INFO - PROCESS | 1654 | Values: 55.0 55.0 55.0 54.0 54.0 55.0 56.0 56.0 54.0 54.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:74.00 stddev:13.15 (17.8%) stddev-sans-first:12.92 14:22:44 INFO - PROCESS | 1654 | Values: 66.0 68.0 79.0 76.0 74.0 70.0 74.0 100.0 102.0 92.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:6.26 (7.1%) stddev-sans-first:6.57 14:22:44 INFO - PROCESS | 1654 | Values: 88.0 88.0 88.0 86.0 89.0 88.0 89.0 100.0 104.0 85.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:152.00 stddev:22.81 (15.0%) stddev-sans-first:23.72 14:22:44 INFO - PROCESS | 1654 | Values: 147.0 152.0 153.0 152.0 147.0 147.0 149.0 150.0 217.0 183.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:173.50 stddev:12.95 (7.5%) stddev-sans-first:0.78 14:22:44 INFO - PROCESS | 1654 | Values: 214.0 172.0 174.0 173.0 172.0 174.0 173.0 173.0 174.0 173.0 14:22:44 INFO - PROCESS | 1654 | 14:22:44 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:3.97 (5.8%) stddev-sans-first:4.20 14:22:44 INFO - PROCESS | 1654 | Values: 68.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 70.0 80.0 14:22:44 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:22:44 INFO - PROCESS | 1654 | 14:22:45 INFO - TEST-INFO | 1654: exit 0 14:22:45 INFO - TEST-OK | kraken | took 60963ms 14:22:45 INFO - SUITE-END | took 1180s 14:22:45 INFO - Completed test suite (00:19:41) 14:22:45 INFO - javascript benchmark 14:22:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.8351582420883, 3317.1375442384974, 3326.218338690408, 3343.465045592706, 3377.7466689998255, 4460.598546130847, 5131.743412829358, 5483.862903427416, 5576.832695019146, 5619.859503512414, 4859.173940430126, 5412.2152287918225, 5584.078627026536, 5698.202251684757, 5709.4290570942985, 5048.293238946532, 5059.342285502879, 5067.0, 5094.388673359202, 5120.436751957282, 5094.923576146361, 5230.607704422165, 5233.947660523384, 5240.711760853152, 5243.187305967562, 5064.037832811754, 5092.949070509321, 5179.870503237412, 5251.448597897223, 5259.789608415697, 5136.383633963911, 5139.948600513984, 5144.871378215537, 5150.407703114152, 5154.896902061975, 5053.797848086072, 5100.515451032146, 5108.080545501808, 5125.564327032207, 5129.1024070787835, 4672.299155126724, 5527.309086364205, 5604.243427137325, 5630.239917611111, 5637.71811409432, 6070.9679354509835, 6075.33171351151, 6082.787102451393, 6118.571699981003, 6139.938600613981, 6133.539984501135, 6156.907646385308, 6169.0, 6171.59884607499, 6172.691365431755, 5594.13290939905, 5644.8024319148635, 5645.435456454404, 5657.660540367591, 5689.857753556153, 6113.385090541919, 6126.9561142435105, 6130.417610327012, 6132.397922269778, 6141.915626108677, 6044.818655440344, 6054.39456054391, 6055.424734650202, 6060.969695151584, 6117.0, 6029.728662210211, 6091.695415229221, 6129.0, 6145.96927015371, 6147.047207682816, 4945.925811112764, 6038.667873266924, 6039.4262545058145, 6057.939420605738, 6136.8953588354525, 5968.820935371859, 6095.35998720128, 6112.572119951649, 6118.265808103056, 6123.846903827351, 4877.6829506081995, 4886.804527818847, 4890.779914903838, 4893.755312234445, 4901.142300097468, 4326.567343265711, 4352.630026447788, 4379.080393117481, 4408.162449134654, 4434.645228381722, 4548.931766023512, 4743.335932969387, 5273.1035723927025, 5388.625900395374, 5667.829965100971, 6053.576249662569, 6183.598066125687, 6204.937950620526, 6224.035274532454, 6231.626102433868, 5468.72656367188, 5482.5888058394985, 5503.449655034545, 5619.8595035124445, 5629.493345598916, 5257.342832145981, 5283.630145889828, 5287.841364759063, 5309.097453432925, 5354.651947623392, 6264.21697287839, 6298.244210694746, 6320.0, 6342.809715708536, 6384.0, 6047.727852246748, 6182.258129024546, 6202.162708034358, 6209.565330427007, 6211.161493198541, 6172.197614310111, 6248.0940263660605, 6281.96859015702, 6297.874042519215, 6308.243010838729, 6104.85328883332, 6114.966544785144, 6131.743695906945, 6134.467201660849, 6135.324535308442, 6126.969365153146, 6130.570860039933, 6157.753689852356, 6174.753009879554, 6190.442860142609, 5804.970975145097, 5870.5010074142465, 5870.765169393348, 5943.524518038633, 6018.7291571878495, 5931.881362372815, 5966.463018328372, 5982.222311099529, 6058.454739073504, 6100.450959413674, 5891.23413956183, 5907.822765317047, 5909.2908850938165, 5915.142304365757, 5915.526757859275, 6006.519478441802, 6028.728707208274, 6084.330723620486, 6099.146119543356, 6099.420555047263, 5685.374608793112, 5737.770489180386, 5768.826935191951, 5811.680357580373, 5846.795362162304], "value": 5576.793571006913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.8359049718344, 509.93370861787963, 512.4542362384063, 527.3355571979306, 527.42247239273, 29955.65199566019, 38814.41778373323, 39700.40449393261, 39789.40315895264, 39790.0, 40562.98592535188, 41089.79455102728, 41475.96310092249, 41541.792291038575, 41579.79210103945, 9205.58574864131, 9434.528273586327, 9439.575219115122, 9441.24470042395, 9447.196988256006, 7916.683332666716, 9334.906650933472, 9340.15938565529, 9342.579583918707, 9343.813123737522, 9281.35030547862, 9352.579133938954, 9360.765980850465, 9362.578683959204, 9364.391314564566, 9288.256939444862, 9339.486328251944, 9348.626054957827, 9350.67272645454, 9360.71917842459, 9144.40561363516, 9195.862062069074, 9225.492597907112, 9228.077192280785, 9249.953750231272, 38642.8407147786, 38917.41623875616, 38943.61056389428, 38960.83117506479, 38985.41521877174, 3290.2925870937866, 3312.188513814131, 3385.9661403386144, 3518.8416521256604, 3656.8902932912056, 23334.416639583975, 29431.558526622117, 29490.557641635394, 30170.84914575435, 30480.237994050105, 3121.32891428344, 3159.699828516287, 3161.1148878314107, 3194.361127774431, 3283.83580820958, 445454.0, 468331.6583417095, 469077.65461172815, 470303.0, 470445.0, 57634.55913602193, 57831.0, 57858.0, 57895.71052144797, 58063.0, 33893.0, 34615.307693845985, 34684.13289667728, 56666.583335416944, 56874.7156264216, 15237.0, 15684.843151568339, 15709.607259818367, 15753.606159845865, 15758.527244182693, 11894.405279735978, 12015.699607509707, 12027.458764355624, 12029.518819247132, 12050.39748012596, 18754.812451875307, 18756.81243187578, 18762.0, 18771.530711732317, 18797.718034229496, 6828.897566536506, 7536.924630753732, 7642.235776422313, 7676.961615192, 7703.807404814813, 851.6933903794629, 920.8158368326227, 989.5299732626945, 1042.1298215989582, 1051.5373235776235, 27778.02776902839, 28739.856300718362, 29151.979680711072, 29409.85295073511, 29562.817487300697, 1019.99490002551, 1044.12815299226, 1072.9195310351754, 1095.4358505369742, 1115.4645770030268, 14482.058666186664, 14925.104493730194, 14956.0, 15373.692526149414, 15801.683966320608, 634179.0, 640386.0, 641913.0, 643123.0, 645394.0, 55807.720961395746, 56103.0, 56235.71882140563, 56236.71881640647, 56348.71825640846, 1300.2978391668582, 1340.162398500937, 1358.0900796466194, 1362.128237927727, 1362.1338765890794, 24605.87697061503, 25447.982080717306, 28915.7108428913, 29153.708462915947, 29672.851635741685, 49646.0, 49842.504724858314, 49906.75046624744, 49929.75175620639, 49942.75028624834, 568347.0, 571059.1447042738, 571154.0, 571660.0, 572464.0, 21446.356609301747, 25468.853901574104, 25845.353866153495, 26195.869020655537, 26218.344541386617, 44660.0, 45752.313715294964, 45802.0, 45970.31044534268, 46389.84025399392, 33426.0, 34851.9544413668, 35922.0, 36481.63518364782, 37403.625963741106, 36745.63254367422, 36801.0, 37876.62123378841, 38027.61972380241, 38311.80844095762, 31898.362032758752, 36299.81850090838, 36389.0, 36611.01049445548, 37497.81251093836, 31084.68915310818, 31643.20891977627, 32930.0, 33228.66771332256, 33339.333213335114, 24434.389140270923, 24456.877715611306, 24779.87610061938, 24960.251192464257, 24972.37569060788], "value": 19186.79727301633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.96520347965225, 366.90277076574705, 368.5080417642447, 376.25689263704186, 395.4838935189578, 14400.351984160712, 14874.330655120519, 15580.922095389522, 19735.5066123347, 20209.494762630904, 18386.264549418007, 18559.90720046401, 20278.49303767403, 20389.694154587694, 20481.897590512064, 5193.195054766517, 5500.6424582402215, 5502.449755024506, 5514.09017512112, 5519.0, 4432.180046691356, 5420.945790542103, 5979.970100149493, 6028.397160283958, 6072.817815465543, 5979.133025711291, 6010.75956961721, 6013.729382177812, 6013.879722405549, 6029.336772954972, 5242.606804489678, 5325.387580428262, 5329.866753331159, 5367.1680889462195, 5380.542653874425, 4511.819527218908, 5152.768125434327, 5182.093133701587, 5227.398849132361, 5236.057509648262, 12394.62816115518, 12983.35083245834, 13086.803697944539, 13092.541761038414, 13097.934510327483, 2115.6509175985943, 2212.3805334506364, 2276.6357382818837, 2309.445733024079, 2857.528507796211, 8623.56882155896, 9824.06671366219, 9854.950725246399, 9915.851262231072, 10434.739131521697, 1787.901665408402, 1860.3209828412666, 1861.64628720544, 1886.9528261793428, 1937.053202082705, 92401.5379923096, 119846.80153198444, 121495.0, 125646.0, 125906.0, 9414.19979301767, 11082.944585277184, 11348.54605815758, 11587.304761714324, 11640.010599099001, 14329.068610540282, 14346.641333966734, 14347.85652143486, 14364.425422982964, 14369.497067602584, 7989.121196668362, 8076.434649574473, 8258.793530161794, 8283.337333013344, 8381.49711017341, 7809.0, 8047.275745182962, 8194.22154895284, 8231.300339471212, 8273.751787446387, 3837.7505462144873, 3896.7272290939927, 4325.4593175853015, 4410.514843367227, 4500.662450316239, 1859.6559636467298, 1904.8952307622937, 1907.9427617171507, 1913.6172765446966, 1913.8564607654482, 790.3884010254183, 892.8883889513811, 893.78102364921, 905.8912930448388, 947.545178314413, 16726.74909876353, 19667.508312292022, 21187.576248474943, 21468.677969830464, 21943.890280548814, 873.2882700598991, 906.3383729877227, 911.7994041310901, 953.9284553658504, 970.5583959298502, 10165.898341016495, 10981.890181098086, 10994.670159895217, 11023.669289921316, 11034.779304414027, 542509.0, 570845.0, 580044.0, 587089.1291087035, 587601.0, 88932.9999999987, 121804.0, 123064.0, 126311.36844315719, 126488.0, 970.2819913264275, 979.6130528441225, 1008.1531513528671, 1009.2228983682523, 1009.2783659683362, 17962.730559041887, 18051.277948881896, 18171.636567268844, 18229.179686914387, 18259.9044057357, 41525.54660586865, 46866.0, 51413.7429312866, 51568.48431515787, 52739.73630131825, 56984.0, 61165.38834611597, 73018.63490682513, 75749.0, 76988.0, 7719.343855772097, 7918.287354137925, 7941.404394670307, 7984.201579842202, 8123.512589244664, 10217.795644087226, 12154.088443366605, 12279.868633498401, 12350.81473777876, 12355.505779768708, 8825.823483530421, 10504.632337868137, 10796.56813727442, 10923.453827308762, 10949.671509854717, 5450.863728406663, 6060.878737433589, 10534.789304214026, 10563.63027294041, 10824.0, 10491.422971736627, 10545.789084218426, 10733.463326833471, 11114.222004459934, 11182.552697891993, 7678.0, 7898.407619428681, 7938.5236885784725, 8176.305014073871, 8184.304334131427, 9616.423014619146, 10359.63741269052, 10801.837972430578, 10847.457627118454, 10863.185261105291], "value": 8953.65437048378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.780421230497, 1380.779075347944, 1462.217713523265, 1635.9345626174954, 1857.2106854586789, 7366.152892417367, 7745.961270193641, 7766.378689704817, 7768.300852923236, 7770.0287464067, 6992.6154061526595, 7594.974678418412, 7952.880706789403, 8142.91857081429, 8189.1810818918075, 2270.19408110121, 2304.5045315257216, 2305.8040066594276, 2308.676785250066, 2311.2719493359623, 1910.9713354299697, 2105.9262925797602, 2118.3539020598787, 2338.777816107467, 2343.7773411525877, 2213.214308920334, 2242.4505996030994, 2245.158065725353, 2246.6742322363248, 2289.290320000805, 2247.168547637368, 2255.6503741919946, 2281.7376001759844, 2283.497630521291, 2287.7025986621634, 2297.8046866016407, 2313.838031337807, 2314.67594536765, 2315.814734821227, 2325.5930212212793, 8161.428699991003, 8193.50838949659, 8254.298384637314, 8262.132476089984, 8267.421280510367, 4986.62600304975, 5016.372953380827, 5192.58459323257, 5192.948070519322, 5203.791848326063, 3535.717142628609, 3624.3294990426593, 3627.0569651890432, 3627.3289441453417, 3627.4921510988484, 890.7505898348472, 907.7912080221586, 923.289067418091, 931.3620170183447, 935.7379933618598, 10691.465426728633, 10855.24013319068, 10876.075533579655, 10883.020528152425, 10885.619003334925, 4178.874633760992, 4346.0, 4431.8670439886855, 4442.577955094261, 4464.933026004613, 8644.740657780276, 8705.347098967603, 8708.259797917248, 8711.47731136134, 8738.082501337269, 5099.3370861787735, 5105.668131571436, 5105.8723531912, 5113.360829896263, 5114.590832733446, 4277.465316835395, 4426.402435671143, 4442.844500442469, 4663.696859704109, 4747.596454301354, 3102.705243001911, 3544.096255454894, 3608.2422691235133, 3661.9633803662155, 3701.9444708329397, 965.9903400966041, 1134.7843909657304, 1135.8353038809491, 1149.689583812366, 1155.5493357590547, 759.1649185895582, 871.5685735560938, 879.1296616349767, 881.3566096749408, 906.7325139083986, 5286.127788914786, 5622.57830662702, 5734.397888221677, 5874.882502350015, 6053.727582258721, 786.7482405630143, 866.7096522664851, 889.6886089868624, 892.2727976698969, 954.374884450686, 3381.6980462522106, 3524.753267271318, 3789.412641040643, 3920.9215815684097, 3924.6271604197555, 9621.0, 9825.164860986753, 10088.243381746399, 10111.191104711605, 10113.797724045478, 9912.405255684682, 10029.598816047277, 10099.69700908974, 10110.342827716322, 10117.089461948313, 7664.540127592362, 7669.463137580427, 7793.766187014286, 7892.763217103496, 7958.2041795821115, 4633.791479383503, 4918.8989801309635, 5552.639078459887, 5595.384507704231, 5643.746031428514, 7721.652525636247, 9300.581473833558, 9362.578683959102, 9409.388389754644, 9490.28822838276, 9404.858927115962, 9432.905670943477, 9530.714078577654, 9568.330216884751, 9668.613255469983, 5781.797637082682, 5885.55858310637, 6680.432163265982, 6756.6959486822225, 6819.2498825128205, 7986.241307075818, 8061.072976607765, 8064.0, 8071.354291656536, 8075.515469071875, 6990.335918087773, 7075.575465472089, 7087.184973727881, 7181.640917954186, 7217.170025446931, 6796.082528858738, 6993.918764245048, 7034.0, 7045.295470452914, 7170.139583250043, 5954.821355359346, 6504.6015106752275, 6595.472362210916, 6650.600963942179, 6721.596704197764, 4708.576228139484, 4768.880777980578, 4776.331313616166, 4798.688085274446, 4920.6801557898625, 4483.910321793611, 4645.397337918413, 4742.454617718869, 4795.712257264575, 4892.168331383602], "value": 4291.564129448077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.9932156786563, 297.57744003515006, 301.2168362258129, 304.89176342398457, 313.64244760972497, 4303.591158839905, 4940.407151141863, 4952.628552858532, 5113.846584602463, 5120.308758317626, 4988.700677959325, 5029.5221953914415, 5038.345015148026, 5132.409772876111, 5137.974310128454, 3473.2879759649336, 3777.5844657087837, 3963.365861462167, 3967.1470633813797, 3992.5208974922903, 3752.8311225994894, 3939.9409008864745, 3951.404222157837, 3953.7430067045693, 3975.264576053425, 3255.9837200813963, 3276.9672303276902, 3282.83585820708, 3878.3600705883496, 3887.1448281378052, 3880.9611903881023, 3885.922281554353, 3906.570277269498, 3925.862594809168, 3947.624975627311, 2771.764400026, 3139.152428844222, 3354.5639066921144, 3397.7937832069506, 3400.25194457219, 4186.769727664977, 4503.504614492404, 5014.548690617826, 5053.74731263439, 5070.467600901926, 4096.467459230281, 4443.7111587746695, 4445.844395446176, 4447.776861363119, 4483.843065492725, 5080.466551012128, 5346.572274218053, 5349.759260833272, 5369.697635953899, 5408.864778380533, 3172.98413507931, 3621.7102631789658, 3700.259948010382, 3728.7762734236035, 3737.0, 5550.4449555044575, 5550.5282051026115, 5562.663681253883, 5586.748596313217, 5591.944080559183, 3289.0954987378664, 3404.642512536148, 3707.740458167956, 3712.5916149223563, 3731.1045349116016, 3619.674229319374, 3658.396364599811, 3765.981170094132, 3786.390783916824, 3820.1595648957186, 3500.4224302989724, 3686.594474607791, 4097.262492751333, 4347.9565204347555, 4374.119128774658, 5349.652272602269, 5356.91964620531, 5361.517463428232, 5364.22218778275, 5381.946180538144, 1028.953697083633, 1074.9032587067045, 1116.525476672411, 1174.3599738142732, 1221.5785553983862, 684.4319215051495, 730.441212472459, 806.4636866768815, 841.7937605286621, 851.6976473351871, 3890.630390112935, 3901.882943511699, 4373.846915357947, 4418.365204874153, 4525.705829121097, 5122.334096567422, 5139.6145289102715, 5143.897122057538, 5160.458151894072, 5172.301739265226, 4241.830326786894, 4494.606671931646, 4656.348111264426, 4676.134915040729, 4680.5085466025575, 2313.6298192289155, 2496.3274606014015, 2515.584928486816, 2702.932426689309, 2715.1447294102295, 4775.976120119377, 4855.6115510759055, 5148.33071700684, 5201.375834899761, 5311.3095297611835, 5199.688018718889, 5222.490272762272, 5253.3958594761325, 5262.368515778131, 5273.947260527422, 4405.427294451701, 4647.420681521788, 5093.567046800989, 5277.182036784305, 5294.788208471695, 4522.819087236474, 4846.80612775485, 5094.694318340911, 5105.617078719037, 5194.7272918135295, 4313.0, 4797.712137271775, 5015.874603134951, 5031.371078615173, 5032.3206367139965, 4568.857785553611, 4799.728072060837, 5215.4002289735645, 5255.500727430888, 5336.946630533645, 3005.729484346419, 3009.5102924052735, 3481.8433170506883, 3499.4575840744724, 3508.8070156140634, 4570.154521413549, 4929.901401971869, 5028.245763135559, 5081.577158395655, 5086.160783470686, 4234.273839021641, 4329.8051587678, 4672.901868060935, 4975.800967961241, 5093.643444958817, 4685.461171965131, 5390.897549955599, 5404.675719456845, 5420.4850539198715, 5435.466946484817, 5095.312132862016, 5300.349825087456, 5304.28392167068, 5305.973470132624, 5316.494932981361, 4205.3271476563605, 5097.490250975021, 5384.165454354581, 5394.433584473573, 5407.486288802557, 4490.012197316585, 4523.7285762854335, 4944.983560028308, 5263.999520273407, 5361.410244873139], "value": 3772.504650827198, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7022510095559, 699.4334588982924, 729.3654520567104, 759.312821896184, 788.2314743125457, 13459.528916487925, 15803.288852001673, 16389.344426222935, 16619.0, 16688.499345019638, 12304.507819687224, 15307.693846123071, 15539.68920621587, 15625.765613515807, 15718.135502547355, 809.0695699945081, 827.4001349021971, 830.5390508267909, 831.6590198018813, 831.9833603327929, 647.1522305779444, 674.9763758268462, 677.0250838792124, 831.2269589281965, 836.6318819719304, 740.4779630360583, 840.8192238668685, 872.995635021824, 883.4610887358706, 884.2881480408269, 869.0, 869.0483920107472, 870.447265986097, 871.063606622883, 871.9520426376547, 498.6563153180068, 513.7225898015067, 643.707113263464, 643.7457204404234, 644.1207751419279, 11951.103667224907, 12291.877081229162, 12297.446614902261, 12313.876861231363, 13883.58349249514, 12278.815817762741, 12885.742285154338, 12892.419841107172, 12987.87012129876, 13145.0, 10895.455227238606, 11121.0, 11217.887821121847, 11401.258918170292, 11430.25703329281, 3051.67957364478, 3594.6944509716445, 3627.2564124354444, 3631.8365673544754, 3646.2707458508403, 87935.68096478558, 88397.55801220953, 90303.0, 91988.99999999933, 92908.0, 10344.844827327595, 10396.896031039592, 10416.427096509764, 10615.25693201484, 10748.467230705959, 19334.709979350322, 19976.60046799056, 20024.898630575168, 20117.19531218764, 20141.899290503454, 7003.0, 7441.1070671519765, 7519.699212031567, 7580.1661817200065, 7592.202818704067, 4123.340265557496, 4328.675349348749, 4361.433013708198, 4404.647628189737, 4449.3326001100095, 3356.9496457553155, 3471.965280347164, 3479.2171761353998, 3481.912952176165, 3487.1805125795418, 594.6135012242078, 598.4853026397295, 626.1797045869924, 627.8744251149789, 631.0376675569701, 541.5288698832042, 565.2115299157653, 639.6961443314482, 665.1785045468939, 679.0123456790163, 7737.49706269102, 8584.957075214585, 8675.913240867636, 8995.23540499065, 9166.358354915092, 603.8822429626268, 619.9101130336076, 627.8869803435334, 654.3848782144769, 660.4914216053612, 3926.293267211929, 4394.252976993918, 4461.57615026572, 4466.731996080245, 4505.7296562206375, 114249.0, 115787.42106289415, 116081.0, 116340.41829790967, 120090.0, 103422.0, 103666.77999320065, 104940.0, 105988.63164841055, 107720.4613976925, 84010.8997275073, 87749.56125219334, 90125.09874901298, 91830.0, 93604.53197734104, 8414.200650938152, 9025.427753090338, 9395.85906211421, 9564.617415303588, 9580.281478888972, 45937.540624593326, 51309.477151744504, 51383.48616513787, 51593.74203128961, 52651.68370790761, 68417.65791171012, 68968.6551567239, 69368.6531567339, 69875.30124698688, 72815.27184728085, 11884.584039558575, 11927.224730392496, 11971.521139154336, 12063.0, 12318.75362492763, 13758.93120534391, 13997.0, 14248.287585620885, 14501.854981450051, 14784.926075369554, 12801.61595152147, 13173.934130329288, 13638.181709097486, 13660.0, 13806.65483362924, 12624.684382890502, 12722.936385318384, 12912.870871291167, 13106.868931310564, 13160.276184809927, 12557.686057848627, 12736.87263127394, 12990.740185196431, 13371.531996380469, 13387.866121339051, 10046.296759226783, 10348.22388320894, 10416.583336666448, 10471.21465890046, 10783.6225732099, 10104.94947525287, 10548.261621686715, 10556.788864222826, 10776.245662803529, 10848.67453976382], "value": 7225.899376378689, "unit": "score"}], "name": "dromaeo_css", "value": 6943.777657160451, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 124.0, 169.0, 151.0, 114.0, 114.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 112.0, 113.0, 150.0, 112.0, 114.0, 111.0, 112.0, 142.0, 114.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 183.0, 187.0, 183.0, 184.0, 185.0, 179.0, 181.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 62.0, 59.0, 58.0, 58.0, 83.0, 61.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 90.0, 69.0, 69.0, 69.0, 90.0, 68.0, 69.0, 92.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 87.0, 91.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 121.0, 146.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 132.0, 87.0, 85.0, 85.0, 87.0, 86.0, 100.0, 131.0, 75.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 56.0, 56.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 79.0, 76.0, 74.0, 70.0, 74.0, 100.0, 102.0, 92.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 86.0, 89.0, 88.0, 89.0, 100.0, 104.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 153.0, 152.0, 147.0, 147.0, 149.0, 150.0, 217.0, 183.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 172.0, 174.0, 173.0, 172.0, 174.0, 173.0, 173.0, 174.0, 173.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 70.0, 80.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1491.8000000000002, "alertThreshold": 2.0}]} 14:22:46 INFO - Return code: 0 14:22:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:22:46 INFO - # TBPL SUCCESS # 14:22:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:46 INFO - 2016-11-18 14:22:46.113 screenresolution[1658:9710] starting screenresolution argv=screenresolution get 14:22:46 INFO - 2016-11-18 14:22:46.115 screenresolution[1658:9710] Display 0: 1600x1200x32@60 14:22:46 INFO - 2016-11-18 14:22:46.121 screenresolution[1659:9713] starting screenresolution argv=screenresolution list 14:22:46 INFO - Available Modes on Display 0 14:22:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:46 INFO - Intel Iris: 14:22:46 INFO - Chipset Model: Intel Iris 14:22:46 INFO - Type: GPU 14:22:46 INFO - Bus: Built-In 14:22:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:46 INFO - Vendor: Intel (0x8086) 14:22:46 INFO - Device ID: 0x0a2e 14:22:46 INFO - Revision ID: 0x0009 14:22:46 INFO - Displays: 14:22:46 INFO - Display: 14:22:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:46 INFO - Display Serial Number: 1600x1200 60 14:22:46 INFO - Main Display: Yes 14:22:46 INFO - Mirror: Off 14:22:46 INFO - Online: Yes 14:22:46 INFO - Rotation: Supported 14:22:46 INFO - Return code: 0 14:22:46 INFO - Running post-action listener: _resource_record_post_action 14:22:46 INFO - [mozharness: 2016-11-18 22:22:46.357157Z] Finished run-tests step (success) 14:22:46 INFO - Running post-run listener: _resource_record_post_run 14:22:46 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37512192; Write bytes: 694288384; Read time: 237; Write time: 2002 14:22:46 INFO - TinderboxPrint: CPU usage
53.6% 14:22:46 INFO - TinderboxPrint: I/O read bytes / time
37,512,192 / 237 14:22:46 INFO - TinderboxPrint: I/O write bytes / time
694,288,384 / 2,002 14:22:46 INFO - TinderboxPrint: CPU idle
2,254.2 (46.4%) 14:22:46 INFO - TinderboxPrint: CPU system
973.4 (20.0%) 14:22:46 INFO - TinderboxPrint: CPU user
1,630.1 (33.6%) 14:22:46 INFO - TinderboxPrint: Swap in / out
420,945,920 / 0 14:22:46 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384494080; Write bytes: 386759680; Read time: 28754; Write time: 854 14:22:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34468864; Write bytes: 306189312; Read time: 215; Write time: 1140 14:22:46 INFO - Running post-run listener: _upload_blobber_files 14:22:46 INFO - Blob upload gear active. 14:22:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:22:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:22:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:47 INFO - (blobuploader) - INFO - Done attempting. 14:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:49 INFO - (blobuploader) - INFO - Done attempting. 14:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:51 INFO - (blobuploader) - INFO - Done attempting. 14:22:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:51 INFO - Return code: 0 14:22:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b89bd08e2477877434b7890b440ca8999d5b296cc796bfafac864bdebf6d607e5e570b3dbd50f00e96042e8cc6e8500acf2f5fd6b92ff716e94f8caab6329423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/aeab3921c00b0eb0765969ac49c570f1bc5a1482b2b01077f89d83f49ac571be592d0bb81f080a83ad42079e31d0c29612b03097de73cdb1daff705c8e623fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe8b45ce025d581e09f75d0b7b41b27a734ecbf6f171bcf9da4553ebb694d0db4377fb0bd27a50bcab72be10cf83147cc94f239b779132be802d1c5ada965c19"} 14:22:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:51 INFO - Contents: 14:22:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b89bd08e2477877434b7890b440ca8999d5b296cc796bfafac864bdebf6d607e5e570b3dbd50f00e96042e8cc6e8500acf2f5fd6b92ff716e94f8caab6329423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/aeab3921c00b0eb0765969ac49c570f1bc5a1482b2b01077f89d83f49ac571be592d0bb81f080a83ad42079e31d0c29612b03097de73cdb1daff705c8e623fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe8b45ce025d581e09f75d0b7b41b27a734ecbf6f171bcf9da4553ebb694d0db4377fb0bd27a50bcab72be10cf83147cc94f239b779132be802d1c5ada965c19"} 14:22:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:51 INFO - Copying logs to upload dir... 14:22:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.904243 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-18 14:22:51.581253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 14:22:51.582453) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b89bd08e2477877434b7890b440ca8999d5b296cc796bfafac864bdebf6d607e5e570b3dbd50f00e96042e8cc6e8500acf2f5fd6b92ff716e94f8caab6329423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/aeab3921c00b0eb0765969ac49c570f1bc5a1482b2b01077f89d83f49ac571be592d0bb81f080a83ad42079e31d0c29612b03097de73cdb1daff705c8e623fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe8b45ce025d581e09f75d0b7b41b27a734ecbf6f171bcf9da4553ebb694d0db4377fb0bd27a50bcab72be10cf83147cc94f239b779132be802d1c5ada965c19"} build_url:https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010838 build_url: 'https://queue.taskcluster.net/v1/task/WL6qHya_Qga9RX8kG7t1LA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b89bd08e2477877434b7890b440ca8999d5b296cc796bfafac864bdebf6d607e5e570b3dbd50f00e96042e8cc6e8500acf2f5fd6b92ff716e94f8caab6329423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/aeab3921c00b0eb0765969ac49c570f1bc5a1482b2b01077f89d83f49ac571be592d0bb81f080a83ad42079e31d0c29612b03097de73cdb1daff705c8e623fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe8b45ce025d581e09f75d0b7b41b27a734ecbf6f171bcf9da4553ebb694d0db4377fb0bd27a50bcab72be10cf83147cc94f239b779132be802d1c5ada965c19"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 14:22:51.619481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-18 14:22:51.620066) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Slkc3X2N76/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GF3dLBqfc7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005125 ========= master_lag: 3.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-18 14:22:54.785780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 14:22:54.786133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 14:22:54.791367) ========= ========= Total master_lag: 3.39 =========