builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1486749100.25 results: success (0) buildid: 20170210081222 builduid: 8516d95a978f4a97a86d11123d66232f revision: 4990c20c7326e90dd12a9a98c86ff194d08e8f67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.247683) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.248095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.248368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.277990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.278567) ========= 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.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 --2017-02-10 09:51:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.5M=0.001s 2017-02-10 09:51:40 (16.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087309 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.395608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.396372) ========= 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.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.026804 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:40.447603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 09:51:40.447971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4990c20c7326e90dd12a9a98c86ff194d08e8f67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4990c20c7326e90dd12a9a98c86ff194d08e8f67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 2017-02-10 09:51:40,532 truncating revision to first 12 chars 2017-02-10 09:51:40,532 Setting DEBUG logging. 2017-02-10 09:51:40,532 attempt 1/10 2017-02-10 09:51:40,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4990c20c7326?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 09:51:41,713 unpacking tar archive at: mozilla-beta-4990c20c7326/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 09:51:41.933769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:41.934142) ========= script_repo_revision: 4990c20c7326e90dd12a9a98c86ff194d08e8f67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:41.934602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:41.934957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 09:51:41.955742) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-02-10 09:51:41.956074) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:51:42 INFO - MultiFileLogger online at 20170210 09:51:42 in /builds/slave/test 09:51:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:51:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:51:42 INFO - {'append_to_log': False, 09:51:42 INFO - 'base_work_dir': '/builds/slave/test', 09:51:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:51:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:51:42 INFO - 'branch': 'Mozilla-Beta', 09:51:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:42 INFO - 'config_files': ('talos/mac_config.py',), 09:51:42 INFO - 'default_actions': ('clobber', 09:51:42 INFO - 'read-buildbot-config', 09:51:42 INFO - 'download-and-extract', 09:51:42 INFO - 'populate-webroot', 09:51:42 INFO - 'create-virtualenv', 09:51:42 INFO - 'install', 09:51:42 INFO - 'run-tests'), 09:51:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:42 INFO - 'download_minidump_stackwalk': True, 09:51:42 INFO - 'download_symbols': 'ondemand', 09:51:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:42 INFO - 'installer_path': 'installer.exe', 09:51:42 INFO - 'log_level': 'info', 09:51:42 INFO - 'log_name': 'talos', 09:51:42 INFO - 'log_to_console': True, 09:51:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:51:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:51:42 INFO - 'opt_config_files': (), 09:51:42 INFO - 'pip_index': False, 09:51:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:51:42 INFO - 'cmd': ('bash', 09:51:42 INFO - '-c', 09:51:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:51:42 INFO - 'enabled': True, 09:51:42 INFO - 'halt_on_failure': False, 09:51:42 INFO - 'name': 'check_screen_resolution'},), 09:51:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:51:42 INFO - 'cmd': ('bash', 09:51:42 INFO - '-c', 09:51:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:51:42 INFO - 'enabled': True, 09:51:42 INFO - 'halt_on_failure': False, 09:51:42 INFO - 'name': 'check_screen_resolution'},), 09:51:42 INFO - 'run_cmd_checks_enabled': True, 09:51:42 INFO - 'sps_profile': False, 09:51:42 INFO - 'sps_profile_interval': 0, 09:51:42 INFO - 'suite': 'dromaeojs', 09:51:42 INFO - 'system_bits': '32', 09:51:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:42 INFO - 'title': 't-yosemite-r7-0034', 09:51:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:42 INFO - 'use_talos_json': True, 09:51:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:51:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:42 INFO - 'work_dir': 'build'} 09:51:42 INFO - [mozharness: 2017-02-10 17:51:42.162171Z] Running clobber step. 09:51:42 INFO - Running pre-action listener: _resource_record_pre_action 09:51:42 INFO - Running main action method: clobber 09:51:42 INFO - rmtree: /builds/slave/test/build 09:51:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:51:44 INFO - Running post-action listener: _resource_record_post_action 09:51:44 INFO - [mozharness: 2017-02-10 17:51:44.747891Z] Finished clobber step (success) 09:51:44 INFO - [mozharness: 2017-02-10 17:51:44.748167Z] Running read-buildbot-config step. 09:51:44 INFO - Running pre-action listener: _resource_record_pre_action 09:51:44 INFO - Running main action method: read_buildbot_config 09:51:44 INFO - Using buildbot properties: 09:51:44 INFO - { 09:51:44 INFO - "project": "", 09:51:44 INFO - "product": "firefox", 09:51:44 INFO - "script_repo_revision": "production", 09:51:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:51:44 INFO - "repository": "", 09:51:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:51:44 INFO - "buildid": "20170210081222", 09:51:44 INFO - "pgo_build": "False", 09:51:44 INFO - "basedir": "/builds/slave/test", 09:51:44 INFO - "buildnumber": 19, 09:51:44 INFO - "slavename": "t-yosemite-r7-0034", 09:51:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:51:44 INFO - "platform": "yosemite_r7", 09:51:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:51:44 INFO - "branch": "mozilla-beta", 09:51:44 INFO - "repo_path": "releases/mozilla-beta", 09:51:44 INFO - "revision": "4990c20c7326e90dd12a9a98c86ff194d08e8f67", 09:51:44 INFO - "stage_platform": "macosx64", 09:51:44 INFO - "builduid": "8516d95a978f4a97a86d11123d66232f", 09:51:44 INFO - "slavebuilddir": "test" 09:51:44 INFO - } 09:51:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:51:44 INFO - Running post-action listener: _resource_record_post_action 09:51:44 INFO - [mozharness: 2017-02-10 17:51:44.753885Z] Finished read-buildbot-config step (success) 09:51:44 INFO - [mozharness: 2017-02-10 17:51:44.754122Z] Running download-and-extract step. 09:51:44 INFO - Running pre-action listener: _resource_record_pre_action 09:51:44 INFO - Running main action method: download_and_extract 09:51:44 INFO - mkdir: /builds/slave/test/build/tests 09:51:44 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')]} 09:51:44 INFO - trying https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:51:44 INFO - Downloading https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:51:46 INFO - Downloaded 1165 bytes. 09:51:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:51:46 INFO - Using the following test package requirements: 09:51:46 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:51:46 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:51:46 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:51:46 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:51:46 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:51:46 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:51:46 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:51:46 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:51:46 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:51:46 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:51:46 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:51:46 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:51:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:51:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:51:46 INFO - Fetch https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:51:46 INFO - Http code: 200 09:51:46 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:51:46 INFO - x-amz-cf-id: OpYdnpJ_6AIPo6x_mocAqEy0r9ThhPo2bEz0vP57GrsIk1hEm0HEmA== 09:51:46 INFO - x-amz-version-id: Eu25jk8bhp7nqPlTvWE8rSUqK6khkWVc 09:51:51 INFO - Expected file size: 16093652 09:51:51 INFO - Obtained file size: 16093652 09:51:58 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:51:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:51:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:51:58 INFO - Fetch https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:51:59 INFO - Http code: 200 09:51:59 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:51:59 INFO - x-amz-cf-id: ladspUDx8kNZk3Avxy2wjWDtOrObATvluK3yfZn3shFkk9vTLUQ-9A== 09:51:59 INFO - x-amz-version-id: Eu25jk8bhp7nqPlTvWE8rSUqK6khkWVc 09:52:00 INFO - Expected file size: 16093652 09:52:00 INFO - Obtained file size: 16093652 09:52:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:52:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:52:07 INFO - Fetch https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:52:08 INFO - Http code: 200 09:52:08 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:52:08 INFO - x-amz-cf-id: 1OXFjojAXb64DqkZECJ3KnfuKPmPTSA3p0eZeViKPXO04env-pJ1OA== 09:52:08 INFO - x-amz-version-id: OkZQJj3onb_tbAf3LytA_UfTrIdagIbx 09:52:09 INFO - Expected file size: 14403005 09:52:09 INFO - Obtained file size: 14403005 09:52: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')]} 09:52:10 INFO - trying https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:52:10 INFO - Downloading https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:52:17 INFO - Downloaded 82152700 bytes. 09:52:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:52:17 INFO - mkdir: /builds/slave/test/properties 09:52:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:17 INFO - Contents: 09:52:17 INFO - build_url:https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:52:18 INFO - Running post-action listener: _resource_record_post_action 09:52:18 INFO - Running post-action listener: set_extra_try_arguments 09:52:18 INFO - [mozharness: 2017-02-10 17:52:18.877511Z] Finished download-and-extract step (success) 09:52:18 INFO - [mozharness: 2017-02-10 17:52:18.877669Z] Running populate-webroot step. 09:52:18 INFO - Running pre-action listener: _resource_record_pre_action 09:52:18 INFO - Running main action method: populate_webroot 09:52:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:18 INFO - '--tppagecycles', 09:52:18 INFO - '7'], 09:52:18 INFO - 'tests': ['tsvgm']}}, 09:52:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['damp', 'tps']}, 09:52:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'tests': ['damp', 'tps']}, 09:52:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['dromaeo_dom']}, 09:52:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['basic_compositor_video']}, 09:52:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:52:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['a11yr', 09:52:18 INFO - 'ts_paint', 09:52:18 INFO - 'tpaint', 09:52:18 INFO - 'sessionrestore', 09:52:18 INFO - 'sessionrestore_no_auto_restore', 09:52:18 INFO - 'tabpaint']}, 09:52:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['tsvgx', 09:52:18 INFO - 'tsvgr_opacity', 09:52:18 INFO - 'tart', 09:52:18 INFO - 'tscrollx', 09:52:18 INFO - 'cart']}, 09:52:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:18 INFO - 'tsvgr_opacity', 09:52:18 INFO - 'tart', 09:52:18 INFO - 'tscrollx', 09:52:18 INFO - 'cart']}, 09:52:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'talos_options': ['--disable-e10s'], 09:52:18 INFO - 'tests': ['tp5o']}, 09:52:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'tests': ['tp5o']}, 09:52:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'talos_options': ['--disable-e10s', 09:52:18 INFO - '--xperf_path', 09:52:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:18 INFO - 'tests': ['tp5n']}, 09:52:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:18 INFO - 'talos_options': ['--xperf_path', 09:52:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:18 INFO - 'tests': ['tp5n']}}, 09:52:18 INFO - 'talos.zip': {'path': '', 09:52:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:18 INFO - Running post-action listener: _resource_record_post_action 09:52:18 INFO - [mozharness: 2017-02-10 17:52:18.897039Z] Finished populate-webroot step (success) 09:52:18 INFO - [mozharness: 2017-02-10 17:52:18.897161Z] Running create-virtualenv step. 09:52:18 INFO - Running pre-action listener: _resource_record_pre_action 09:52:18 INFO - Running main action method: create_virtualenv 09:52:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:18 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 09:52:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:19 INFO - Using real prefix '/tools/python27' 09:52:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:22 INFO - Installing pip.................done. 09:52:22 INFO - Return code: 0 09:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:52:23 INFO - Reading from file tmpfile_stdout 09:52:23 INFO - Output received: 09:52:23 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) 09:52:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52:23 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')]} 09:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 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')]} 09:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:23 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:23 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 09:52:23 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 09:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:23 INFO - 'HOME': '/Users/cltbld', 09:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:23 INFO - 'LOGNAME': 'cltbld', 09:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:23 INFO - 'MOZ_NO_REMOTE': '1', 09:52:23 INFO - 'NO_EM_RESTART': '1', 09:52:23 INFO - 'PAGER': '/bin/cat', 09:52:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:23 INFO - 'PWD': '/builds/slave/test', 09:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:23 INFO - 'SHELL': '/bin/bash', 09:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:23 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:23 INFO - 'USER': 'cltbld', 09:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:23 INFO - 'XPC_FLAGS': '0x0', 09:52:23 INFO - 'XPC_SERVICE_NAME': '0', 09:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:24 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 09:52:24 INFO - Cleaning up... 09:52:24 INFO - Return code: 0 09:52:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:24 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:24 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 09:52:24 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 09:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:24 INFO - 'HOME': '/Users/cltbld', 09:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:24 INFO - 'LOGNAME': 'cltbld', 09:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:24 INFO - 'MOZ_NO_REMOTE': '1', 09:52:24 INFO - 'NO_EM_RESTART': '1', 09:52:24 INFO - 'PAGER': '/bin/cat', 09:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:24 INFO - 'PWD': '/builds/slave/test', 09:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:24 INFO - 'SHELL': '/bin/bash', 09:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:24 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:24 INFO - 'USER': 'cltbld', 09:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:24 INFO - 'XPC_FLAGS': '0x0', 09:52:24 INFO - 'XPC_SERVICE_NAME': '0', 09:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:24 INFO - Downloading/unpacking psutil>=3.1.1 09:52:24 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 09:52:24 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 09:52:24 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 09:52:24 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 09:52:24 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 09:52:24 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 09:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:28 INFO - Installing collected packages: psutil 09:52:28 INFO - Running setup.py install for psutil 09:52:28 INFO - building 'psutil._psutil_osx' extension 09:52:28 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 09:52:29 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 09:52:29 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 09:52:29 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 09:52:29 INFO - building 'psutil._psutil_posix' extension 09:52:29 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 09:52:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:52:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:52:29 INFO - ^ 09:52:29 INFO - 1 warning generated. 09:52:29 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 09:52:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:29 INFO - Successfully installed psutil 09:52:29 INFO - Cleaning up... 09:52:29 INFO - Return code: 0 09:52:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:29 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:29 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 09:52:29 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 09:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:29 INFO - 'HOME': '/Users/cltbld', 09:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:29 INFO - 'LOGNAME': 'cltbld', 09:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:29 INFO - 'MOZ_NO_REMOTE': '1', 09:52:29 INFO - 'NO_EM_RESTART': '1', 09:52:29 INFO - 'PAGER': '/bin/cat', 09:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:29 INFO - 'PWD': '/builds/slave/test', 09:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:29 INFO - 'SHELL': '/bin/bash', 09:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:29 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:29 INFO - 'USER': 'cltbld', 09:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:29 INFO - 'XPC_FLAGS': '0x0', 09:52:29 INFO - 'XPC_SERVICE_NAME': '0', 09:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:30 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 09:52:30 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 09:52:30 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 09:52:30 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 09:52:30 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 09:52:30 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 09:52:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:52:32 INFO - Installing collected packages: mozsystemmonitor 09:52:32 INFO - Running setup.py install for mozsystemmonitor 09:52:33 INFO - Successfully installed mozsystemmonitor 09:52:33 INFO - Cleaning up... 09:52:33 INFO - Return code: 0 09:52:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52:33 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')]} 09:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:33 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')]} 09:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:33 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:33 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 09:52:33 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 09:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:33 INFO - 'HOME': '/Users/cltbld', 09:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:33 INFO - 'LOGNAME': 'cltbld', 09:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:33 INFO - 'MOZ_NO_REMOTE': '1', 09:52:33 INFO - 'NO_EM_RESTART': '1', 09:52:33 INFO - 'PAGER': '/bin/cat', 09:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:33 INFO - 'PWD': '/builds/slave/test', 09:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:33 INFO - 'SHELL': '/bin/bash', 09:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:33 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:33 INFO - 'USER': 'cltbld', 09:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:33 INFO - 'XPC_FLAGS': '0x0', 09:52:33 INFO - 'XPC_SERVICE_NAME': '0', 09:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:52:33 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 09:52:33 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 09:52:33 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 09:52:33 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 09:52:33 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 09:52:33 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 09:52:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:52:36 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 09:52:36 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 09:52:36 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 09:52:36 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 09:52:36 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 09:52:36 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 09:52:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:36 INFO - warning: no files found matching '*.txt' 09:52:36 INFO - no previously-included directories found matching 'build' 09:52:36 INFO - no previously-included directories found matching 'dist' 09:52:36 INFO - no previously-included directories found matching '.git*' 09:52:36 INFO - Installing collected packages: jsonschema, functools32 09:52:36 INFO - Running setup.py install for functools32 09:52:36 INFO - warning: no files found matching '*.txt' 09:52:36 INFO - no previously-included directories found matching 'build' 09:52:36 INFO - no previously-included directories found matching 'dist' 09:52:36 INFO - no previously-included directories found matching '.git*' 09:52:36 INFO - Successfully installed jsonschema functools32 09:52:36 INFO - Cleaning up... 09:52:37 INFO - Return code: 0 09:52:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:37 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:37 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 09:52:37 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 09:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:37 INFO - 'HOME': '/Users/cltbld', 09:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:37 INFO - 'LOGNAME': 'cltbld', 09:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:37 INFO - 'MOZ_NO_REMOTE': '1', 09:52:37 INFO - 'NO_EM_RESTART': '1', 09:52:37 INFO - 'PAGER': '/bin/cat', 09:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:37 INFO - 'PWD': '/builds/slave/test', 09:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:37 INFO - 'SHELL': '/bin/bash', 09:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:37 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:37 INFO - 'USER': 'cltbld', 09:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:37 INFO - 'XPC_FLAGS': '0x0', 09:52:37 INFO - 'XPC_SERVICE_NAME': '0', 09:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:52:37 INFO - Cleaning up... 09:52:37 INFO - Return code: 0 09:52:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:37 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:37 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 09:52:37 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 09:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:37 INFO - 'HOME': '/Users/cltbld', 09:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:37 INFO - 'LOGNAME': 'cltbld', 09:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:37 INFO - 'MOZ_NO_REMOTE': '1', 09:52:37 INFO - 'NO_EM_RESTART': '1', 09:52:37 INFO - 'PAGER': '/bin/cat', 09:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:37 INFO - 'PWD': '/builds/slave/test', 09:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:37 INFO - 'SHELL': '/bin/bash', 09:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:37 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:37 INFO - 'USER': 'cltbld', 09:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:37 INFO - 'XPC_FLAGS': '0x0', 09:52:37 INFO - 'XPC_SERVICE_NAME': '0', 09:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:37 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 09:52:37 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 09:52:37 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 09:52:37 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 09:52:37 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 09:52:37 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 09:52:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:40 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 09:52:40 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 09:52:40 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 09:52:40 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 09:52:40 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 09:52:40 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 09:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 INFO - Downloading docopt-0.6.1.tar.gz 09:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:41 INFO - Running setup.py install for blobuploader 09:52:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:41 INFO - Running setup.py install for requests 09:52:42 INFO - Running setup.py install for docopt 09:52:42 INFO - Successfully installed blobuploader requests docopt 09:52:42 INFO - Cleaning up... 09:52:42 INFO - Return code: 0 09:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:42 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')]} 09:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:42 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')]} 09:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:42 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:42 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 09:52:42 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 09:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:42 INFO - 'HOME': '/Users/cltbld', 09:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:42 INFO - 'LOGNAME': 'cltbld', 09:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:42 INFO - 'MOZ_NO_REMOTE': '1', 09:52:42 INFO - 'NO_EM_RESTART': '1', 09:52:42 INFO - 'PAGER': '/bin/cat', 09:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:42 INFO - 'PWD': '/builds/slave/test', 09:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:42 INFO - 'SHELL': '/bin/bash', 09:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:42 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:42 INFO - 'USER': 'cltbld', 09:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:42 INFO - 'XPC_FLAGS': '0x0', 09:52:42 INFO - 'XPC_SERVICE_NAME': '0', 09:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-vp4R0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-bb5dfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-a1H43R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-g2TGCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-QGuYXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-XqUUnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-mIYEEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1vSAdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-YT7CzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-JT9Mqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cwtdAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-OS0REi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-8ObQza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-y_oEI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cZMPJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Kzy854-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-AWlRJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:44 INFO - Running setup.py install for manifestparser 09:52:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:52:45 INFO - Running setup.py install for mozcrash 09:52:45 INFO - Running setup.py install for mozdebug 09:52:45 INFO - Running setup.py install for mozdevice 09:52:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:52:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:52:45 INFO - Running setup.py install for mozfile 09:52:45 INFO - Running setup.py install for mozhttpd 09:52:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:52:45 INFO - Running setup.py install for mozinfo 09:52:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:52:45 INFO - Running setup.py install for mozInstall 09:52:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Running setup.py install for mozleak 09:52:46 INFO - Running setup.py install for mozlog 09:52:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Running setup.py install for moznetwork 09:52:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Running setup.py install for mozprocess 09:52:46 INFO - Running setup.py install for mozprofile 09:52:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:52:46 INFO - Running setup.py install for mozrunner 09:52:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:52:47 INFO - Running setup.py install for mozscreenshot 09:52:47 INFO - Running setup.py install for moztest 09:52:47 INFO - Running setup.py install for mozversion 09:52:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:52:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:47 INFO - Cleaning up... 09:52:47 INFO - Return code: 0 09:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:47 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')]} 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 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')]} 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:47 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 09:52:47 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 09:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:47 INFO - 'HOME': '/Users/cltbld', 09:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:47 INFO - 'LOGNAME': 'cltbld', 09:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:47 INFO - 'MOZ_NO_REMOTE': '1', 09:52:47 INFO - 'NO_EM_RESTART': '1', 09:52:47 INFO - 'PAGER': '/bin/cat', 09:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:47 INFO - 'PWD': '/builds/slave/test', 09:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:47 INFO - 'SHELL': '/bin/bash', 09:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:47 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:47 INFO - 'USER': 'cltbld', 09:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:47 INFO - 'XPC_FLAGS': '0x0', 09:52:47 INFO - 'XPC_SERVICE_NAME': '0', 09:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:47 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-zWRtVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:47 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)) 09:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:47 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-wiIJZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-kM4dxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-RL7fRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-d0FcMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xoYJYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-A3UEOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-FHu7Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-bFXrJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-_8uG5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:48 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)) 09:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-22oJk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:49 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-pEv_4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:49 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-82Hpvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:49 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-M1NGT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:49 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-jMXhT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:49 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-guBh_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-jUAOso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:49 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)) 09:52:49 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)) 09:52:49 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)) 09:52:49 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)) 09:52:49 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)) 09:52:49 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)) 09:52:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:52 INFO - Downloading blessings-1.6.tar.gz 09:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:52 INFO - Installing collected packages: blessings 09:52:52 INFO - Running setup.py install for blessings 09:52:52 INFO - Successfully installed blessings 09:52:52 INFO - Cleaning up... 09:52:52 INFO - Return code: 0 09:52:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:53 INFO - Reading from file tmpfile_stdout 09:52:53 INFO - Current package versions: 09:52:53 INFO - blessings == 1.6 09:52:53 INFO - blobuploader == 1.2.4 09:52:53 INFO - docopt == 0.6.1 09:52:53 INFO - functools32 == 3.2.3-2 09:52:53 INFO - jsonschema == 2.5.1 09:52:53 INFO - manifestparser == 1.1 09:52:53 INFO - mozInstall == 1.12 09:52:53 INFO - mozcrash == 1.0 09:52:53 INFO - mozdebug == 0.1 09:52:53 INFO - mozdevice == 0.48 09:52:53 INFO - mozfile == 1.2 09:52:53 INFO - mozhttpd == 0.7 09:52:53 INFO - mozinfo == 0.9 09:52:53 INFO - mozleak == 0.1 09:52:53 INFO - mozlog == 3.4 09:52:53 INFO - moznetwork == 0.27 09:52:53 INFO - mozprocess == 0.23 09:52:53 INFO - mozprofile == 0.28 09:52:53 INFO - mozrunner == 6.13 09:52:53 INFO - mozscreenshot == 0.1 09:52:53 INFO - mozsystemmonitor == 0.3 09:52:53 INFO - moztest == 0.8 09:52:53 INFO - mozversion == 1.4 09:52:53 INFO - psutil == 3.1.1 09:52:53 INFO - requests == 1.2.3 09:52:53 INFO - wsgiref == 0.1.2 09:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:53 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')]} 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 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')]} 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:53 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 09:52:53 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 09:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:53 INFO - 'HOME': '/Users/cltbld', 09:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:53 INFO - 'LOGNAME': 'cltbld', 09:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:53 INFO - 'MOZ_NO_REMOTE': '1', 09:52:53 INFO - 'NO_EM_RESTART': '1', 09:52:53 INFO - 'PAGER': '/bin/cat', 09:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:53 INFO - 'PWD': '/builds/slave/test', 09:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:53 INFO - 'SHELL': '/bin/bash', 09:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:53 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:53 INFO - 'USER': 'cltbld', 09:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:53 INFO - 'XPC_FLAGS': '0x0', 09:52:53 INFO - 'XPC_SERVICE_NAME': '0', 09:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 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)) 09:52:53 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:52:53 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')]} 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 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')]} 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 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 0x109a1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109993570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f94a6650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, '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.layXQfHWAI/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.02QbdIAiyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 09:52:53 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 09:52:53 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 09:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:53 INFO - 'HOME': '/Users/cltbld', 09:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:53 INFO - 'LOGNAME': 'cltbld', 09:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:53 INFO - 'MOZ_NO_REMOTE': '1', 09:52:53 INFO - 'NO_EM_RESTART': '1', 09:52:53 INFO - 'PAGER': '/bin/cat', 09:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:53 INFO - 'PWD': '/builds/slave/test', 09:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:53 INFO - 'SHELL': '/bin/bash', 09:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:52:53 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:53 INFO - 'USER': 'cltbld', 09:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:53 INFO - 'XPC_FLAGS': '0x0', 09:52:53 INFO - 'XPC_SERVICE_NAME': '0', 09:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:52:53 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Running post-action listener: _resource_record_post_action 09:52:53 INFO - Running post-action listener: _start_resource_monitoring 09:52:53 INFO - Starting resource monitoring. 09:52:53 INFO - [mozharness: 2017-02-10 17:52:53.796145Z] Finished create-virtualenv step (success) 09:52:53 INFO - [mozharness: 2017-02-10 17:52:53.797196Z] Running install step. 09:52:53 INFO - Running pre-action listener: _resource_record_pre_action 09:52:53 INFO - Running main action method: install 09:52:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:54 INFO - Reading from file tmpfile_stdout 09:52:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:52:54 INFO - Reading from file tmpfile_stdout 09:52:54 INFO - Output received: 09:52:54 INFO - Usage: mozinstall [options] installer 09:52:54 INFO - Options: 09:52:54 INFO - -h, --help show this help message and exit 09:52:54 INFO - -d DEST, --destination=DEST 09:52:54 INFO - Directory to install application into. [default: 09:52:54 INFO - "/builds/slave/test"] 09:52:54 INFO - --app=APP Application being installed. [default: firefox] 09:52:54 INFO - mkdir: /builds/slave/test/build/application 09:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:53:16 INFO - Reading from file tmpfile_stdout 09:53:16 INFO - Output received: 09:53:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:53:16 INFO - Running post-action listener: _resource_record_post_action 09:53:16 INFO - [mozharness: 2017-02-10 17:53:16.496222Z] Finished install step (success) 09:53:16 INFO - [mozharness: 2017-02-10 17:53:16.496333Z] Running run-tests step. 09:53:16 INFO - Running pre-action listener: _resource_record_pre_action 09:53:16 INFO - Running main action method: run_tests 09:53:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:16 INFO - 2017-02-10 09:53:16.510 screenresolution[1623:7557] starting screenresolution argv=screenresolution get 09:53:16 INFO - 2017-02-10 09:53:16.513 screenresolution[1623:7557] Display 0: 1600x1200x32@60 09:53:16 INFO - 2017-02-10 09:53:16.519 screenresolution[1624:7560] starting screenresolution argv=screenresolution list 09:53:16 INFO - Available Modes on Display 0 09:53:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:16 INFO - Intel Iris: 09:53:16 INFO - Chipset Model: Intel Iris 09:53:16 INFO - Type: GPU 09:53:16 INFO - Bus: Built-In 09:53:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:16 INFO - Vendor: Intel (0x8086) 09:53:16 INFO - Device ID: 0x0a2e 09:53:16 INFO - Revision ID: 0x0009 09:53:16 INFO - Displays: 09:53:16 INFO - Display: 09:53:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:16 INFO - Display Serial Number: 1600x1200 60 09:53:16 INFO - Main Display: Yes 09:53:16 INFO - Mirror: Off 09:53:16 INFO - Online: Yes 09:53:16 INFO - Rotation: Supported 09:53:16 INFO - Return code: 0 09:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:16 INFO - Python 2.7.3 09:53:16 INFO - Return code: 0 09:53:16 INFO - grabbing minidump binary from tooltool 09:53:16 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')]} 09:53:16 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 0x109831d30>, '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 0x109697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109829b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:16 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 09:53:16 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 09:53:16 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 09:53:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:16 INFO - Return code: 0 09:53:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 09:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 09:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.layXQfHWAI/Render', 09:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:16 INFO - 'HOME': '/Users/cltbld', 09:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:16 INFO - 'LOGNAME': 'cltbld', 09:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:16 INFO - 'MOZ_NO_REMOTE': '1', 09:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:16 INFO - 'NO_EM_RESTART': '1', 09:53:16 INFO - 'PAGER': '/bin/cat', 09:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:16 INFO - 'PWD': '/builds/slave/test', 09:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:16 INFO - 'SHELL': '/bin/bash', 09:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02QbdIAiyl/Listeners', 09:53:16 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 09:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:16 INFO - 'USER': 'cltbld', 09:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:16 INFO - 'XPC_FLAGS': '0x0', 09:53:16 INFO - 'XPC_SERVICE_NAME': '0', 09:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 09:53:17 INFO - mozversion application_buildid: 20170210081222 09:53:17 INFO - mozversion application_changeset: 4990c20c7326e90dd12a9a98c86ff194d08e8f67 09:53:17 INFO - mozversion application_display_name: Firefox 09:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:17 INFO - mozversion application_name: Firefox 09:53:17 INFO - mozversion application_remotingname: firefox 09:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:17 INFO - mozversion application_vendor: Mozilla 09:53:17 INFO - mozversion application_version: 52.0 09:53:17 INFO - mozversion platform_buildid: 20170210081222 09:53:17 INFO - mozversion platform_changeset: 4990c20c7326e90dd12a9a98c86ff194d08e8f67 09:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:17 INFO - mozversion platform_version: 52.0 09:53:17 INFO - using testdate: 1486749197 09:53:17 INFO - actual date: 1486749197 09:53:17 INFO - starting webserver on 'localhost:49240' 09:53:17 INFO - SUITE-START | Running 2 tests 09:53:17 INFO - TEST-START | dromaeo_css 09:53:17 INFO - operating with platform_type : mac_ 09:53:17 INFO - Initialising browser for dromaeo_css test... 09:53:17 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpUy1Oss/profile http://localhost:49240/getInfo.html) 09:53:20 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:53:20 INFO - PROCESS | 1634 | colorDepth:24 09:53:20 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:53:20 INFO - PROCESS | 1634 | __metrics 09:53:20 INFO - PROCESS | 1634 | 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" 09:53:20 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:21 INFO - TEST-INFO | 1634: exit 0 09:53:21 INFO - Browser initialized. 09:53:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:21 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpUy1Oss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:33 INFO - PROCESS | 1638 | RSS: Main: 167874560 09:53:33 INFO - PROCESS | 1638 | 09:56:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:56:36 INFO - PROCESS | 1638 | RSS: Main: 270290944 09:56:36 INFO - PROCESS | 1638 | 09:59:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:59:40 INFO - PROCESS | 1638 | RSS: Main: 293789696 09:59:40 INFO - PROCESS | 1638 | 10:02:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 10:02:43 INFO - PROCESS | 1638 | RSS: Main: 281677824 10:02:43 INFO - PROCESS | 1638 | 10:05:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 10:05:46 INFO - PROCESS | 1638 | RSS: Main: 273739776 10:05:46 INFO - PROCESS | 1638 | 10:08:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 10:08:50 INFO - PROCESS | 1638 | RSS: Main: 258023424 10:08:50 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 10:11:53 INFO - PROCESS | 1638 | RSS: Main: 314765312 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | __start_tp_report 10:11:53 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:11:53 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:11:53 INFO - PROCESS | 1638 | |i|pagename|runs| 10:11:53 INFO - PROCESS | 1638 | |0;dojo.html;2985.2089196362963;2998.1305421427787;3051.816890986541;3053.7709671774624;3100.488419410797;4860.295257187715;4984.053029924312;5042.420121686007;5065.33665835411;5068.797248110071;4281.7002809803325;5008.323876276701;5008.824691135811;5032.899342013157;5054.292399064134;4540.9091818163615;4547.158775626512;4605.171069207541;4636.97681511592;4668.696534725249;4497.9325310120375;4512.616427603658;4579.129965306598;4601.171789077965;4631.3516107744945;4259.893502662443;4288.16380805743;4539.59143677069;4636.652251081166;4677.976610116944;4651.395318608559;4668.253079507263;4673.906521869578;4688.484266730657;4706.599939005188;4459.955400445986;4541.45502539694;4635.745034023127;4636.235021221494;4638.234691275936;4859.441164266119;4970.826021089245;4973.378327709036;5008.348914641109;5077.695338279715;5368.516833485005;5450.700211488366;5460.372057213432;5525.889482210333;5553.7778488860395;5581.079121944874;5596.944030559724;5632.802851900205;5644.040513112781;5657.896710141524;5016.598672106223;5113.1052065888325;5120.103981803207;5172.482751724798;5201.063808514504;5677.460641239076;5679.488846003796;5738.2540269765495;5796.5072968797285;5802.390748971297;5468.425815289417;5475.835724928259;5480.479354461399;5484.7531861066345;5485.9725701371235;5358.866028349323;5624.803131890364;5642;5654.434556544395;5675.489205971482;5379.919301210485;5476.069068258326;5506.531944784738;5512.641678290978;5521.475459831309;5412.783488660488;5435.483629055233;5499.257600223998;5504.4770746778995;5513.393526712059;4478.977605111953;4504.864854054384;4526.547345265513;4553.225951588238;4566;4016.859409920697;4022.4971878515184;4026.053877338823;4032.91934161321;4059.06641472463;3977.284088864032;5039.924401133986;5047.394312682502;5063.987202559503;5102.515261050195;5322.680639161663;5405;5408.8377348679605;5484.945150548443;5523.337199536081;5037.194048952223;5041.395032596112;5044.470330615306;5055.469175736568;5065.341505604248;4856.223004319292;4870.707757534559;4881.170201065827;4887.975560122177;4897.9714260005085;5644;5802.071668533014;5811.825645230734;5827.388124246978;5835.124731290341;5458.181272809111;5465.535429488538;5518.117101263779;5521.337439507124;5542.75057622416;5687.971560142173;5862.413758624103;5878.147668588116;5888.146218798164;5899.292084949833;5340.626156169031;5358.705271210121;5461.535769459481;5497.697626630574;5500.532454741232;3915.4126880968083;5393.406725260296;5401.459854014724;5417.83746487606;5529.281193444826;5365.865853353697;5377.892442151213;5385.54222891043;5403.891922161613;5410.891782164256;5363.624546281723;5383.946160538501;5387.407385187548;5396.622236443568;5437.130059190668;5082.440931497458;5152.5877929766275;5176.792928282826;5264.868378290574;5274.050670879278;5275.657082289639;5359.758810853599;5370.382406023201;5427.864303392446;5434.728263586726;5269.920951185812;5284.286621306074;5289.709066001406;5307.4692530746615;5334.439883812144 10:11:53 INFO - PROCESS | 1638 | |1;ext.html;458.3743190544906;471.18955396717644;481.9228923372259;509.9647715138268;546.8086169840559;36458.08854778628;38520.42219366708;38563.61436385635;38595.80702096492;38606;37979;38351;38375.808120959424;38532.80733596335;38556.80721596388;8146.918530814705;8735.737927862143;9115.908840911588;9347;11319.320840749582;11280.830787538194;11391.772164556704;11398.974092331688;11399.886001140007;11424.257423267503;11411;11420.54317827286;11426.828597571042;11431.199816012882;11481.655550333462;11314.151438642093;11383;11405.486753096131;11423;11451.59919402817;11234.831477527843;11285.210035297532;11293.943530282379;11331.980121789078;11335.659930202108;34285.82857085724;34833.303333933436;37719;38153.80923095394;38209;2804.5372513535444;3003.7634274605457;3022.926860964348;3269.264415506492;3443.9827800860835;27815;27951.86024069887;28925.987590434444;30268.69731302681;30315.393692126254;2510.836795608298;3114.2837147455984;3117.719405253538;3246.204679853451;3322.3355328934067;419386;423228;425562;425869;426120.8693956541;32214.19464513359;54196.187057194176;54520.72739636277;54575.90848183014;54678.45321546813;32380.190495237337;34083.318333633186;34216.82891585526;34238.657613423544;34312.65687343095;13783.310834458238;13877.88976881847;13896.16623002623;13935.860641393456;13952.720945581032;10622.521986510472;10867.728306792393;11421.828672569918;11692.181547291608;11742.765144697229;7562.546247225184;7567.356774674215;7630.8092297693;7633.2366763324335;7642.426817988673;3126.5466507356305;3141.638711548201;3175.301433684586;3207.566978457925;3244.659310772382;680.9445359692456;759.3621358059256;849.7280870121501;910.2626872233512;982.6757170133839;28300.71699283022;28337.433251334856;28722;28874;29180.416391672046;788.5347644889428;898.6046139698511;924.4176169013613;1028.4240825137947;1047.9056884880397;14239.644008899653;14805.481808136663;15162.166080865438;15223.391064357302;15466.845331546765;649190;654640;654817;656892;657093.7145314243;52777.736111319195;52821;54095.72952135214;54572.635684108216;54657;986.8519722041751;1145.4559084434993;1186.15190139051;1279.4178648714812;1321.3393303348325;28614.998475053275;29780;30189.547156793105;30621.540676889417;30642;44959.77520112378;45511.54488455073;45594.77202613965;45603;45640.54359456363;467939;536001;542079;542890.2855485698;543286;23099.65350519777;25520.489590208465;25524.74475255298;25532.872335638203;25551.23346299614;44185.779071104436;44336.55663443324;44467.77766111149;44600;44769.776151120335;31016.22459438532;35428.64571354254;35902;36211.09472263109;36361.09097272589;28501.717422715614;34588.82705586456;34732.65267347294;35098.947031588075;35458.75894343686;36322.273554528234;36704.81647591745;36749.44875826918;36763;37011.6333131689;31303.373932521677;32206.516902246018;32598.837005814818;34459.655403446646;34485.827570861984;24310.75689243085;24374.26877193687;24523;24699.50600988006;24939 10:11:53 INFO - PROCESS | 1638 | |2;jquery.html;327.54471284913967;358.4873630708088;359.24379181822263;370.4572800846759;383.7352226963395;18239.088045597717;18828.152733127008;19782.505437364074;19869.801301986976;20037.899810500927;18613.906930465328;18873.62252754944;19389.32137375192;19532.511687207825;19541.511462213453;4988.501149885001;5565.193047008182;5782.826515204551;5809.448102430262;5821.53427725781;5440.455954404568;5569.582281328896;5607.551395888319;5651.660900345993;5711.428857114297;5534.723263836792;5563.415841336662;5567.860803479925;5575.330960284771;5584.553235741151;4785.71285722856;5305.469453054702;5659.717014149276;5677.091665333568;5678.375378708339;4872.1473742094995;4891.315215869781;4970.105381031413;4980.228064649985;4981.900361992776;21223.469413264636;23679.526409471713;23930.282091537283;24293.757062429326;24307;2005.2480319880044;2146.806787389127;2333.171724037959;2489.514544663791;2816.549352103674;9628.807423851555;10030.398176109456;10219.591216351337;13448.596542103654;13509.32453377337;1729.5848996240811;1778.5642517583276;1798.9640207195782;1865.7481240032557;1892.829645331913;110702.44648776785;120599.39700301443;121493;125596;125995;8972.590415642015;9001.279897608176;9516.524173791282;9741.659041933499;9888.802223955481;9951.25365597583;11926.46330915111;11958;11979.820302695467;11993;6904.930950690429;7306.415486761046;7386.519876208029;7626.58053807046;7629.046369203849;7820.608969551499;7824.061112666403;7845.411594130349;7947.562884041317;7985.28132468069;3802.866899658499;3804.9048773780323;3806.371948628501;3872.3610604249984;3874.9031274217805;1586.8016497937758;1860.7953125156223;1882.3035476873645;1890.4990177602947;1917.6356492266705;698.179638924262;747.1557140431278;754.5585832288064;788.180292495798;797.6051854332027;17469.65060698804;17575.20911558983;20448;20470.897645511675;20946.685799713017;827.8758186272107;862.7153039496951;867.5575456517222;867.8654808504692;867.9305655547541;9847.852282215772;10090.243231757648;10791.56833726642;10829;10862.674119776419;218890;345416;440350;531157;538230;71531.28468715247;72920.63539682374;101136;122845;127120.09319860209;835.9717547416711;837.6021389839899;838.9412741108185;846.4794151596847;853.7182729699184;15221.467248646688;18111.36997670216;18286.72569911479;18796.342128025455;19039.238430462625;48978.5102148974;50476.74761626315;51906.22140667969;52496;53089.46910530845;70866;71453.642731786;73471.26528734858;73926;74227.14432139239;6246.875062498815;6860.902255639074;7673.232676732506;7831.84336313282;7990.760277191694;8986.68546600866;11868.881311186778;11905.047596192111;12116.091293152873;12541.498340066295;10196.898031019891;10387.740306492398;10409.323393979366;10488.737781555523;10696.03735663794;10163.390196588229;10210.336328138646;10228.28402011852;10299.3820370778;10509.894901051197;10019.098281154731;10148.188144948239;10152.49237538135;10550.788984220426;10775.407352595683;7826.178251283533;7856.489328193649;7925.801854953672;7982.201779821971;8113.878291825509;8355.916440835757;10211;10388.117010053928;10486.685399438029;10508.737281568023 10:11:53 INFO - PROCESS | 1638 | |3;mootools.html;1254.6298841841656;1399.839018512871;1410.0975375759513;1506.7664512000638;1728.9827101728986;7170.641467926609;7177.856442871146;7624.504407213534;8046.5976701164855;8060.435769496137;7958.045034595857;8044.115147333789;8046.15515370885;8052.355811535078;8060.073091594469;1763.9063780456136;2100.8109270165683;2233.419310979141;2245.7305123385217;2249.9437514062115;2241.8430709850318;2277.4989502309463;2292.495650956795;2299.7125359330084;2305.804006659436;2231.129859354845;2247.73027236731;2267.761885002076;2268.3648578398074;2270.5231901300745;2201.1745595401726;2221.1892659179366;2238.1383167480476;2240.4846885216493;2255.1994042115057;2221.244776775904;2238.7686772275347;2240.462289050616;2247.3033359658557;2251.4934139818574;7934.9603251983945;7988.562058829467;8128.187181281824;8131.959340203321;8234.258916697467;4909.803607855682;5049.899002019975;5057.393112826448;5060.139776238011;5068.72122033288;3238.8056716596843;3369.713574346159;3416.1288871337897;3446.276281980787;3453.205762674599;1051.9526621301984;1072.3780207479642;1663.5009497150807;1689.9606741853795;1776.6801975644378;10605.787884242272;10686.305390149615;10705.571777128984;10707.411092389915;10724;3584.9103772405897;3648.288583726201;4552.840650577214;4599.5400459953735;4657.787550913356;8449.493030418073;8507.27688146502;8533.402661813738;8534.530600817016;8554.101819309008;4983.700977941335;5006.74966251686;5013.5989120870245;5019.02129084825;5020.447750747415;4562.543745625478;4589.426321709786;4601.194790911577;4698.436187657435;4708.317293992352;2958;3350.5141754445467;3414.129397003748;3480.599731030964;3491.6682915123024;992.6672320047829;1001.3040936549174;1006.1900170362782;1006.4162785584343;1010.0858722855827;773.1649818196335;774.4385320642489;797.366093955307;800.8958835351483;810.6716779704229;5112;5254.5533629641905;5396.08266594672;5424.484673955968;5464.9453505464435;384.0150015210975;389.77393111994974;407.0190840075404;419.97270177438367;420.15339091730186;3537.5224344713133;3629.927401451956;3797.2785170817456;3836.1368692044066;3872.3610604249984;9304.302177336727;9808.754781130528;9853.211743060538;9931.950340248397;9970.401775893324;9910.900890991143;9935.801283974424;9948.80102397948;9967.700968970943;9972.551235194434;7181.676824542908;7593.810154746176;7671.808204794925;7681.539107653559;7688.154303026663;5343.198520221842;5356.437574054668;5430.592705547178;5568.526675232651;5651.321841379061;7016;8787.209151176425;9047.909520904706;9204.079592040742;9219.44683319003;7179.892301615584;8992.730218093468;9226.215771659485;9231.953840231025;9357.438553686801;5742.626729262584;7100.715971361088;7113.755092858625;7118.893216601651;7119.928800711927;7506.1743208248145;7526.924730752622;7537.9623101884135;7595.088589369311;7630.847383052419;6689.966550167413;6766.661666916733;6827.146606674166;6839.213490448662;6875.931240687729;5711.771529138788;6659.234188068241;6723.831904202434;6733.730650773914;6760.459163267025;6369.948958421994;6524.119243902012;6538.542302038812;6558.8360290993105;6566.573172743756;3903;4596.655250856133;4668.626509879269;4704.176769065469;4796.8081276748535;4592.242280023758;4621.3299071633755;4772.236442169236;4798.592119669867;4877.853664390074 10:11:53 INFO - PROCESS | 1638 | |4;prototype.html;278.45561926433817;284.25383368657276;287.8805295802242;290.7209079283886;294.2276524124174;3724.9756317012766;4036.596340365962;4068.4507591475144;4069.7354671946305;4099.733517321372;3750.381187104131;4062.553119156898;4068.5759984005585;4086.6117718816663;4088.3867419887033;3003.564483149942;3090.18110200797;3153.3377990622;3172.619285685721;3235.7896736712155;2944.6024786653743;3162.5888634477487;3218.0667606394236;3226.790258633181;3270.394976929276;3165.493521036635;3180.5706229659045;3190.7606929480266;3199.2481766784786;3207.951880721791;2732.4808286425614;3032.438998785232;3063.5251536011733;3160.920976975571;3226.661200573953;2458.360826185187;2627.4745050989686;2865.498537755905;2873.339131999631;2874.037197538827;3129.640091389497;3886.5813977898147;3899.98050009751;3933.193695292458;3933.8623148189963;3062.6784187660196;3071.616047994001;3740;3743.7566558173903;3752.4746535485056;3610.3862343401424;4358.3244597087505;4387.561243875619;4407.193050849137;4436.334549817521;3218.4206842768294;3239.4816829307433;3251.9674803252137;3254.67453254675;3259.5273685315497;3676.9080772980624;4554.2257816170995;4583.74789386587;4602.84928767808;4622.468416132154;3018.5321275202377;3124.7657175415584;3297.86808527661;3301.5873015873017;3318.8008719476907;2741.821781584191;3005.63932328122;3210.3900258950725;3341.7134403254922;3343.431616625131;3681.650243226889;3683.8710645127826;3689.520362352877;3702.5927148013698;3718.4236443351324;3421.5894092709036;3536.504889315498;4396.384506169139;4400.361947517592;4419.270820314677;933.7385532051037;1053.773438710681;1062.697131317571;1071.6356438810842;1075.8977897099762;694.3577191098213;708.7519368221082;736.694271877165;744.9925500744923;761.2425636491615;3578.910527236788;3812.980935095307;3849.8075096245075;3856.708002819087;3995.860144894915;3300.5214243934497;4472.798724057425;4538.88652783683;4562.88592785183;4578.764642705484;3786.3373909565717;3800.410936304877;3842.711796615265;4035.4955630546183;4036.313826649418;2103.6844473329124;2140.5504843982626;2201.8220252165015;2209.3482422685347;2217.3791338425267;4058.3912413137673;4102.425660407545;4386.7367957922625;4424.208195680754;4492.415985921809;3865.584009993754;4398.186335527937;4438.6005259526155;4443;4447.266201076786;3882.6505614494267;3982.482277303932;4446.3552784846015;4462.219111655448;4487.326900964881;3572.857085716646;4046.2312160689376;4279.673301276614;4301.333293339538;4576.633869290382;3954.1415534698644;4209.221294060609;4561.270196768501;4582.427196600425;4590.311453282035;4072.165206132795;4210.9683127633925;4585.839495617637;4733.290376075826;4739.549742774431;3120.98439507801;3197.6802319767835;3209.6148462184688;3226.9677303227604;3230.935381292314;3649.635036496329;4518.480374756945;4527.7509736964785;4537.410136682211;4560.270356742905;3580;4322.9135417290845;4469.659102269241;4478.552144785495;4497.640188784824;3728.440733889938;3981.5268350709266;4232.180162530141;4374.518802931739;4455.443069616298;4184.205001049791;4307.08334791015;4356.847510337123;4359.215341238608;4386.276264416463;3933.7443066200603;4070.3690927906223;4427.734335939854;4446.377507149066;4447.843560674312;3328.484084966834;3902.512185976753;4288.91422171561;4331.068820203672;4341.3487976803735 10:11:53 INFO - PROCESS | 1638 | |5;yui.html;714.2143641993806;719.4855678190092;737.9852702534016;760.520871850734;782.1357400072919;13153.27656978867;13766.174029558208;14154.575362739135;14245.857541424582;14363.281835908188;12670.23978561287;13245.602631921034;13443.32783360833;13449.26029068401;13485.528006519773;764.1136281912968;799.460364254129;807.7818988873;810.8013536683492;810.8378324335127;821.1214001018913;825.6738588257634;825.781167990483;827.5407149032285;827.5903427803246;863.568215892054;864.2826454043129;864.6887120636566;868.2142660891872;869.7477731457869;862.9741107766746;863.3481721300409;863.995680021599;864.2826454043192;865.312076898867;609.6037575575867;609.957302988791;626.3798839149255;636.7293900092442;638.4573112854036;11856.05151587871;11888.108391870557;11899.940500297529;11909.642710718692;13252.337383130902;12928.676783080404;13177.86822131776;13192.010599205098;13226.801597975942;13452.5291614793;10616.469176541219;10808.675739727822;11174.888251117465;11181.83227251592;11430.028447581966;3425.9486107708403;3463.0130412832473;3608.1701208722143;3718.958691566366;3737.738358314919;65905.01142482867;87170.12829871684;88016;88184;88326;9354.71935841926;9461.33770636049;9590.520473976274;9645;9787.951060244795;19520.51198720015;19714.605707885763;19761.110750016283;19832.008399579965;19989.700154497696;7149.60677162761;7301.598412087386;7470;7472.551646901204;7509.535640550041;4090.2228576570355;4225.915481690349;4257.169851878916;4299.591538803808;4384.276594361958;3288.605367355885;3396.8980930572125;3404.131946353664;3407.1993081625797;3410.5225268462436;602.9487493563096;605.479287812481;625.5683578330937;626.2391194698372;628.4218518962565;427.9935800962988;466.92996050592;499.78009675742555;542.5144495676426;544.6786396026364;7468.887966680504;7921.1682773307975;8433.358927996336;8714.215720585178;8952.776180595538;513.3659929986463;536.2599612534755;549.6152693114835;559.2059275828334;565.1297002616008;3884.592117827644;4231.555686652919;4237.6821738369745;4268.829246830154;4366.672499562545;74112.88830667545;89215.21569568572;97977;112065;115020.42489787498;66403.66798165978;67989;90995;94609;97884.51057744665;58469.70765146147;82063.7690434644;83597.58201208955;84013.57993210117;84704.57647711845;8587.527685977331;8992.28061755045;9042.773930651787;9101.77245568866;9168.679096231599;49041.50958490512;51832.740836295576;51834.48165518447;52086;53597;70297;70385.29614703992;72789;75261.36585219491;76337;11148.331100134017;11377.54489820398;11481.598144064918;11610;11649.359285239054;12418.565350212699;12536.74926501483;12811.935940320238;12870.292133932724;12872.613821585368;11601.419929003347;11680.532778688757;11795.587154449553;11854.703632409259;11962.222455540363;11363.829542556703;11481.081513479068;11861;11927.940360298144;11973.161878668758;9033.728988130366;11122.666320010412;11701.707457313636;11739.941300293785;11939.52241910314;9635.855462168212;9992.750181245527;10027.22029529279;10711;10964.232503724663;9782.853257201004;10448.58205671795;10491.055804977588;10496.68509944703;10519.26365154432 10:11:53 INFO - PROCESS | 1638 | __end_tp_report 10:11:53 INFO - PROCESS | 1638 | __start_cc_report 10:11:53 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1427 10:11:53 INFO - PROCESS | 1638 | __end_cc_report 10:11:53 INFO - PROCESS | 1638 | __startTimestamp1486750313275__endTimestamp 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:11:53 INFO - PROCESS | 1638 | Number of tests: 6 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5087.21 Median:5275.66 stddev:584.94 (11.1%) stddev-sans-first:563.02 10:11:53 INFO - PROCESS | 1638 | Values: 2985.2 2998.1 3051.8 3053.8 3100.5 4860.3 4984.1 5042.4 5065.3 5068.8 4281.7 5008.3 5008.8 5032.9 5054.3 4540.9 4547.2 4605.2 4637.0 4668.7 4497.9 4512.6 4579.1 4601.2 4631.4 4259.9 4288.2 4539.6 4636.7 4678.0 4651.4 4668.3 4673.9 4688.5 4706.6 4460.0 4541.5 4635.7 4636.2 4638.2 4859.4 4970.8 4973.4 5008.3 5077.7 5368.5 5450.7 5460.4 5525.9 5553.8 5581.1 5596.9 5632.8 5644.0 5657.9 5016.6 5113.1 5120.1 5172.5 5201.1 5677.5 5679.5 5738.3 5796.5 5802.4 5468.4 5475.8 5480.5 5484.8 5486.0 5358.9 5624.8 5642.0 5654.4 5675.5 5379.9 5476.1 5506.5 5512.6 5521.5 5412.8 5435.5 5499.3 5504.5 5513.4 4479.0 4504.9 4526.5 4553.2 4566.0 4016.9 4022.5 4026.1 4032.9 4059.1 3977.3 5039.9 5047.4 5064.0 5102.5 5322.7 5405.0 5408.8 5484.9 5523.3 5037.2 5041.4 5044.5 5055.5 5065.3 4856.2 4870.7 4881.2 4888.0 4898.0 5644.0 5802.1 5811.8 5827.4 5835.1 5458.2 5465.5 5518.1 5521.3 5542.8 5688.0 5862.4 5878.1 5888.1 5899.3 5340.6 5358.7 5461.5 5497.7 5500.5 3915.4 5393.4 5401.5 5417.8 5529.3 5365.9 5377.9 5385.5 5403.9 5410.9 5363.6 5383.9 5387.4 5396.6 5437.1 5082.4 5152.6 5176.8 5264.9 5274.1 5275.7 5359.8 5370.4 5427.9 5434.7 5269.9 5284.3 5289.7 5307.5 5334.4 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:64912.18 Median:34262.24 stddev:145637.03 (425.1%) stddev-sans-first:145965.18 10:11:53 INFO - PROCESS | 1638 | Values: 458.4 471.2 481.9 510.0 546.8 36458.1 38520.4 38563.6 38595.8 38606.0 37979.0 38351.0 38375.8 38532.8 38556.8 8146.9 8735.7 9115.9 9347.0 11319.3 11280.8 11391.8 11399.0 11399.9 11424.3 11411.0 11420.5 11426.8 11431.2 11481.7 11314.2 11383.0 11405.5 11423.0 11451.6 11234.8 11285.2 11293.9 11332.0 11335.7 34285.8 34833.3 37719.0 38153.8 38209.0 2804.5 3003.8 3022.9 3269.3 3444.0 27815.0 27951.9 28926.0 30268.7 30315.4 2510.8 3114.3 3117.7 3246.2 3322.3 419386.0 423228.0 425562.0 425869.0 426120.9 32214.2 54196.2 54520.7 54575.9 54678.5 32380.2 34083.3 34216.8 34238.7 34312.7 13783.3 13877.9 13896.2 13935.9 13952.7 10622.5 10867.7 11421.8 11692.2 11742.8 7562.5 7567.4 7630.8 7633.2 7642.4 3126.5 3141.6 3175.3 3207.6 3244.7 680.9 759.4 849.7 910.3 982.7 28300.7 28337.4 28722.0 28874.0 29180.4 788.5 898.6 924.4 1028.4 1047.9 14239.6 14805.5 15162.2 15223.4 15466.8 649190.0 654640.0 654817.0 656892.0 657093.7 52777.7 52821.0 54095.7 54572.6 54657.0 986.9 1145.5 1186.2 1279.4 1321.3 28615.0 29780.0 30189.5 30621.5 30642.0 44959.8 45511.5 45594.8 45603.0 45640.5 467939.0 536001.0 542079.0 542890.3 543286.0 23099.7 25520.5 25524.7 25532.9 25551.2 44185.8 44336.6 44467.8 44600.0 44769.8 31016.2 35428.6 35902.0 36211.1 36361.1 28501.7 34588.8 34732.7 35098.9 35458.8 36322.3 36704.8 36749.4 36763.0 37011.6 31303.4 32206.5 32598.8 34459.7 34485.8 24310.8 24374.3 24523.0 24699.5 24939.0 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:28442.12 Median:3805.64 stddev:73587.90 (1933.7%) stddev-sans-first:73764.06 10:11:53 INFO - PROCESS | 1638 | Values: 327.5 358.5 359.2 370.5 383.7 18239.1 18828.2 19782.5 19869.8 20037.9 18613.9 18873.6 19389.3 19532.5 19541.5 4988.5 5565.2 5782.8 5809.4 5821.5 5440.5 5569.6 5607.6 5651.7 5711.4 5534.7 5563.4 5567.9 5575.3 5584.6 4785.7 5305.5 5659.7 5677.1 5678.4 4872.1 4891.3 4970.1 4980.2 4981.9 21223.5 23679.5 23930.3 24293.8 24307.0 2005.2 2146.8 2333.2 2489.5 2816.5 9628.8 10030.4 10219.6 13448.6 13509.3 1729.6 1778.6 1799.0 1865.7 1892.8 110702.4 120599.4 121493.0 125596.0 125995.0 8972.6 9001.3 9516.5 9741.7 9888.8 9951.3 11926.5 11958.0 11979.8 11993.0 6904.9 7306.4 7386.5 7626.6 7629.0 7820.6 7824.1 7845.4 7947.6 7985.3 3802.9 3804.9 3806.4 3872.4 3874.9 1586.8 1860.8 1882.3 1890.5 1917.6 698.2 747.2 754.6 788.2 797.6 17469.7 17575.2 20448.0 20470.9 20946.7 827.9 862.7 867.6 867.9 867.9 9847.9 10090.2 10791.6 10829.0 10862.7 218890.0 345416.0 440350.0 531157.0 538230.0 71531.3 72920.6 101136.0 122845.0 127120.1 836.0 837.6 838.9 846.5 853.7 15221.5 18111.4 18286.7 18796.3 19039.2 48978.5 50476.7 51906.2 52496.0 53089.5 70866.0 71453.6 73471.3 73926.0 74227.1 6246.9 6860.9 7673.2 7831.8 7990.8 8986.7 11868.9 11905.0 12116.1 12541.5 10196.9 10387.7 10409.3 10488.7 10696.0 10163.4 10210.3 10228.3 10299.4 10509.9 10019.1 10148.2 10152.5 10550.8 10775.4 7826.2 7856.5 7925.8 7982.2 8113.9 8355.9 10211.0 10388.1 10486.7 10508.7 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5209.50 Median:5053.65 stddev:2882.84 (57.0%) stddev-sans-first:2875.61 10:11:53 INFO - PROCESS | 1638 | Values: 1254.6 1399.8 1410.1 1506.8 1729.0 7170.6 7177.9 7624.5 8046.6 8060.4 7958.0 8044.1 8046.2 8052.4 8060.1 1763.9 2100.8 2233.4 2245.7 2249.9 2241.8 2277.5 2292.5 2299.7 2305.8 2231.1 2247.7 2267.8 2268.4 2270.5 2201.2 2221.2 2238.1 2240.5 2255.2 2221.2 2238.8 2240.5 2247.3 2251.5 7935.0 7988.6 8128.2 8132.0 8234.3 4909.8 5049.9 5057.4 5060.1 5068.7 3238.8 3369.7 3416.1 3446.3 3453.2 1052.0 1072.4 1663.5 1690.0 1776.7 10605.8 10686.3 10705.6 10707.4 10724.0 3584.9 3648.3 4552.8 4599.5 4657.8 8449.5 8507.3 8533.4 8534.5 8554.1 4983.7 5006.7 5013.6 5019.0 5020.4 4562.5 4589.4 4601.2 4698.4 4708.3 2958.0 3350.5 3414.1 3480.6 3491.7 992.7 1001.3 1006.2 1006.4 1010.1 773.2 774.4 797.4 800.9 810.7 5112.0 5254.6 5396.1 5424.5 5464.9 384.0 389.8 407.0 420.0 420.2 3537.5 3629.9 3797.3 3836.1 3872.4 9304.3 9808.8 9853.2 9932.0 9970.4 9910.9 9935.8 9948.8 9967.7 9972.6 7181.7 7593.8 7671.8 7681.5 7688.2 5343.2 5356.4 5430.6 5568.5 5651.3 7016.0 8787.2 9047.9 9204.1 9219.4 7179.9 8992.7 9226.2 9232.0 9357.4 5742.6 7100.7 7113.8 7118.9 7119.9 7506.2 7526.9 7538.0 7595.1 7630.8 6690.0 6766.7 6827.1 6839.2 6875.9 5711.8 6659.2 6723.8 6733.7 6760.5 6369.9 6524.1 6538.5 6558.8 6566.6 3903.0 4596.7 4668.6 4704.2 4796.8 4592.2 4621.3 4772.2 4798.6 4877.9 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:3532.85 Median:3884.62 stddev:1054.39 (27.1%) stddev-sans-first:1028.67 10:11:53 INFO - PROCESS | 1638 | Values: 278.5 284.3 287.9 290.7 294.2 3725.0 4036.6 4068.5 4069.7 4099.7 3750.4 4062.6 4068.6 4086.6 4088.4 3003.6 3090.2 3153.3 3172.6 3235.8 2944.6 3162.6 3218.1 3226.8 3270.4 3165.5 3180.6 3190.8 3199.2 3208.0 2732.5 3032.4 3063.5 3160.9 3226.7 2458.4 2627.5 2865.5 2873.3 2874.0 3129.6 3886.6 3900.0 3933.2 3933.9 3062.7 3071.6 3740.0 3743.8 3752.5 3610.4 4358.3 4387.6 4407.2 4436.3 3218.4 3239.5 3252.0 3254.7 3259.5 3676.9 4554.2 4583.7 4602.8 4622.5 3018.5 3124.8 3297.9 3301.6 3318.8 2741.8 3005.6 3210.4 3341.7 3343.4 3681.7 3683.9 3689.5 3702.6 3718.4 3421.6 3536.5 4396.4 4400.4 4419.3 933.7 1053.8 1062.7 1071.6 1075.9 694.4 708.8 736.7 745.0 761.2 3578.9 3813.0 3849.8 3856.7 3995.9 3300.5 4472.8 4538.9 4562.9 4578.8 3786.3 3800.4 3842.7 4035.5 4036.3 2103.7 2140.6 2201.8 2209.3 2217.4 4058.4 4102.4 4386.7 4424.2 4492.4 3865.6 4398.2 4438.6 4443.0 4447.3 3882.7 3982.5 4446.4 4462.2 4487.3 3572.9 4046.2 4279.7 4301.3 4576.6 3954.1 4209.2 4561.3 4582.4 4590.3 4072.2 4211.0 4585.8 4733.3 4739.5 3121.0 3197.7 3209.6 3227.0 3230.9 3649.6 4518.5 4527.8 4537.4 4560.3 3580.0 4322.9 4469.7 4478.6 4497.6 3728.4 3981.5 4232.2 4374.5 4455.4 4184.2 4307.1 4356.8 4359.2 4386.3 3933.7 4070.4 4427.7 4446.4 4447.8 3328.5 3902.5 4288.9 4331.1 4341.3 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19077.75 Median:52841.50 stddev:27788.39 (52.6%) stddev-sans-first:27832.14 10:11:53 INFO - PROCESS | 1638 | Values: 714.2 719.5 738.0 760.5 782.1 13153.3 13766.2 14154.6 14245.9 14363.3 12670.2 13245.6 13443.3 13449.3 13485.5 764.1 799.5 807.8 810.8 810.8 821.1 825.7 825.8 827.5 827.6 863.6 864.3 864.7 868.2 869.7 863.0 863.3 864.0 864.3 865.3 609.6 610.0 626.4 636.7 638.5 11856.1 11888.1 11899.9 11909.6 13252.3 12928.7 13177.9 13192.0 13226.8 13452.5 10616.5 10808.7 11174.9 11181.8 11430.0 3425.9 3463.0 3608.2 3719.0 3737.7 65905.0 87170.1 88016.0 88184.0 88326.0 9354.7 9461.3 9590.5 9645.0 9788.0 19520.5 19714.6 19761.1 19832.0 19989.7 7149.6 7301.6 7470.0 7472.6 7509.5 4090.2 4225.9 4257.2 4299.6 4384.3 3288.6 3396.9 3404.1 3407.2 3410.5 602.9 605.5 625.6 626.2 628.4 428.0 466.9 499.8 542.5 544.7 7468.9 7921.2 8433.4 8714.2 8952.8 513.4 536.3 549.6 559.2 565.1 3884.6 4231.6 4237.7 4268.8 4366.7 74112.9 89215.2 97977.0 112065.0 115020.4 66403.7 67989.0 90995.0 94609.0 97884.5 58469.7 82063.8 83597.6 84013.6 84704.6 8587.5 8992.3 9042.8 9101.8 9168.7 49041.5 51832.7 51834.5 52086.0 53597.0 70297.0 70385.3 72789.0 75261.4 76337.0 11148.3 11377.5 11481.6 11610.0 11649.4 12418.6 12536.7 12811.9 12870.3 12872.6 11601.4 11680.5 11795.6 11854.7 11962.2 11363.8 11481.1 11861.0 11927.9 11973.2 9033.7 11122.7 11701.7 11739.9 11939.5 9635.9 9992.8 10027.2 10711.0 10964.2 9782.9 10448.6 10491.1 10496.7 10519.3 10:11:53 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:11:53 INFO - PROCESS | 1638 | 10:11:53 INFO - TEST-INFO | 1638: exit 0 10:11:53 INFO - TEST-OK | dromaeo_css | took 1116781ms 10:11:53 INFO - TEST-START | kraken 10:11:53 INFO - operating with platform_type : mac_ 10:11:53 INFO - Initialising browser for kraken test... 10:11:53 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpschJGf/profile http://localhost:49240/getInfo.html) 10:11:56 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:11:56 INFO - PROCESS | 1646 | colorDepth:24 10:11:56 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:11:56 INFO - PROCESS | 1646 | __metrics 10:11:56 INFO - PROCESS | 1646 | 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" 10:11:56 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:57 INFO - TEST-INFO | 1646: exit 0 10:11:57 INFO - Browser initialized. 10:11:57 INFO - Running cycle 1/1 for kraken test... 10:11:57 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpschJGf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:09 INFO - PROCESS | 1648 | RSS: Main: 167858176 10:12:09 INFO - PROCESS | 1648 | 10:12:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:13 INFO - PROCESS | 1648 | RSS: Main: 218165248 10:12:13 INFO - PROCESS | 1648 | 10:12:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 10:12:16 INFO - PROCESS | 1648 | RSS: Main: 231567360 10:12:16 INFO - PROCESS | 1648 | 10:12:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 10:12:20 INFO - PROCESS | 1648 | RSS: Main: 327819264 10:12:20 INFO - PROCESS | 1648 | 10:12:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 10:12:23 INFO - PROCESS | 1648 | RSS: Main: 231694336 10:12:23 INFO - PROCESS | 1648 | 10:12:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:26 INFO - PROCESS | 1648 | RSS: Main: 233959424 10:12:26 INFO - PROCESS | 1648 | 10:12:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:29 INFO - PROCESS | 1648 | RSS: Main: 273915904 10:12:29 INFO - PROCESS | 1648 | 10:12:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:33 INFO - PROCESS | 1648 | RSS: Main: 274849792 10:12:33 INFO - PROCESS | 1648 | 10:12:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 10:12:37 INFO - PROCESS | 1648 | RSS: Main: 270438400 10:12:37 INFO - PROCESS | 1648 | 10:12:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:39 INFO - PROCESS | 1648 | RSS: Main: 247545856 10:12:39 INFO - PROCESS | 1648 | 10:12:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:41 INFO - PROCESS | 1648 | RSS: Main: 249155584 10:12:41 INFO - PROCESS | 1648 | 10:12:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:44 INFO - PROCESS | 1648 | RSS: Main: 252215296 10:12:44 INFO - PROCESS | 1648 | 10:12:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:48 INFO - PROCESS | 1648 | RSS: Main: 270540800 10:12:48 INFO - PROCESS | 1648 | 10:12:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:51 INFO - PROCESS | 1648 | RSS: Main: 264245248 10:12:51 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 10:12:53 INFO - PROCESS | 1648 | RSS: Main: 308342784 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | __start_tp_report 10:12:53 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:12:53 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:12:53 INFO - PROCESS | 1648 | |i|pagename|runs| 10:12:53 INFO - PROCESS | 1648 | |0;ai-astar;107;119;120;118;119;118;117;120;119;119 10:12:53 INFO - PROCESS | 1648 | |1;audio-beat-detection;149;112;113;145;119;139;139;112;143;113 10:12:53 INFO - PROCESS | 1648 | |2;audio-dft;210;212;213;211;213;212;211;208;213;210 10:12:53 INFO - PROCESS | 1648 | |3;audio-fft;85;61;60;93;62;61;63;86;112;84 10:12:53 INFO - PROCESS | 1648 | |4;audio-oscillator;109;104;132;105;69;71;90;69;71;93 10:12:53 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;92;90;93;90;93;89;93;91;93;89 10:12:53 INFO - PROCESS | 1648 | |6;imaging-darkroom;99;98;99;99;97;98;99;98;98;98 10:12:53 INFO - PROCESS | 1648 | |7;imaging-desaturate;99;99;98;97;98;104;99;100;99;99 10:12:53 INFO - PROCESS | 1648 | |8;json-parse-financial;54;55;54;56;59;59;58;57;58;58 10:12:53 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;67;75;73;74;78;74;77;74;74;76 10:12:53 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;87;87;83;86;87;85;84;91;108 10:12:53 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;145;144;143;141;145;148;157;157;190;144 10:12:53 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;171;170;170;171;172;172;170;171;170;171 10:12:53 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;69;70;69;68;69;68;69;68;68;68 10:12:53 INFO - PROCESS | 1648 | __end_tp_report 10:12:53 INFO - PROCESS | 1648 | __start_cc_report 10:12:53 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1976 10:12:53 INFO - PROCESS | 1648 | __end_cc_report 10:12:53 INFO - PROCESS | 1648 | __startTimestamp1486750373989__endTimestamp 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:12:53 INFO - PROCESS | 1648 | Number of tests: 14 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:117.60 Median:119.00 stddev:3.84 (3.2%) stddev-sans-first:0.97 10:12:53 INFO - PROCESS | 1648 | Values: 107.0 119.0 120.0 118.0 119.0 118.0 117.0 120.0 119.0 119.0 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:139.00 stddev:15.77 (11.3%) stddev-sans-first:14.86 10:12:53 INFO - PROCESS | 1648 | Values: 149.0 112.0 113.0 145.0 119.0 139.0 139.0 112.0 143.0 113.0 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:211.30 Median:212.00 stddev:1.64 (0.8%) stddev-sans-first:1.67 10:12:53 INFO - PROCESS | 1648 | Values: 210.0 212.0 213.0 211.0 213.0 212.0 211.0 208.0 213.0 210.0 10:12:53 INFO - PROCESS | 1648 | 10:12:53 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:76.70 Median:73.50 stddev:17.94 (24.4%) stddev-sans-first:18.77 10:12:54 INFO - PROCESS | 1648 | Values: 85.0 61.0 60.0 93.0 62.0 61.0 63.0 86.0 112.0 84.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:70.00 stddev:21.45 (30.6%) stddev-sans-first:21.78 10:12:54 INFO - PROCESS | 1648 | Values: 109.0 104.0 132.0 105.0 69.0 71.0 90.0 69.0 71.0 93.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:92.50 stddev:1.70 (1.8%) stddev-sans-first:1.79 10:12:54 INFO - PROCESS | 1648 | Values: 92.0 90.0 93.0 90.0 93.0 89.0 93.0 91.0 93.0 89.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:98.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:12:54 INFO - PROCESS | 1648 | Values: 99.0 98.0 99.0 99.0 97.0 98.0 99.0 98.0 98.0 98.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:99.20 Median:99.00 stddev:1.87 (1.9%) stddev-sans-first:1.99 10:12:54 INFO - PROCESS | 1648 | Values: 99.0 99.0 98.0 97.0 98.0 104.0 99.0 100.0 99.0 99.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:58.00 stddev:1.93 (3.3%) stddev-sans-first:1.76 10:12:54 INFO - PROCESS | 1648 | Values: 54.0 55.0 54.0 56.0 59.0 59.0 58.0 57.0 58.0 58.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:74.50 stddev:2.97 (4.0%) stddev-sans-first:1.66 10:12:54 INFO - PROCESS | 1648 | Values: 67.0 75.0 73.0 74.0 78.0 74.0 77.0 74.0 74.0 76.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.00 stddev:7.18 (8.3%) stddev-sans-first:7.60 10:12:54 INFO - PROCESS | 1648 | Values: 87.0 87.0 87.0 83.0 86.0 87.0 85.0 84.0 91.0 108.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:146.50 stddev:14.66 (10.0%) stddev-sans-first:15.37 10:12:54 INFO - PROCESS | 1648 | Values: 145.0 144.0 143.0 141.0 145.0 148.0 157.0 157.0 190.0 144.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:12:54 INFO - PROCESS | 1648 | Values: 171.0 170.0 170.0 171.0 172.0 172.0 170.0 171.0 170.0 171.0 10:12:54 INFO - PROCESS | 1648 | 10:12:54 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 10:12:54 INFO - PROCESS | 1648 | Values: 69.0 70.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 10:12:54 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:12:54 INFO - PROCESS | 1648 | 10:12:55 INFO - TEST-INFO | 1648: exit 0 10:12:55 INFO - TEST-OK | kraken | took 61178ms 10:12:55 INFO - SUITE-END | took 1177s 10:12:55 INFO - Completed test suite (00:19:38) 10:12:55 INFO - javascript benchmark 10:12:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.2089196362963, 2998.1305421427787, 3051.816890986541, 3053.7709671774624, 3100.488419410797, 4860.295257187715, 4984.053029924312, 5042.420121686007, 5065.33665835411, 5068.797248110071, 4281.7002809803325, 5008.323876276701, 5008.824691135811, 5032.899342013157, 5054.292399064134, 4540.9091818163615, 4547.158775626512, 4605.171069207541, 4636.97681511592, 4668.696534725249, 4497.9325310120375, 4512.616427603658, 4579.129965306598, 4601.171789077965, 4631.3516107744945, 4259.893502662443, 4288.16380805743, 4539.59143677069, 4636.652251081166, 4677.976610116944, 4651.395318608559, 4668.253079507263, 4673.906521869578, 4688.484266730657, 4706.599939005188, 4459.955400445986, 4541.45502539694, 4635.745034023127, 4636.235021221494, 4638.234691275936, 4859.441164266119, 4970.826021089245, 4973.378327709036, 5008.348914641109, 5077.695338279715, 5368.516833485005, 5450.700211488366, 5460.372057213432, 5525.889482210333, 5553.7778488860395, 5581.079121944874, 5596.944030559724, 5632.802851900205, 5644.040513112781, 5657.896710141524, 5016.598672106223, 5113.1052065888325, 5120.103981803207, 5172.482751724798, 5201.063808514504, 5677.460641239076, 5679.488846003796, 5738.2540269765495, 5796.5072968797285, 5802.390748971297, 5468.425815289417, 5475.835724928259, 5480.479354461399, 5484.7531861066345, 5485.9725701371235, 5358.866028349323, 5624.803131890364, 5642.0, 5654.434556544395, 5675.489205971482, 5379.919301210485, 5476.069068258326, 5506.531944784738, 5512.641678290978, 5521.475459831309, 5412.783488660488, 5435.483629055233, 5499.257600223998, 5504.4770746778995, 5513.393526712059, 4478.977605111953, 4504.864854054384, 4526.547345265513, 4553.225951588238, 4566.0, 4016.859409920697, 4022.4971878515184, 4026.053877338823, 4032.91934161321, 4059.06641472463, 3977.284088864032, 5039.924401133986, 5047.394312682502, 5063.987202559503, 5102.515261050195, 5322.680639161663, 5405.0, 5408.8377348679605, 5484.945150548443, 5523.337199536081, 5037.194048952223, 5041.395032596112, 5044.470330615306, 5055.469175736568, 5065.341505604248, 4856.223004319292, 4870.707757534559, 4881.170201065827, 4887.975560122177, 4897.9714260005085, 5644.0, 5802.071668533014, 5811.825645230734, 5827.388124246978, 5835.124731290341, 5458.181272809111, 5465.535429488538, 5518.117101263779, 5521.337439507124, 5542.75057622416, 5687.971560142173, 5862.413758624103, 5878.147668588116, 5888.146218798164, 5899.292084949833, 5340.626156169031, 5358.705271210121, 5461.535769459481, 5497.697626630574, 5500.532454741232, 3915.4126880968083, 5393.406725260296, 5401.459854014724, 5417.83746487606, 5529.281193444826, 5365.865853353697, 5377.892442151213, 5385.54222891043, 5403.891922161613, 5410.891782164256, 5363.624546281723, 5383.946160538501, 5387.407385187548, 5396.622236443568, 5437.130059190668, 5082.440931497458, 5152.5877929766275, 5176.792928282826, 5264.868378290574, 5274.050670879278, 5275.657082289639, 5359.758810853599, 5370.382406023201, 5427.864303392446, 5434.728263586726, 5269.920951185812, 5284.286621306074, 5289.709066001406, 5307.4692530746615, 5334.439883812144], "value": 5051.065387920054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.3743190544906, 471.18955396717644, 481.9228923372259, 509.9647715138268, 546.8086169840559, 36458.08854778628, 38520.42219366708, 38563.61436385635, 38595.80702096492, 38606.0, 37979.0, 38351.0, 38375.808120959424, 38532.80733596335, 38556.80721596388, 8146.918530814705, 8735.737927862143, 9115.908840911588, 9347.0, 11319.320840749582, 11280.830787538194, 11391.772164556704, 11398.974092331688, 11399.886001140007, 11424.257423267503, 11411.0, 11420.54317827286, 11426.828597571042, 11431.199816012882, 11481.655550333462, 11314.151438642093, 11383.0, 11405.486753096131, 11423.0, 11451.59919402817, 11234.831477527843, 11285.210035297532, 11293.943530282379, 11331.980121789078, 11335.659930202108, 34285.82857085724, 34833.303333933436, 37719.0, 38153.80923095394, 38209.0, 2804.5372513535444, 3003.7634274605457, 3022.926860964348, 3269.264415506492, 3443.9827800860835, 27815.0, 27951.86024069887, 28925.987590434444, 30268.69731302681, 30315.393692126254, 2510.836795608298, 3114.2837147455984, 3117.719405253538, 3246.204679853451, 3322.3355328934067, 419386.0, 423228.0, 425562.0, 425869.0, 426120.8693956541, 32214.19464513359, 54196.187057194176, 54520.72739636277, 54575.90848183014, 54678.45321546813, 32380.190495237337, 34083.318333633186, 34216.82891585526, 34238.657613423544, 34312.65687343095, 13783.310834458238, 13877.88976881847, 13896.16623002623, 13935.860641393456, 13952.720945581032, 10622.521986510472, 10867.728306792393, 11421.828672569918, 11692.181547291608, 11742.765144697229, 7562.546247225184, 7567.356774674215, 7630.8092297693, 7633.2366763324335, 7642.426817988673, 3126.5466507356305, 3141.638711548201, 3175.301433684586, 3207.566978457925, 3244.659310772382, 680.9445359692456, 759.3621358059256, 849.7280870121501, 910.2626872233512, 982.6757170133839, 28300.71699283022, 28337.433251334856, 28722.0, 28874.0, 29180.416391672046, 788.5347644889428, 898.6046139698511, 924.4176169013613, 1028.4240825137947, 1047.9056884880397, 14239.644008899653, 14805.481808136663, 15162.166080865438, 15223.391064357302, 15466.845331546765, 649190.0, 654640.0, 654817.0, 656892.0, 657093.7145314243, 52777.736111319195, 52821.0, 54095.72952135214, 54572.635684108216, 54657.0, 986.8519722041751, 1145.4559084434993, 1186.15190139051, 1279.4178648714812, 1321.3393303348325, 28614.998475053275, 29780.0, 30189.547156793105, 30621.540676889417, 30642.0, 44959.77520112378, 45511.54488455073, 45594.77202613965, 45603.0, 45640.54359456363, 467939.0, 536001.0, 542079.0, 542890.2855485698, 543286.0, 23099.65350519777, 25520.489590208465, 25524.74475255298, 25532.872335638203, 25551.23346299614, 44185.779071104436, 44336.55663443324, 44467.77766111149, 44600.0, 44769.776151120335, 31016.22459438532, 35428.64571354254, 35902.0, 36211.09472263109, 36361.09097272589, 28501.717422715614, 34588.82705586456, 34732.65267347294, 35098.947031588075, 35458.75894343686, 36322.273554528234, 36704.81647591745, 36749.44875826918, 36763.0, 37011.6333131689, 31303.373932521677, 32206.516902246018, 32598.837005814818, 34459.655403446646, 34485.827570861984, 24310.75689243085, 24374.26877193687, 24523.0, 24699.50600988006, 24939.0], "value": 17885.824297650506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.54471284913967, 358.4873630708088, 359.24379181822263, 370.4572800846759, 383.7352226963395, 18239.088045597717, 18828.152733127008, 19782.505437364074, 19869.801301986976, 20037.899810500927, 18613.906930465328, 18873.62252754944, 19389.32137375192, 19532.511687207825, 19541.511462213453, 4988.501149885001, 5565.193047008182, 5782.826515204551, 5809.448102430262, 5821.53427725781, 5440.455954404568, 5569.582281328896, 5607.551395888319, 5651.660900345993, 5711.428857114297, 5534.723263836792, 5563.415841336662, 5567.860803479925, 5575.330960284771, 5584.553235741151, 4785.71285722856, 5305.469453054702, 5659.717014149276, 5677.091665333568, 5678.375378708339, 4872.1473742094995, 4891.315215869781, 4970.105381031413, 4980.228064649985, 4981.900361992776, 21223.469413264636, 23679.526409471713, 23930.282091537283, 24293.757062429326, 24307.0, 2005.2480319880044, 2146.806787389127, 2333.171724037959, 2489.514544663791, 2816.549352103674, 9628.807423851555, 10030.398176109456, 10219.591216351337, 13448.596542103654, 13509.32453377337, 1729.5848996240811, 1778.5642517583276, 1798.9640207195782, 1865.7481240032557, 1892.829645331913, 110702.44648776785, 120599.39700301443, 121493.0, 125596.0, 125995.0, 8972.590415642015, 9001.279897608176, 9516.524173791282, 9741.659041933499, 9888.802223955481, 9951.25365597583, 11926.46330915111, 11958.0, 11979.820302695467, 11993.0, 6904.930950690429, 7306.415486761046, 7386.519876208029, 7626.58053807046, 7629.046369203849, 7820.608969551499, 7824.061112666403, 7845.411594130349, 7947.562884041317, 7985.28132468069, 3802.866899658499, 3804.9048773780323, 3806.371948628501, 3872.3610604249984, 3874.9031274217805, 1586.8016497937758, 1860.7953125156223, 1882.3035476873645, 1890.4990177602947, 1917.6356492266705, 698.179638924262, 747.1557140431278, 754.5585832288064, 788.180292495798, 797.6051854332027, 17469.65060698804, 17575.20911558983, 20448.0, 20470.897645511675, 20946.685799713017, 827.8758186272107, 862.7153039496951, 867.5575456517222, 867.8654808504692, 867.9305655547541, 9847.852282215772, 10090.243231757648, 10791.56833726642, 10829.0, 10862.674119776419, 218890.0, 345416.0, 440350.0, 531157.0, 538230.0, 71531.28468715247, 72920.63539682374, 101136.0, 122845.0, 127120.09319860209, 835.9717547416711, 837.6021389839899, 838.9412741108185, 846.4794151596847, 853.7182729699184, 15221.467248646688, 18111.36997670216, 18286.72569911479, 18796.342128025455, 19039.238430462625, 48978.5102148974, 50476.74761626315, 51906.22140667969, 52496.0, 53089.46910530845, 70866.0, 71453.642731786, 73471.26528734858, 73926.0, 74227.14432139239, 6246.875062498815, 6860.902255639074, 7673.232676732506, 7831.84336313282, 7990.760277191694, 8986.68546600866, 11868.881311186778, 11905.047596192111, 12116.091293152873, 12541.498340066295, 10196.898031019891, 10387.740306492398, 10409.323393979366, 10488.737781555523, 10696.03735663794, 10163.390196588229, 10210.336328138646, 10228.28402011852, 10299.3820370778, 10509.894901051197, 10019.098281154731, 10148.188144948239, 10152.49237538135, 10550.788984220426, 10775.407352595683, 7826.178251283533, 7856.489328193649, 7925.801854953672, 7982.201779821971, 8113.878291825509, 8355.916440835757, 10211.0, 10388.117010053928, 10486.685399438029, 10508.737281568023], "value": 8765.14082637547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.6298841841656, 1399.839018512871, 1410.0975375759513, 1506.7664512000638, 1728.9827101728986, 7170.641467926609, 7177.856442871146, 7624.504407213534, 8046.5976701164855, 8060.435769496137, 7958.045034595857, 8044.115147333789, 8046.15515370885, 8052.355811535078, 8060.073091594469, 1763.9063780456136, 2100.8109270165683, 2233.419310979141, 2245.7305123385217, 2249.9437514062115, 2241.8430709850318, 2277.4989502309463, 2292.495650956795, 2299.7125359330084, 2305.804006659436, 2231.129859354845, 2247.73027236731, 2267.761885002076, 2268.3648578398074, 2270.5231901300745, 2201.1745595401726, 2221.1892659179366, 2238.1383167480476, 2240.4846885216493, 2255.1994042115057, 2221.244776775904, 2238.7686772275347, 2240.462289050616, 2247.3033359658557, 2251.4934139818574, 7934.9603251983945, 7988.562058829467, 8128.187181281824, 8131.959340203321, 8234.258916697467, 4909.803607855682, 5049.899002019975, 5057.393112826448, 5060.139776238011, 5068.72122033288, 3238.8056716596843, 3369.713574346159, 3416.1288871337897, 3446.276281980787, 3453.205762674599, 1051.9526621301984, 1072.3780207479642, 1663.5009497150807, 1689.9606741853795, 1776.6801975644378, 10605.787884242272, 10686.305390149615, 10705.571777128984, 10707.411092389915, 10724.0, 3584.9103772405897, 3648.288583726201, 4552.840650577214, 4599.5400459953735, 4657.787550913356, 8449.493030418073, 8507.27688146502, 8533.402661813738, 8534.530600817016, 8554.101819309008, 4983.700977941335, 5006.74966251686, 5013.5989120870245, 5019.02129084825, 5020.447750747415, 4562.543745625478, 4589.426321709786, 4601.194790911577, 4698.436187657435, 4708.317293992352, 2958.0, 3350.5141754445467, 3414.129397003748, 3480.599731030964, 3491.6682915123024, 992.6672320047829, 1001.3040936549174, 1006.1900170362782, 1006.4162785584343, 1010.0858722855827, 773.1649818196335, 774.4385320642489, 797.366093955307, 800.8958835351483, 810.6716779704229, 5112.0, 5254.5533629641905, 5396.08266594672, 5424.484673955968, 5464.9453505464435, 384.0150015210975, 389.77393111994974, 407.0190840075404, 419.97270177438367, 420.15339091730186, 3537.5224344713133, 3629.927401451956, 3797.2785170817456, 3836.1368692044066, 3872.3610604249984, 9304.302177336727, 9808.754781130528, 9853.211743060538, 9931.950340248397, 9970.401775893324, 9910.900890991143, 9935.801283974424, 9948.80102397948, 9967.700968970943, 9972.551235194434, 7181.676824542908, 7593.810154746176, 7671.808204794925, 7681.539107653559, 7688.154303026663, 5343.198520221842, 5356.437574054668, 5430.592705547178, 5568.526675232651, 5651.321841379061, 7016.0, 8787.209151176425, 9047.909520904706, 9204.079592040742, 9219.44683319003, 7179.892301615584, 8992.730218093468, 9226.215771659485, 9231.953840231025, 9357.438553686801, 5742.626729262584, 7100.715971361088, 7113.755092858625, 7118.893216601651, 7119.928800711927, 7506.1743208248145, 7526.924730752622, 7537.9623101884135, 7595.088589369311, 7630.847383052419, 6689.966550167413, 6766.661666916733, 6827.146606674166, 6839.213490448662, 6875.931240687729, 5711.771529138788, 6659.234188068241, 6723.831904202434, 6733.730650773914, 6760.459163267025, 6369.948958421994, 6524.119243902012, 6538.542302038812, 6558.8360290993105, 6566.573172743756, 3903.0, 4596.655250856133, 4668.626509879269, 4704.176769065469, 4796.8081276748535, 4592.242280023758, 4621.3299071633755, 4772.236442169236, 4798.592119669867, 4877.853664390074], "value": 4152.477819869326, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.45561926433817, 284.25383368657276, 287.8805295802242, 290.7209079283886, 294.2276524124174, 3724.9756317012766, 4036.596340365962, 4068.4507591475144, 4069.7354671946305, 4099.733517321372, 3750.381187104131, 4062.553119156898, 4068.5759984005585, 4086.6117718816663, 4088.3867419887033, 3003.564483149942, 3090.18110200797, 3153.3377990622, 3172.619285685721, 3235.7896736712155, 2944.6024786653743, 3162.5888634477487, 3218.0667606394236, 3226.790258633181, 3270.394976929276, 3165.493521036635, 3180.5706229659045, 3190.7606929480266, 3199.2481766784786, 3207.951880721791, 2732.4808286425614, 3032.438998785232, 3063.5251536011733, 3160.920976975571, 3226.661200573953, 2458.360826185187, 2627.4745050989686, 2865.498537755905, 2873.339131999631, 2874.037197538827, 3129.640091389497, 3886.5813977898147, 3899.98050009751, 3933.193695292458, 3933.8623148189963, 3062.6784187660196, 3071.616047994001, 3740.0, 3743.7566558173903, 3752.4746535485056, 3610.3862343401424, 4358.3244597087505, 4387.561243875619, 4407.193050849137, 4436.334549817521, 3218.4206842768294, 3239.4816829307433, 3251.9674803252137, 3254.67453254675, 3259.5273685315497, 3676.9080772980624, 4554.2257816170995, 4583.74789386587, 4602.84928767808, 4622.468416132154, 3018.5321275202377, 3124.7657175415584, 3297.86808527661, 3301.5873015873017, 3318.8008719476907, 2741.821781584191, 3005.63932328122, 3210.3900258950725, 3341.7134403254922, 3343.431616625131, 3681.650243226889, 3683.8710645127826, 3689.520362352877, 3702.5927148013698, 3718.4236443351324, 3421.5894092709036, 3536.504889315498, 4396.384506169139, 4400.361947517592, 4419.270820314677, 933.7385532051037, 1053.773438710681, 1062.697131317571, 1071.6356438810842, 1075.8977897099762, 694.3577191098213, 708.7519368221082, 736.694271877165, 744.9925500744923, 761.2425636491615, 3578.910527236788, 3812.980935095307, 3849.8075096245075, 3856.708002819087, 3995.860144894915, 3300.5214243934497, 4472.798724057425, 4538.88652783683, 4562.88592785183, 4578.764642705484, 3786.3373909565717, 3800.410936304877, 3842.711796615265, 4035.4955630546183, 4036.313826649418, 2103.6844473329124, 2140.5504843982626, 2201.8220252165015, 2209.3482422685347, 2217.3791338425267, 4058.3912413137673, 4102.425660407545, 4386.7367957922625, 4424.208195680754, 4492.415985921809, 3865.584009993754, 4398.186335527937, 4438.6005259526155, 4443.0, 4447.266201076786, 3882.6505614494267, 3982.482277303932, 4446.3552784846015, 4462.219111655448, 4487.326900964881, 3572.857085716646, 4046.2312160689376, 4279.673301276614, 4301.333293339538, 4576.633869290382, 3954.1415534698644, 4209.221294060609, 4561.270196768501, 4582.427196600425, 4590.311453282035, 4072.165206132795, 4210.9683127633925, 4585.839495617637, 4733.290376075826, 4739.549742774431, 3120.98439507801, 3197.6802319767835, 3209.6148462184688, 3226.9677303227604, 3230.935381292314, 3649.635036496329, 4518.480374756945, 4527.7509736964785, 4537.410136682211, 4560.270356742905, 3580.0, 4322.9135417290845, 4469.659102269241, 4478.552144785495, 4497.640188784824, 3728.440733889938, 3981.5268350709266, 4232.180162530141, 4374.518802931739, 4455.443069616298, 4184.205001049791, 4307.08334791015, 4356.847510337123, 4359.215341238608, 4386.276264416463, 3933.7443066200603, 4070.3690927906223, 4427.734335939854, 4446.377507149066, 4447.843560674312, 3328.484084966834, 3902.512185976753, 4288.91422171561, 4331.068820203672, 4341.3487976803735], "value": 3214.015124815183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2143641993806, 719.4855678190092, 737.9852702534016, 760.520871850734, 782.1357400072919, 13153.27656978867, 13766.174029558208, 14154.575362739135, 14245.857541424582, 14363.281835908188, 12670.23978561287, 13245.602631921034, 13443.32783360833, 13449.26029068401, 13485.528006519773, 764.1136281912968, 799.460364254129, 807.7818988873, 810.8013536683492, 810.8378324335127, 821.1214001018913, 825.6738588257634, 825.781167990483, 827.5407149032285, 827.5903427803246, 863.568215892054, 864.2826454043129, 864.6887120636566, 868.2142660891872, 869.7477731457869, 862.9741107766746, 863.3481721300409, 863.995680021599, 864.2826454043192, 865.312076898867, 609.6037575575867, 609.957302988791, 626.3798839149255, 636.7293900092442, 638.4573112854036, 11856.05151587871, 11888.108391870557, 11899.940500297529, 11909.642710718692, 13252.337383130902, 12928.676783080404, 13177.86822131776, 13192.010599205098, 13226.801597975942, 13452.5291614793, 10616.469176541219, 10808.675739727822, 11174.888251117465, 11181.83227251592, 11430.028447581966, 3425.9486107708403, 3463.0130412832473, 3608.1701208722143, 3718.958691566366, 3737.738358314919, 65905.01142482867, 87170.12829871684, 88016.0, 88184.0, 88326.0, 9354.71935841926, 9461.33770636049, 9590.520473976274, 9645.0, 9787.951060244795, 19520.51198720015, 19714.605707885763, 19761.110750016283, 19832.008399579965, 19989.700154497696, 7149.60677162761, 7301.598412087386, 7470.0, 7472.551646901204, 7509.535640550041, 4090.2228576570355, 4225.915481690349, 4257.169851878916, 4299.591538803808, 4384.276594361958, 3288.605367355885, 3396.8980930572125, 3404.131946353664, 3407.1993081625797, 3410.5225268462436, 602.9487493563096, 605.479287812481, 625.5683578330937, 626.2391194698372, 628.4218518962565, 427.9935800962988, 466.92996050592, 499.78009675742555, 542.5144495676426, 544.6786396026364, 7468.887966680504, 7921.1682773307975, 8433.358927996336, 8714.215720585178, 8952.776180595538, 513.3659929986463, 536.2599612534755, 549.6152693114835, 559.2059275828334, 565.1297002616008, 3884.592117827644, 4231.555686652919, 4237.6821738369745, 4268.829246830154, 4366.672499562545, 74112.88830667545, 89215.21569568572, 97977.0, 112065.0, 115020.42489787498, 66403.66798165978, 67989.0, 90995.0, 94609.0, 97884.51057744665, 58469.70765146147, 82063.7690434644, 83597.58201208955, 84013.57993210117, 84704.57647711845, 8587.527685977331, 8992.28061755045, 9042.773930651787, 9101.77245568866, 9168.679096231599, 49041.50958490512, 51832.740836295576, 51834.48165518447, 52086.0, 53597.0, 70297.0, 70385.29614703992, 72789.0, 75261.36585219491, 76337.0, 11148.331100134017, 11377.54489820398, 11481.598144064918, 11610.0, 11649.359285239054, 12418.565350212699, 12536.74926501483, 12811.935940320238, 12870.292133932724, 12872.613821585368, 11601.419929003347, 11680.532778688757, 11795.587154449553, 11854.703632409259, 11962.222455540363, 11363.829542556703, 11481.081513479068, 11861.0, 11927.940360298144, 11973.161878668758, 9033.728988130366, 11122.666320010412, 11701.707457313636, 11739.941300293785, 11939.52241910314, 9635.855462168212, 9992.750181245527, 10027.22029529279, 10711.0, 10964.232503724663, 9782.853257201004, 10448.58205671795, 10491.055804977588, 10496.68509944703, 10519.26365154432], "value": 6872.064158161193, "unit": "score"}], "name": "dromaeo_css", "value": 6459.3987857606035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 120.0, 118.0, 119.0, 118.0, 117.0, 120.0, 119.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 112.0, 113.0, 145.0, 119.0, 139.0, 139.0, 112.0, 143.0, 113.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 212.0, 213.0, 211.0, 213.0, 212.0, 211.0, 208.0, 213.0, 210.0], "value": 211.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 60.0, 93.0, 62.0, 61.0, 63.0, 86.0, 112.0, 84.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 132.0, 105.0, 69.0, 71.0, 90.0, 69.0, 71.0, 93.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 93.0, 90.0, 93.0, 89.0, 93.0, 91.0, 93.0, 89.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 99.0, 99.0, 97.0, 98.0, 99.0, 98.0, 98.0, 98.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 97.0, 98.0, 104.0, 99.0, 100.0, 99.0, 99.0], "value": 99.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 56.0, 59.0, 59.0, 58.0, 57.0, 58.0, 58.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 73.0, 74.0, 78.0, 74.0, 77.0, 74.0, 74.0, 76.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 83.0, 86.0, 87.0, 85.0, 84.0, 91.0, 108.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 143.0, 141.0, 145.0, 148.0, 157.0, 157.0, 190.0, 144.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 170.0, 171.0, 172.0, 172.0, 170.0, 171.0, 170.0, 171.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1524.3999999999999, "alertThreshold": 2.0}]} 10:12:55 INFO - Return code: 0 10:12:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:12:55 INFO - # TBPL SUCCESS # 10:12:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:12:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:12:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:12:55 INFO - 2017-02-10 10:12:55.310 screenresolution[1653:10198] starting screenresolution argv=screenresolution get 10:12:55 INFO - 2017-02-10 10:12:55.313 screenresolution[1653:10198] Display 0: 1600x1200x32@60 10:12:55 INFO - 2017-02-10 10:12:55.320 screenresolution[1654:10200] starting screenresolution argv=screenresolution list 10:12:55 INFO - Available Modes on Display 0 10:12:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:12:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:12:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:12:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:12:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:12:55 INFO - Intel Iris: 10:12:55 INFO - Chipset Model: Intel Iris 10:12:55 INFO - Type: GPU 10:12:55 INFO - Bus: Built-In 10:12:55 INFO - VRAM (Dynamic, Max): 1536 MB 10:12:55 INFO - Vendor: Intel (0x8086) 10:12:55 INFO - Device ID: 0x0a2e 10:12:55 INFO - Revision ID: 0x0009 10:12:55 INFO - Displays: 10:12:55 INFO - Display: 10:12:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:12:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:12:55 INFO - Display Serial Number: 1600x1200 60 10:12:55 INFO - Main Display: Yes 10:12:55 INFO - Mirror: Off 10:12:55 INFO - Online: Yes 10:12:55 INFO - Rotation: Supported 10:12:55 INFO - Return code: 0 10:12:55 INFO - Running post-action listener: _resource_record_post_action 10:12:55 INFO - [mozharness: 2017-02-10 18:12:55.572961Z] Finished run-tests step (success) 10:12:55 INFO - Running post-run listener: _resource_record_post_run 10:12:55 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 38282240; Write bytes: 499645952; Read time: 433; Write time: 1586 10:12:55 INFO - TinderboxPrint: CPU usage
53.4% 10:12:55 INFO - TinderboxPrint: I/O read bytes / time
38,282,240 / 433 10:12:55 INFO - TinderboxPrint: I/O write bytes / time
499,645,952 / 1,586 10:12:55 INFO - TinderboxPrint: CPU idle
2,237.6 (46.6%) 10:12:55 INFO - TinderboxPrint: CPU system
966.7 (20.1%) 10:12:55 INFO - TinderboxPrint: CPU user
1,601.5 (33.3%) 10:12:55 INFO - TinderboxPrint: Swap in / out
229,617,664 / 0 10:12:55 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 183249408; Write bytes: 177125376; Read time: 17554; Write time: 354 10:12:55 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 37327872; Write bytes: 305837568; Read time: 418; Write time: 1182 10:12:56 INFO - Running post-run listener: _upload_blobber_files 10:12:56 INFO - Blob upload gear active. 10:12:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:56 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 10:12:56 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:12:56 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:12:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:57 INFO - (blobuploader) - INFO - Done attempting. 10:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:58 INFO - (blobuploader) - INFO - Done attempting. 10:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:00 INFO - (blobuploader) - INFO - Done attempting. 10:13:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:00 INFO - Return code: 0 10:13:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f85a3faf03666dd79e69c1c235d86a5dbb2acf78e107ca6d8d99d8b569540782e61e6b517f2d9b846134bf2278783b58b22d9c45328bd21a6336228733f03d39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09bd926a10346614befa7018f9048fe5ed984c3b9b98d349241499a38d589584323f134697dc7a76cfffe0e61924cb021dad0d522745e10d865f78240ef4cc92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/311e86394cd2dbfecf6077110a2c5fe3c0b6e1c119a3e641173a3dc9dca6a694bd9168f577013cd7c6bb10c10feb50698c4f00f3c7cf311ba11cbae1aedb757d"} 10:13:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:00 INFO - Contents: 10:13:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f85a3faf03666dd79e69c1c235d86a5dbb2acf78e107ca6d8d99d8b569540782e61e6b517f2d9b846134bf2278783b58b22d9c45328bd21a6336228733f03d39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09bd926a10346614befa7018f9048fe5ed984c3b9b98d349241499a38d589584323f134697dc7a76cfffe0e61924cb021dad0d522745e10d865f78240ef4cc92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/311e86394cd2dbfecf6077110a2c5fe3c0b6e1c119a3e641173a3dc9dca6a694bd9168f577013cd7c6bb10c10feb50698c4f00f3c7cf311ba11cbae1aedb757d"} 10:13:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:00 INFO - Copying logs to upload dir... 10:13:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.658767 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-02-10 10:13:00.669348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:13:00.673150) ========= 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.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/Mozilla-Beta/sha512/f85a3faf03666dd79e69c1c235d86a5dbb2acf78e107ca6d8d99d8b569540782e61e6b517f2d9b846134bf2278783b58b22d9c45328bd21a6336228733f03d39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09bd926a10346614befa7018f9048fe5ed984c3b9b98d349241499a38d589584323f134697dc7a76cfffe0e61924cb021dad0d522745e10d865f78240ef4cc92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/311e86394cd2dbfecf6077110a2c5fe3c0b6e1c119a3e641173a3dc9dca6a694bd9168f577013cd7c6bb10c10feb50698c4f00f3c7cf311ba11cbae1aedb757d"} build_url:https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011770 build_url: 'https://queue.taskcluster.net/v1/task/c8nOjYmnTxKBpx_xISZGvQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f85a3faf03666dd79e69c1c235d86a5dbb2acf78e107ca6d8d99d8b569540782e61e6b517f2d9b846134bf2278783b58b22d9c45328bd21a6336228733f03d39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09bd926a10346614befa7018f9048fe5ed984c3b9b98d349241499a38d589584323f134697dc7a76cfffe0e61924cb021dad0d522745e10d865f78240ef4cc92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/311e86394cd2dbfecf6077110a2c5fe3c0b6e1c119a3e641173a3dc9dca6a694bd9168f577013cd7c6bb10c10feb50698c4f00f3c7cf311ba11cbae1aedb757d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:13:00.712089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:13:00.712851) ========= 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.layXQfHWAI/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.02QbdIAiyl/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005239 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:13:00.767558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:13:00.767959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:13:00.768324) ========= ========= Total master_lag: 0.21 =========