builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0367 starttime: 1480008081.84 results: success (0) buildid: 20161124062419 builduid: ec4fa613ddcc4926a86b2cd9dd35f999 revision: 41a407cb625b22b1cd413dff0fa5142151784647 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.837766) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.838216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.838491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.864553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.865012) ========= 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.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-24 09:21:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.97M=0.001s 2016-11-24 09:21:21 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.974342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:21.974656) ========= 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.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.019470 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:22.023587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 09:21:22.023947) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 41a407cb625b22b1cd413dff0fa5142151784647 --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-aurora --rev 41a407cb625b22b1cd413dff0fa5142151784647 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-24 09:21:22,107 truncating revision to first 12 chars 2016-11-24 09:21:22,107 Setting DEBUG logging. 2016-11-24 09:21:22,107 attempt 1/10 2016-11-24 09:21:22,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/41a407cb625b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 09:21:23,417 unpacking tar archive at: mozilla-aurora-41a407cb625b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.568754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 09:21:23.616942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:23.617307) ========= script_repo_revision: 41a407cb625b22b1cd413dff0fa5142151784647 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:23.618016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:23.618362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:21:23.638269) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-24 09:21:23.638648) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:21:23 INFO - MultiFileLogger online at 20161124 09:21:23 in /builds/slave/test 09:21:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:21:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:23 INFO - {'append_to_log': False, 09:21:23 INFO - 'base_work_dir': '/builds/slave/test', 09:21:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:21:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:23 INFO - 'branch': 'Mozilla-Aurora', 09:21:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:23 INFO - 'config_files': ('talos/mac_config.py',), 09:21:23 INFO - 'default_actions': ('clobber', 09:21:23 INFO - 'read-buildbot-config', 09:21:23 INFO - 'download-and-extract', 09:21:23 INFO - 'populate-webroot', 09:21:23 INFO - 'create-virtualenv', 09:21:23 INFO - 'install', 09:21:23 INFO - 'run-tests'), 09:21:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:23 INFO - 'download_minidump_stackwalk': True, 09:21:23 INFO - 'download_symbols': 'ondemand', 09:21:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:23 INFO - 'installer_path': 'installer.exe', 09:21:23 INFO - 'log_level': 'info', 09:21:23 INFO - 'log_name': 'talos', 09:21:23 INFO - 'log_to_console': True, 09:21:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:21:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:21:23 INFO - 'opt_config_files': (), 09:21:23 INFO - 'pip_index': False, 09:21:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:21:23 INFO - 'cmd': ('bash', 09:21:23 INFO - '-c', 09:21:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:21:23 INFO - 'enabled': True, 09:21:23 INFO - 'halt_on_failure': False, 09:21:23 INFO - 'name': 'check_screen_resolution'},), 09:21:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:21:23 INFO - 'cmd': ('bash', 09:21:23 INFO - '-c', 09:21:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:21:23 INFO - 'enabled': True, 09:21:23 INFO - 'halt_on_failure': False, 09:21:23 INFO - 'name': 'check_screen_resolution'},), 09:21:23 INFO - 'run_cmd_checks_enabled': True, 09:21:23 INFO - 'sps_profile': False, 09:21:23 INFO - 'sps_profile_interval': 0, 09:21:23 INFO - 'suite': 'dromaeojs-e10s', 09:21:23 INFO - 'system_bits': '32', 09:21:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:23 INFO - 'title': 't-yosemite-r7-0367', 09:21:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:23 INFO - 'use_talos_json': True, 09:21:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:23 INFO - 'work_dir': 'build'} 09:21:23 INFO - [mozharness: 2016-11-24 17:21:23.838531Z] Running clobber step. 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: clobber 09:21:23 INFO - rmtree: /builds/slave/test/build 09:21:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:25 INFO - Running post-action listener: _resource_record_post_action 09:21:25 INFO - [mozharness: 2016-11-24 17:21:25.509329Z] Finished clobber step (success) 09:21:25 INFO - [mozharness: 2016-11-24 17:21:25.509598Z] Running read-buildbot-config step. 09:21:25 INFO - Running pre-action listener: _resource_record_pre_action 09:21:25 INFO - Running main action method: read_buildbot_config 09:21:25 INFO - Using buildbot properties: 09:21:25 INFO - { 09:21:25 INFO - "project": "", 09:21:25 INFO - "product": "firefox", 09:21:25 INFO - "script_repo_revision": "production", 09:21:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:21:25 INFO - "repository": "", 09:21:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:21:25 INFO - "buildid": "20161124062419", 09:21:25 INFO - "pgo_build": "False", 09:21:25 INFO - "basedir": "/builds/slave/test", 09:21:25 INFO - "buildnumber": 38, 09:21:25 INFO - "slavename": "t-yosemite-r7-0367", 09:21:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:21:25 INFO - "platform": "yosemite_r7", 09:21:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:21:25 INFO - "branch": "mozilla-aurora", 09:21:25 INFO - "repo_path": "releases/mozilla-aurora", 09:21:25 INFO - "revision": "41a407cb625b22b1cd413dff0fa5142151784647", 09:21:25 INFO - "stage_platform": "macosx64", 09:21:25 INFO - "builduid": "ec4fa613ddcc4926a86b2cd9dd35f999", 09:21:25 INFO - "slavebuilddir": "test" 09:21:25 INFO - } 09:21:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 09:21:25 INFO - Running post-action listener: _resource_record_post_action 09:21:25 INFO - [mozharness: 2016-11-24 17:21:25.515204Z] Finished read-buildbot-config step (success) 09:21:25 INFO - [mozharness: 2016-11-24 17:21:25.515398Z] Running download-and-extract step. 09:21:25 INFO - Running pre-action listener: _resource_record_pre_action 09:21:25 INFO - Running main action method: download_and_extract 09:21:25 INFO - mkdir: /builds/slave/test/build/tests 09:21:25 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:21:25 INFO - trying https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 09:21:25 INFO - Downloading https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 09:21:26 INFO - Downloaded 1199 bytes. 09:21:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:21:26 INFO - Using the following test package requirements: 09:21:26 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:21:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 09:21:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 09:21:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'jsshell-mac.zip'], 09:21:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 09:21:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:21:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 09:21:26 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 09:21:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 09:21:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:21:26 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 09:21:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:21:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:21:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:21:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:21:26 INFO - Http code: 200 09:21:26 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:21:26 INFO - x-amz-cf-id: vZDyPMrvxM5zxfs7asm6Icq3133F_YCM1k3GJeIVQSund4HM1g-Rxg== 09:21:26 INFO - x-amz-version-id: bqAyA.R7PFQtKO7B1M.MWkfeO2DqNKQG 09:21:27 INFO - Expected file size: 16279004 09:21:27 INFO - Obtained file size: 16279004 09:21:33 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:21:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:21:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:21:33 INFO - Fetch https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:21:34 INFO - Http code: 200 09:21:34 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:21:34 INFO - x-amz-cf-id: acwsxS2f574FC88l4FQAfOu147Zhs-VtuUazj2Z_hVJ7vxO4VMwD5g== 09:21:34 INFO - x-amz-version-id: bqAyA.R7PFQtKO7B1M.MWkfeO2DqNKQG 09:21:34 INFO - Expected file size: 16279004 09:21:34 INFO - Obtained file size: 16279004 09:21:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 09:21:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:21:41 INFO - Fetch https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 09:21:42 INFO - Http code: 200 09:21:42 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 09:21:42 INFO - x-amz-cf-id: YNmiVazaxG_LCGjre1Dvo4uToZUdbBwoA26oKL4HGBWknyn7mz1kJg== 09:21:42 INFO - x-amz-version-id: PbGk8ZCztOLak093oUPF2lUfXW3F6Xep 09:21:42 INFO - Expected file size: 14409038 09:21:42 INFO - Obtained file size: 14409038 09:21: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:21:42 INFO - trying https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:21:42 INFO - Downloading https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 09:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 09:21:45 INFO - Downloaded 109694081 bytes. 09:21:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:21:45 INFO - mkdir: /builds/slave/test/properties 09:21:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:45 INFO - Contents: 09:21:45 INFO - build_url:https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:21:47 INFO - Running post-action listener: _resource_record_post_action 09:21:47 INFO - Running post-action listener: set_extra_try_arguments 09:21:47 INFO - [mozharness: 2016-11-24 17:21:47.090520Z] Finished download-and-extract step (success) 09:21:47 INFO - [mozharness: 2016-11-24 17:21:47.090646Z] Running populate-webroot step. 09:21:47 INFO - Running pre-action listener: _resource_record_pre_action 09:21:47 INFO - Running main action method: populate_webroot 09:21:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:47 INFO - '--tppagecycles', 09:21:47 INFO - '7'], 09:21:47 INFO - 'tests': ['tsvgm']}}, 09:21:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['damp', 'tps']}, 09:21:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'tests': ['damp', 'tps']}, 09:21:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['dromaeo_dom']}, 09:21:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['basic_compositor_video']}, 09:21:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['a11yr', 09:21:47 INFO - 'ts_paint', 09:21:47 INFO - 'tpaint', 09:21:47 INFO - 'sessionrestore', 09:21:47 INFO - 'sessionrestore_no_auto_restore', 09:21:47 INFO - 'tabpaint']}, 09:21:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['tsvgx', 09:21:47 INFO - 'tsvgr_opacity', 09:21:47 INFO - 'tart', 09:21:47 INFO - 'tscrollx', 09:21:47 INFO - 'cart']}, 09:21:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:47 INFO - 'tsvgr_opacity', 09:21:47 INFO - 'tart', 09:21:47 INFO - 'tscrollx', 09:21:47 INFO - 'cart']}, 09:21:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'talos_options': ['--disable-e10s'], 09:21:47 INFO - 'tests': ['tp5o']}, 09:21:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'tests': ['tp5o']}, 09:21:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'talos_options': ['--disable-e10s', 09:21:47 INFO - '--xperf_path', 09:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:47 INFO - 'tests': ['tp5n']}, 09:21:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:47 INFO - 'talos_options': ['--xperf_path', 09:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:47 INFO - 'tests': ['tp5n']}}, 09:21:47 INFO - 'talos.zip': {'path': '', 09:21:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:47 INFO - Running post-action listener: _resource_record_post_action 09:21:47 INFO - [mozharness: 2016-11-24 17:21:47.109411Z] Finished populate-webroot step (success) 09:21:47 INFO - [mozharness: 2016-11-24 17:21:47.109503Z] Running create-virtualenv step. 09:21:47 INFO - Running pre-action listener: _resource_record_pre_action 09:21:47 INFO - Running main action method: create_virtualenv 09:21:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:47 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:21:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:47 INFO - Using real prefix '/tools/python27' 09:21:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:50 INFO - Installing pip.................done. 09:21:50 INFO - Return code: 0 09:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:51 INFO - Reading from file tmpfile_stdout 09:21:51 INFO - Output received: 09:21:51 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:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:51 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:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:21:51 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:21:51 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:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:51 INFO - 'HOME': '/Users/cltbld', 09:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PAGER': '/bin/cat', 09:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:21:51 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - 'XPC_FLAGS': '0x0', 09:21:51 INFO - 'XPC_SERVICE_NAME': '0', 09:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 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:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:51 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:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:21:51 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:21:51 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:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:51 INFO - 'HOME': '/Users/cltbld', 09:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PAGER': '/bin/cat', 09:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:21:51 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - 'XPC_FLAGS': '0x0', 09:21:51 INFO - 'XPC_SERVICE_NAME': '0', 09:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Downloading/unpacking psutil>=3.1.1 09:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:55 INFO - Installing collected packages: psutil 09:21:55 INFO - Running setup.py install for psutil 09:21:55 INFO - building 'psutil._psutil_osx' extension 09:21:55 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:21:55 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:21:55 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:21:55 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:21:55 INFO - building 'psutil._psutil_posix' extension 09:21:55 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:21:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:21:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:21:55 INFO - ^ 09:21:55 INFO - 1 warning generated. 09:21:55 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:21:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:55 INFO - Successfully installed psutil 09:21:55 INFO - Cleaning up... 09:21:56 INFO - Return code: 0 09:21:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:56 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:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 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:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:21:56 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:21:56 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:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:56 INFO - 'HOME': '/Users/cltbld', 09:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:56 INFO - 'LOGNAME': 'cltbld', 09:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:56 INFO - 'MOZ_NO_REMOTE': '1', 09:21:56 INFO - 'NO_EM_RESTART': '1', 09:21:56 INFO - 'PAGER': '/bin/cat', 09:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:56 INFO - 'PWD': '/builds/slave/test', 09:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:56 INFO - 'SHELL': '/bin/bash', 09:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:21:56 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:56 INFO - 'USER': 'cltbld', 09:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:56 INFO - 'XPC_FLAGS': '0x0', 09:21:56 INFO - 'XPC_SERVICE_NAME': '0', 09:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:58 INFO - Installing collected packages: mozsystemmonitor 09:21:58 INFO - Running setup.py install for mozsystemmonitor 09:21:59 INFO - Successfully installed mozsystemmonitor 09:21:59 INFO - Cleaning up... 09:21:59 INFO - Return code: 0 09:21:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:59 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:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 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:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:59 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:21:59 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:21:59 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:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:59 INFO - 'HOME': '/Users/cltbld', 09:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:59 INFO - 'LOGNAME': 'cltbld', 09:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:59 INFO - 'MOZ_NO_REMOTE': '1', 09:21:59 INFO - 'NO_EM_RESTART': '1', 09:21:59 INFO - 'PAGER': '/bin/cat', 09:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:59 INFO - 'PWD': '/builds/slave/test', 09:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:59 INFO - 'SHELL': '/bin/bash', 09:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:21:59 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:59 INFO - 'USER': 'cltbld', 09:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:59 INFO - 'XPC_FLAGS': '0x0', 09:21:59 INFO - 'XPC_SERVICE_NAME': '0', 09:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:59 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:21:59 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:21:59 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:21:59 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:21:59 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:21:59 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:22:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:02 INFO - warning: no files found matching '*.txt' 09:22:02 INFO - no previously-included directories found matching 'build' 09:22:02 INFO - no previously-included directories found matching 'dist' 09:22:02 INFO - no previously-included directories found matching '.git*' 09:22:02 INFO - Installing collected packages: jsonschema, functools32 09:22:02 INFO - Running setup.py install for functools32 09:22:02 INFO - warning: no files found matching '*.txt' 09:22:02 INFO - no previously-included directories found matching 'build' 09:22:02 INFO - no previously-included directories found matching 'dist' 09:22:02 INFO - no previously-included directories found matching '.git*' 09:22:02 INFO - Successfully installed jsonschema functools32 09:22:02 INFO - Cleaning up... 09:22:02 INFO - Return code: 0 09:22:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:02 INFO - 'HOME': '/Users/cltbld', 09:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:02 INFO - 'LOGNAME': 'cltbld', 09:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:02 INFO - 'MOZ_NO_REMOTE': '1', 09:22:02 INFO - 'NO_EM_RESTART': '1', 09:22:02 INFO - 'PAGER': '/bin/cat', 09:22:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:02 INFO - 'PWD': '/builds/slave/test', 09:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:02 INFO - 'SHELL': '/bin/bash', 09:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:02 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:02 INFO - 'USER': 'cltbld', 09:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:02 INFO - 'XPC_FLAGS': '0x0', 09:22:02 INFO - 'XPC_SERVICE_NAME': '0', 09:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:22:02 INFO - Cleaning up... 09:22:02 INFO - Return code: 0 09:22:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:02 INFO - 'HOME': '/Users/cltbld', 09:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:02 INFO - 'LOGNAME': 'cltbld', 09:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:02 INFO - 'MOZ_NO_REMOTE': '1', 09:22:02 INFO - 'NO_EM_RESTART': '1', 09:22:02 INFO - 'PAGER': '/bin/cat', 09:22:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:02 INFO - 'PWD': '/builds/slave/test', 09:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:02 INFO - 'SHELL': '/bin/bash', 09:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:02 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:02 INFO - 'USER': 'cltbld', 09:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:02 INFO - 'XPC_FLAGS': '0x0', 09:22:02 INFO - 'XPC_SERVICE_NAME': '0', 09:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:03 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:22:03 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:22:03 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:22:03 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:22:03 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:22:03 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:22:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:05 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:22:05 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:22:05 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:22:05 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:22:05 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:22:05 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:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 INFO - Downloading docopt-0.6.1.tar.gz 09:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:06 INFO - Running setup.py install for blobuploader 09:22:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:07 INFO - Running setup.py install for requests 09:22:07 INFO - Running setup.py install for docopt 09:22:07 INFO - Successfully installed blobuploader requests docopt 09:22:07 INFO - Cleaning up... 09:22:07 INFO - Return code: 0 09:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:07 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:07 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:22:07 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:22:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:07 INFO - 'HOME': '/Users/cltbld', 09:22:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:07 INFO - 'LOGNAME': 'cltbld', 09:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:07 INFO - 'MOZ_NO_REMOTE': '1', 09:22:07 INFO - 'NO_EM_RESTART': '1', 09:22:07 INFO - 'PAGER': '/bin/cat', 09:22:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:07 INFO - 'PWD': '/builds/slave/test', 09:22:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:07 INFO - 'SHELL': '/bin/bash', 09:22:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:07 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:07 INFO - 'USER': 'cltbld', 09:22:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:07 INFO - 'XPC_FLAGS': '0x0', 09:22:07 INFO - 'XPC_SERVICE_NAME': '0', 09:22:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-iRCxvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2KAOHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-OC3Qbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-6ZkkEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KyUrSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GFKwdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-fDf9kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-vIurP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-x4KNof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tqzOWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-EmNwGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-eKudx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ASVA_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-QPQj_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ZwclYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-u80s_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Csh6pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:09 INFO - Running setup.py install for manifestparser 09:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:10 INFO - Running setup.py install for mozcrash 09:22:10 INFO - Running setup.py install for mozdebug 09:22:10 INFO - Running setup.py install for mozdevice 09:22:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:10 INFO - Running setup.py install for mozfile 09:22:10 INFO - Running setup.py install for mozhttpd 09:22:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:10 INFO - Running setup.py install for mozinfo 09:22:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:10 INFO - Running setup.py install for mozInstall 09:22:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Running setup.py install for mozleak 09:22:11 INFO - Running setup.py install for mozlog 09:22:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Running setup.py install for moznetwork 09:22:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Running setup.py install for mozprocess 09:22:11 INFO - Running setup.py install for mozprofile 09:22:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:11 INFO - Running setup.py install for mozrunner 09:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:12 INFO - Running setup.py install for mozscreenshot 09:22:12 INFO - Running setup.py install for moztest 09:22:12 INFO - Running setup.py install for mozversion 09:22:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:12 INFO - Cleaning up... 09:22:12 INFO - Return code: 0 09:22:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:12 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:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:12 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:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:12 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:12 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:22:12 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:22:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:12 INFO - 'HOME': '/Users/cltbld', 09:22:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:12 INFO - 'LOGNAME': 'cltbld', 09:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:12 INFO - 'MOZ_NO_REMOTE': '1', 09:22:12 INFO - 'NO_EM_RESTART': '1', 09:22:12 INFO - 'PAGER': '/bin/cat', 09:22:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:12 INFO - 'PWD': '/builds/slave/test', 09:22:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:12 INFO - 'SHELL': '/bin/bash', 09:22:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:12 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:12 INFO - 'USER': 'cltbld', 09:22:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:12 INFO - 'XPC_FLAGS': '0x0', 09:22:12 INFO - 'XPC_SERVICE_NAME': '0', 09:22:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:12 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Cb1gu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:12 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:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:12 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-9TNXJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:12 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:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:12 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-vEUtG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GzEaAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-aNpPdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-pdWmGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-A9LcvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-89QNDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8H5LJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-RqXHOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-7y_s0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:13 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:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-imBox6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:14 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:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-wBUGHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:14 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:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-d4yAP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:14 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:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-qiXd81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:14 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:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-QdaqRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-If9K4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:17 INFO - Downloading blessings-1.6.tar.gz 09:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:17 INFO - Installing collected packages: blessings 09:22:17 INFO - Running setup.py install for blessings 09:22:17 INFO - Successfully installed blessings 09:22:17 INFO - Cleaning up... 09:22:17 INFO - Return code: 0 09:22:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:17 INFO - Reading from file tmpfile_stdout 09:22:17 INFO - Current package versions: 09:22:17 INFO - blessings == 1.6 09:22:17 INFO - blobuploader == 1.2.4 09:22:17 INFO - docopt == 0.6.1 09:22:17 INFO - functools32 == 3.2.3-2 09:22:17 INFO - jsonschema == 2.5.1 09:22:17 INFO - manifestparser == 1.1 09:22:17 INFO - mozInstall == 1.12 09:22:17 INFO - mozcrash == 1.0 09:22:17 INFO - mozdebug == 0.1 09:22:17 INFO - mozdevice == 0.48 09:22:17 INFO - mozfile == 1.2 09:22:17 INFO - mozhttpd == 0.7 09:22:17 INFO - mozinfo == 0.9 09:22:17 INFO - mozleak == 0.1 09:22:17 INFO - mozlog == 3.4 09:22:17 INFO - moznetwork == 0.27 09:22:17 INFO - mozprocess == 0.23 09:22:17 INFO - mozprofile == 0.28 09:22:17 INFO - mozrunner == 6.13 09:22:17 INFO - mozscreenshot == 0.1 09:22:17 INFO - mozsystemmonitor == 0.3 09:22:17 INFO - moztest == 0.7 09:22:17 INFO - mozversion == 1.4 09:22:17 INFO - psutil == 3.1.1 09:22:17 INFO - requests == 1.2.3 09:22:17 INFO - wsgiref == 0.1.2 09:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:17 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:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:18 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:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:19 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:22:19 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:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:19 INFO - 'HOME': '/Users/cltbld', 09:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:19 INFO - 'LOGNAME': 'cltbld', 09:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:19 INFO - 'MOZ_NO_REMOTE': '1', 09:22:19 INFO - 'NO_EM_RESTART': '1', 09:22:19 INFO - 'PAGER': '/bin/cat', 09:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:19 INFO - 'PWD': '/builds/slave/test', 09:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:19 INFO - 'SHELL': '/bin/bash', 09:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:19 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:19 INFO - 'USER': 'cltbld', 09:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:19 INFO - 'XPC_FLAGS': '0x0', 09:22:19 INFO - 'XPC_SERVICE_NAME': '0', 09:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 INFO - Cleaning up... 09:22:19 INFO - Return code: 0 09:22:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 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 0x109ef5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf059c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, '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.6FBfv4W44g/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.RMVZz0eUbG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:22:19 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:22:19 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:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:19 INFO - 'HOME': '/Users/cltbld', 09:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:19 INFO - 'LOGNAME': 'cltbld', 09:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:19 INFO - 'MOZ_NO_REMOTE': '1', 09:22:19 INFO - 'NO_EM_RESTART': '1', 09:22:19 INFO - 'PAGER': '/bin/cat', 09:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:19 INFO - 'PWD': '/builds/slave/test', 09:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:19 INFO - 'SHELL': '/bin/bash', 09:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:19 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:19 INFO - 'USER': 'cltbld', 09:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:19 INFO - 'XPC_FLAGS': '0x0', 09:22:19 INFO - 'XPC_SERVICE_NAME': '0', 09:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:22:20 INFO - Cleaning up... 09:22:20 INFO - Return code: 0 09:22:20 INFO - Running post-action listener: _resource_record_post_action 09:22:20 INFO - Running post-action listener: _start_resource_monitoring 09:22:20 INFO - Starting resource monitoring. 09:22:20 INFO - [mozharness: 2016-11-24 17:22:20.132475Z] Finished create-virtualenv step (success) 09:22:20 INFO - [mozharness: 2016-11-24 17:22:20.133515Z] Running install step. 09:22:20 INFO - Running pre-action listener: _resource_record_pre_action 09:22:20 INFO - Running main action method: install 09:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:20 INFO - Reading from file tmpfile_stdout 09:22:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:20 INFO - Reading from file tmpfile_stdout 09:22:20 INFO - Output received: 09:22:20 INFO - Usage: mozinstall [options] installer 09:22:20 INFO - Options: 09:22:20 INFO - -h, --help show this help message and exit 09:22:20 INFO - -d DEST, --destination=DEST 09:22:20 INFO - Directory to install application into. [default: 09:22:20 INFO - "/builds/slave/test"] 09:22:20 INFO - --app=APP Application being installed. [default: firefox] 09:22:20 INFO - mkdir: /builds/slave/test/build/application 09:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:22:51 INFO - Reading from file tmpfile_stdout 09:22:51 INFO - Output received: 09:22:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:22:51 INFO - Running post-action listener: _resource_record_post_action 09:22:51 INFO - [mozharness: 2016-11-24 17:22:51.294473Z] Finished install step (success) 09:22:51 INFO - [mozharness: 2016-11-24 17:22:51.294634Z] Running run-tests step. 09:22:51 INFO - Running pre-action listener: _resource_record_pre_action 09:22:51 INFO - Running main action method: run_tests 09:22:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:22:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:22:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:22:51 INFO - 2016-11-24 09:22:51.309 screenresolution[1904:16029] starting screenresolution argv=screenresolution get 09:22:51 INFO - 2016-11-24 09:22:51.312 screenresolution[1904:16029] Display 0: 1600x1200x32@60 09:22:51 INFO - 2016-11-24 09:22:51.317 screenresolution[1905:16032] starting screenresolution argv=screenresolution list 09:22:51 INFO - Available Modes on Display 0 09:22:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:22:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:22:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:22:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:22:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:22:51 INFO - Intel Iris: 09:22:51 INFO - Chipset Model: Intel Iris 09:22:51 INFO - Type: GPU 09:22:51 INFO - Bus: Built-In 09:22:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:22:51 INFO - Vendor: Intel (0x8086) 09:22:51 INFO - Device ID: 0x0a2e 09:22:51 INFO - Revision ID: 0x0009 09:22:51 INFO - Displays: 09:22:51 INFO - Display: 09:22:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:22:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:22:51 INFO - Display Serial Number: 1600x1200 60 09:22:51 INFO - Main Display: Yes 09:22:51 INFO - Mirror: Off 09:22:51 INFO - Online: Yes 09:22:51 INFO - Rotation: Supported 09:22:51 INFO - Return code: 0 09:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:51 INFO - Python 2.7.3 09:22:51 INFO - Return code: 0 09:22:51 INFO - grabbing minidump binary from tooltool 09:22:51 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:22:51 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 0x109d09d30>, '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 0x109b6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d01b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:51 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:22:51 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:22:51 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:22:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:51 INFO - Return code: 0 09:22:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:22:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:22:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FBfv4W44g/Render', 09:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:51 INFO - 'HOME': '/Users/cltbld', 09:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:51 INFO - 'LOGNAME': 'cltbld', 09:22:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:51 INFO - 'MOZ_NO_REMOTE': '1', 09:22:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:51 INFO - 'NO_EM_RESTART': '1', 09:22:51 INFO - 'PAGER': '/bin/cat', 09:22:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:51 INFO - 'PWD': '/builds/slave/test', 09:22:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:51 INFO - 'SHELL': '/bin/bash', 09:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMVZz0eUbG/Listeners', 09:22:51 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 09:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:51 INFO - 'USER': 'cltbld', 09:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:51 INFO - 'XPC_FLAGS': '0x0', 09:22:51 INFO - 'XPC_SERVICE_NAME': '0', 09:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:22:51 INFO - mozversion application_buildid: 20161124062419 09:22:51 INFO - mozversion application_changeset: 41a407cb625b22b1cd413dff0fa5142151784647 09:22:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:22:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:51 INFO - mozversion application_name: Firefox 09:22:51 INFO - mozversion application_remotingname: firefox-dev 09:22:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:51 INFO - mozversion application_vendor: Mozilla 09:22:51 INFO - mozversion application_version: 52.0a2 09:22:51 INFO - mozversion platform_buildid: 20161124062419 09:22:51 INFO - mozversion platform_changeset: 41a407cb625b22b1cd413dff0fa5142151784647 09:22:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:51 INFO - mozversion platform_version: 52.0a2 09:22:51 INFO - using testdate: 1480008171 09:22:51 INFO - actual date: 1480008171 09:22:51 INFO - starting webserver on 'localhost:53487' 09:22:51 INFO - SUITE-START | Running 2 tests 09:22:51 INFO - TEST-START | dromaeo_css 09:22:51 INFO - operating with platform_type : mac_ 09:22:51 INFO - Initialising browser for dromaeo_css test... 09:22:51 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpzl9KKe/profile http://localhost:53487/getInfo.html) 09:22:54 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 09:22:54 INFO - PROCESS | 1915 | colorDepth:24 09:22:54 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 09:22:54 INFO - PROCESS | 1915 | __metrics 09:22:54 ERROR - PROCESS | 1915 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:22:55 INFO - TEST-INFO | 1915: exit 0 09:22:55 INFO - Browser initialized. 09:22:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:55 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpzl9KKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:08 INFO - PROCESS | 1918 | RSS: Main: 229961728 09:23:08 INFO - PROCESS | 1918 | 09:23:57 INFO - PROCESS | 1918 | 1480008237693 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:26:11 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53487/tests/dromaeo/cssquery-ext.html) 09:26:13 INFO - PROCESS | 1918 | RSS: Main: 232476672 09:26:13 INFO - PROCESS | 1918 | 09:29:15 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-ext.html (next: http://localhost:53487/tests/dromaeo/cssquery-jquery.html) 09:29:16 INFO - PROCESS | 1918 | RSS: Main: 243687424 09:29:16 INFO - PROCESS | 1918 | 09:32:18 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53487/tests/dromaeo/cssquery-mootools.html) 09:32:18 INFO - PROCESS | 1918 | RSS: Main: 246525952 09:32:18 INFO - PROCESS | 1918 | 09:35:20 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53487/tests/dromaeo/cssquery-prototype.html) 09:35:21 INFO - PROCESS | 1918 | RSS: Main: 246677504 09:35:21 INFO - PROCESS | 1918 | 09:38:24 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53487/tests/dromaeo/cssquery-yui.html) 09:38:24 INFO - PROCESS | 1918 | RSS: Main: 250126336 09:38:24 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53487/tests/dromaeo/cssquery-yui.html (next: http://localhost:53487/tests/dromaeo/cssquery-dojo.html) 09:41:27 INFO - PROCESS | 1918 | RSS: Main: 251564032 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | __start_tp_report 09:41:27 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 09:41:27 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 09:41:27 INFO - PROCESS | 1918 | |i|pagename|runs| 09:41:27 INFO - PROCESS | 1918 | |0;dojo.html;3397.881074162404;3401.4897765335195;3431.416659167942;3446.396880545904;3452.8791492297773;5169.870753231162;5212.983468223698;5717.856428714253;5730.398308177644;5873.442023007808;5828.1840542324;5908.497777688891;5918.378570250126;5931.347551769302;5937.584369094165;5348.304720386344;5350.678959262456;5350.785968561253;5351.759170837312;5388.78444862207;5381.838544843661;5406.40529541752;5408.675479471244;5414.242006119146;5424.376196737367;5209.244659524366;5240.737963101848;5380.838574842742;5385.67685938843;5397.46025397461;5270.314859068335;5287.629865909388;5334.119870221409;5392.460753924615;5422.322209723785;5190.896182076337;5331.386890507563;5334.733263336818;5363.168708850135;5376.354837419534;5652.265205523297;5898.216702491855;5902.055671092605;5963.761449542013;6007.339192688801;6121.696863452133;6122.337166850137;6178.07328900664;6183.783567575113;6235.563510554263;6266.279377871512;6270.686465676744;6274.247090349141;6278.748850045993;6296.968515157395;5934.792282270143;5943.10853371989;5962.403759624046;5971.651346436507;5978.910316345258;6144.648177400964;6174.567780255429;6264.686765661699;6277.874442511215;6307.62154270736;6144.402455361638;6198.194234749454;6229.0967809667345;6234.844128896814;6244.562880598314;6245.313015568284;6258.468030217483;6261.154744109487;6273.466755325757;6278.968605156945;6064.75740970365;6105.511559075263;6112.358202388774;6160.9383906160365;6188.597741146811;6135.324535308531;6148.047052706837;6163.013917773134;6178.351273116258;6178.876422471525;4940;4943.876403089879;4987;5017.222330538772;5028.622853286018;4396.714213576107;4416.315471101984;4417.558244175557;4437.378766972626;4451.59935605797;4346;5678.602497825195;5688.516476099495;5940.6435613863305;5948.940510594839;5220.3735551734035;5482.972585137049;6043.700604370081;6150.630962142286;6243.8126856194385;5392;5413.756380962787;5811.970940145272;5902.114682797529;5931.288245410578;5463.289772329651;5521.116621340566;5524;5529.502344788988;5540.612157149041;5331.893362132736;6425.710843012169;6434.613923164625;6436.259830119596;6475.222973243241;5134.255532947627;6132.202813634199;6170.321264660974;6186.412290832363;6197;6377.426031657174;6402.711877965409;6417.679116044085;6438.420542151229;6470.838229044311;6187.504999600112;6211.534134939807;6216.627002379872;6221.844453888508;6231.844203894939;6095.786647467317;6141.578063794062;6154.230721159855;6218.720157592828;6232.283287421823;6097.634141951497;6125.908111378422;6147.616786223064;6190;6221.688915554295;5025.422076461107;6016.878308984536;6175.135481032569;6179.227596550431;6193.535484838565;5896.145058966512;5944.286685597756;5985.132155837467;5991.490723288569;6010.188624535806;6067.059605760937;6121.818815678001;6124.295705993868;6124.95875701123;6129.695011270001;5983.611065280743;6051.5461340400525;6111.908321375272;6135.631862088289;6137 09:41:27 INFO - PROCESS | 1918 | |1;ext.html;452.2063778069488;477.18877907557163;481.4391234212143;514.244061229992;518.1398877862748;29335.706642933565;34309.31381372371;38972.41541376878;40283.395749063784;40489.59510404895;41439.37840932389;41831.58168418315;41837;41883.58116418835;41909.580904191025;9162.816743665122;9244.399114057565;9306.883174019093;9352.766180845465;9380.765480862965;9311.487868167249;9402.670906518273;9406.764830879214;9410.153086222239;9449.858252126223;9367.953160234223;9424.38741481805;9424.81150376992;9428.81142377152;9448.622055117787;9302.581383837709;9376.249900008017;9387.718368448957;9390.765230869283;9399.718008459757;9255.583498742573;9294.442333459947;9316.301277404154;9323.533823308875;9350.71947841559;38999.41500877461;39066.41400378996;39199.41200881989;39274;39330.803345983375;3184.7611429142908;3322.933541329184;3331.4503106987318;3341.983290083534;3366.5286859839644;28053.71946280552;28420.715792842013;28543.57184642232;28565.28586785347;29133.271668208254;3043.8630261638277;3236.0453666168537;3251.1872031992;3262.934741305184;3315.336932613463;413492;504757;514050;519321;524927;61087.694561527795;61665.691671542256;61900.38099618946;61975;62129.37870621326;59802.70098649479;64545.67727161334;64696.67651661712;64901.67549162224;64914;16253.756193657104;16406.425775097814;16508.25712842925;16532.586685332964;16541.917290413472;12673.239605623692;12674.873251267554;12684.112112152245;12694.873051269555;12720.93639531815;18269.689796199473;18519.72220416695;18830.905845470686;18873.52816179579;19004.334848280243;3155.668654791214;3262.7226685731503;3268.6894744999186;7330.780076597711;7583.810404739816;916.706653870755;946.394307643109;1038.672818062308;1055.6991257491732;1074.7259448840496;29084.709152908625;29459.705402946125;29630.259243518653;29944;30269.848650756605;896.5024411451576;906.7007887397143;1046.3146638951498;1069.155367259856;1069.9251052426412;15075.924620377047;15486.690266194613;15519.617158235544;15624.609384765472;15825.208739562975;700239;703131;706809;708605;709655;53693.73153134209;54416.45583544193;54794;54902.17646735302;55169;1342.5502456676927;1358.1918758338772;1377.091119860887;1378.8827949624394;1383.522684673806;28508.57237141486;29253;29292.267693307836;29385.853070735364;29810.701892980793;49751.00497990092;50222.74443138805;50433.74783126061;50553;51543.226851598;434593.6540634553;534913;538263;541478;541992;26235.868820655774;26366.472670546096;26464.603030954935;26619.068332608265;26733;45669;45895.082098358514;46109;46141.53858461372;47030.178189308754;38254;38342.23315533618;38636;38984.415233770946;39349.83575903353;38113.61886381212;38756.224875501764;39115.413268800425;39415;39596;37123.62876371202;37544.06139846526;37794.62205377911;37836.43245351377;38515.42226866655;33749.66250337465;33916.660833391354;34433.48349774705;34544.654553454144;34778.82610586931;24723.87638061798;25460;25713.614295785203;25780.61329080103;25995.870020649774 09:41:27 INFO - PROCESS | 1918 | |2;jquery.html;350.86316336628715;377.831864820155;385.1834111683232;389.56368866869076;405.42024904386716;18290.993995330253;19754.703679444785;20340.491487712814;20389.694154587694;20529.076191571377;19299.614007719836;19583.510412239702;20043.599128017468;20260.392188234375;20424.89787551064;5808.303003639569;5897.112923864365;5920.615160014607;5951.375105613914;6036.9396306036815;5848.883022339551;6000.699965001754;6006.129111278862;6006.7897623583185;6009.909851352211;3956.6834653227675;4133.813978370966;4336.176126535964;4369.453818272716;5463.31708536433;6534.509911756613;6573.704183311763;6642.269350371455;6701.832454188636;6718.42893354063;5683.3464151622675;5817.272840894888;5830.4169583041785;5835.270591176103;5843.9707801461145;21548.245811396526;23244;25573.104941326965;25742.356441088934;25792.61311080335;2172.576347612216;2232.564649893255;2459.323685986368;2591.481703659276;2834.744872961423;13236.338183090807;14960.551183464513;14962.551123466314;15186.240687965668;15231;1843.769528808899;1948.5615736459324;1959.7256384106236;1960;1982.9900850495799;95406.0459395404;103072;109882;124041.37979310135;126737.36631316876;10090.243231757648;10793.892061079447;11009.119270458345;11269.323840569592;11287.097032237401;11870.703232419259;14167;14189;14223.786643200361;14247.287635618177;8344.958275208706;8608.65565377378;8681.348898832613;8782.60478278479;8791.428557143765;8639.870401943976;8675.305975521944;8702.260307873776;8797.428167169113;8818.721285413707;6690.264070952191;6900.413464855544;6911.205211400653;6913.619750913647;6916.23921368649;1864.655038817823;1913.6077104193607;1915.339207973247;1918.3669389101563;1919.2610844824842;879.8020445399734;936.2042264075482;955.3264948211494;968.1141755293968;1000.3747657713928;20697.896510517352;21178.576428471653;22165.335039948826;22239.77760222377;22363.44091397728;933.1786334958334;956.5217391304348;980.2648013989508;1009.6314845081639;1028.7068185567227;11319.490622921989;11588.14024722695;11609.6517104487;11686.415679216005;11705.297682139098;624788;625679;634105;640758;643094;114899;119170;128580.71419285687;131102.93386374938;138205.3089734545;968.9951550242204;977.7848873248016;992.8262554053011;993.4933184076173;993.9453330066916;19001.90499047496;19412.126454309873;19628.509287267934;19635.41093767189;19717.309894153637;52634;53883;54310;54351.184732228256;56120;71486;73798;75362;75785;76419.61790191014;7590.278923502258;7702.614869256403;7738.264864837832;7845.803854903673;7857.371410287277;9527.952360238154;11745.060395168195;11780.116491263361;11869.881301186877;12038.879611204125;10191.337563058378;10205.336653117523;10295.485225738832;10370.688879333633;10626.787464250827;10059.69820905374;10118.139958103644;10567.313124646873;10577.576896924036;10663.8933610666;8408.915910840813;9527.57125929321;10229.181665466893;10354.637587684394;10786.191035672513;6864.553804002724;7586.810329741801;7684.269994350528;8133.8373232536205;8201.179882011751;9706.805863882824;10301.536430860779;10370.844437333597;10537.73655658584;10544.89455105439 09:41:27 INFO - PROCESS | 1918 | |3;mootools.html;1424.5939907126467;1477.0989696285264;1533.2180587900168;1550.155165434838;1800.784470482424;7105.751298704547;7227.9277207227915;8224.50652960822;8706.998695150052;8708.042115367312;8231.711890083849;8585.656573737044;8610.009848867383;8641.611127499262;8675.47947123173;2078.1375729072415;2288.473651060257;2337.041812856729;2337.275444612167;2340.8829558522007;2333.7899589036983;2353.8116950643907;2356.7761062699014;2403.038784486202;2408.8434251773665;2090.634139025672;2287.7025986621716;2317.5249073939804;2326.2672258238686;2344.988275058622;2242.405762472938;2328.9767102329097;2332.416895776056;2349.6710460535537;2358.858468491896;2349.89425475854;2371.2530552875787;2373.0270589058578;2376.2277259890607;2383.4398916254668;8585;8604.35467339952;8662.956685216597;8719.389642725011;8719.433236839584;4848.321235027099;4857.82997595086;5111.744412779383;5282.234076058989;5290.867728306785;3310.586176727909;3463.7229021678204;3512.1570823002294;3625.655562721537;3649.105969037603;1058.687687132298;1072.3405105859918;1084.9186311026626;1088.771358014818;1099.1536516881956;11334.60328888485;11341.829872551836;11369;11485;11491.195616306863;4575.872219417986;4666.836660716858;4734.881627959328;4752.714837109785;4759.309900064541;9583.089606487372;9829.80340393188;9838.65564705232;9841.163501102486;9879.308448408687;5230.686158830483;5245.632805703564;5274.393444753826;5283.841484755463;5285.920711189336;4133.318002529609;4748.810047598057;4802.991371811889;4816.494268101869;4827.42070951488;3891.299566078133;3893.707971902062;3956.3076461619103;3991.381335892941;4007.198560287954;1291.4317700211877;1301.2452777389092;1304.4325718312564;1313.0546006875036;1315.684235783405;749.7076140305285;854.7563944275852;888.5113187746714;891.7681402835309;908.8182363527321;4710.36410084641;5555.749991250404;5584.804531841366;5749.770009199585;5841.357450680422;878.3631866896577;903.5708038681705;931.9394239374554;966.8308046091905;982.4596471940404;3764.3412402829395;3938.6061393860386;4069.328560787437;4089.9959020079946;4101.610347017028;10448.32085914413;10591.205659575562;10606.840897386546;10622.256442049136;10644.84032739494;9894.554745036347;10282.126019288295;10324.12244959172;10409.375437473776;10576.735581610521;7963.8805417918775;8204.712835050865;8214.219649133323;8239.970003749531;8280.917190828135;5696.686682232517;5790.652560846363;5791.247137872049;5803.47768700819;5968.403159683997;8731.607077681392;9552.23582113443;9612.807743844944;9614.134727874525;9693;8649.221570058726;9761.267904907018;9767.218622510325;9772.364796288219;9821.607135714492;6160.568760186744;6736.461083113241;6960.79117626472;7267.527610705287;7435.256474352522;8094.392920530866;8163.755087347389;8298.543580103153;8301.875471867806;8323.708670196515;6671.766488172891;7237.276272372721;7277.38142257914;7480.0649918760155;7571.886421703569;6268.937310626835;7119.394851437686;7321.12146542397;7362.263773622809;7473.551586904803;6863.588184708933;6991;7025.01649769043;7035.47233957445;7047.330503602149;4809.519048095162;4927.236278376858;4929.5809856161195;4939.75301234944;5025;4898.926516102332;4944.950550494449;4960.082384758831;5052.418971818141;5098.2352647103235 09:41:27 INFO - PROCESS | 1918 | |4;prototype.html;299.49086552860143;300.0787582122883;310.20432590405596;314.42617223567;319.50636266967535;4781.298566310033;5107.0296643637685;5166.819161329354;5326.547243484304;5501.0098182327165;5011.974940125303;5317.41508434072;5373.489518495747;5382.461753824616;5430.321209848769;3594.370985077614;4099.385092236166;4119.320312148507;4138.565450627686;4173.56177601352;3799.5630502492154;4061.57353477885;4130.648894843926;4148.917021659565;4177.9373309400235;4013.3779264214095;4025.75845449274;4035.4955630546183;4053.4730485036903;4055.2092341993325;4025.691650213663;4044.757314561136;4054.432379466877;4065.337204131269;4069.4709687740406;3516.261585067139;3541.11472131967;3541.698955588778;3546.6985306249;3554.4668299754985;4961.561147267288;5134.8202812901745;5144.761508019167;5188.299579556787;5213.843584692465;4082.836686532535;4362.454693163355;4614.792334344963;4630.86107416778;4665.253559430509;4635.791389387452;5323.813666521653;5390.21841832932;5665.535492060967;5698.800541981052;3232.7090561849545;3576.123849656825;3596.2627661329366;3621.8732344367822;3832.559255685604;5493.7802487900435;5654.773809047633;5948.97025514874;5964.522838172936;5977.731002104916;3898.688104951597;3914.336407027002;3926.489556357655;3938.5667576566557;3954.189391174802;3502.7372947029075;3848.134169811826;3938.901527461779;3956.188981258835;3994.8801535953967;3685.963140368562;4188.28799104153;4605.917609361797;4622.791974361162;4669.2062349400685;5168.94036722471;5411.404745477994;5648.74580643872;5726.427357264323;5726.828195154152;1058.6718117383482;1082.680609220282;1232.679503329141;1276.425608476171;1283.0249010751709;848.3467729847982;872.6596627315353;881.4358810361374;882.5587206396801;882.6910581296623;4337.392765012901;4407.3168658857285;4668.043051174569;4909;4989.251612258117;5023.598112151019;5363.785448582091;5524.447555244444;5553.361363443175;5567.331920169606;4143.647789937829;4730.858074257778;4850.296706977469;5102.550775627719;5120.539151476385;2578.510083084208;2740.670085845707;2878.424315136981;2887.4080813433197;2908;4934.235193545006;4952.626400355654;4972.627052971042;5161.66449180802;5544.22380866679;4607.8573463339035;4645.581897629229;5182.434694826085;5610.887782244414;5788.913166302509;5290.365156181283;5515.090010148441;5743.655380677173;5758.013485347548;5783.739731712083;5503.8259887345075;5516;5542.861428464159;5556;5565.415631358649;4375.956240437555;4709.9529004710885;5408.864778380572;5420.674759514442;5479.000164939848;4651.558101980307;4900.583450406612;5059.367579052619;5113.565346945551;5536.287219262613;3243.90207351983;3477.7043951264427;3508.280802435546;3732.480575611397;3752.343339915449;4188.434561334181;4506.571875671937;4821.879453013703;4898.510148985073;5556.666600003851;5004.649674522749;5383.353997520323;5584.274044374205;5601.467860553241;5708.628939118944;4923.5814955729165;5500.917486237629;5708.514776244066;5715.799947001835;5724.885502290014;5125.616588286464;5291.470852914677;5504.174373843955;5585.581081418829;5588.469095435927;5661.603687741818;5683.708799856082;5691.516221121251;5728.713564321851;5729.742161602821;4940.827071052496;5327.135502574068;5513.636681624286;5593.300837395325;5611.803586874603 09:41:27 INFO - PROCESS | 1918 | |5;yui.html;688.2119972631338;702.3117345001899;703.8064532253633;773.5474747272846;799.3525244551912;14827.481038163667;15415.537533873974;15468.613284667888;15491.380344786196;15529.844701552982;13350.399232034557;13382.598522044329;13382.933085334584;13394.330283485835;13407.463701451954;748.9888650322076;817.889584906039;846.3440833354139;846.6359465429863;849.3375167369462;815.7022686719334;826.6280173921729;830.1698301698302;833.9374546908975;837.6440012994483;860.5181098584782;876.2814492116468;877.999081047603;880.2913654508119;881.6914080071988;856.6145234644373;865.5066612031113;866.0733015673233;866.1252135343285;869.4565896314804;641.3202005873788;653.0987237612065;656.6421300391298;656.993430065698;657.1194599236998;10855.891441085567;11540.422978851107;12641.873581264254;12792.232466052066;13220.933895330558;11541.596044138414;11690.941545292219;11776.41117944108;11841.703957401047;11996.70008249792;10343.37939723619;10384.532696028697;10555.630552930686;10576.788464230749;10964.122870170368;3551.4672799080085;3605.13476765577;3620.9637903621156;3622.166901612644;3687.797171155585;77118.61440692817;87723.36829895049;91557.54221228918;93605.06394936031;94376;8728.650853965897;8831.867521987175;8895.688650897187;8967.461952282754;9184.770380740534;18765;18774.249030038918;18833.24667013304;18909.43271701851;19089.618207636046;7534.623268836646;7782.105057918298;7856.803579910434;7878.172791856887;7945.761627151194;3692.4461330800596;4127.545969943304;4211.894702632459;4371.366151907955;4429.402030725811;3227.8063316200632;3423.5207071010077;3424.3493736190044;3429.228423604669;3429.9828500857334;603.5202014398564;613.5122577550858;615.2678312807744;617.2901163661825;628.9842753931097;549.2722143160329;646.6217262901162;654.4404534123352;666.6933210723025;673.7069374821968;8978.236849867835;9142.222911052502;9225.169734723908;9411.90588094124;9478.810423791623;584.2414332858127;665.7170702451439;666.4368608525788;676.7157793726647;688.5455599304435;3981.5023122109737;4167.624913757716;4502.527234640381;4507.3915021471685;4549.567791059844;85242;114910.4254478739;118772.40613797048;120494.39752801355;120921;64661.03008454877;93420.5986910197;97086.0291397091;104268;105411.41882871764;82480.58759706163;82547;83275.16724832795;85793;86846.13153868506;9662;9726.902730972599;9926.602935882484;9927;9961.302708810314;50659.986800263054;51192;52694;52912.735436322575;54784.72607636936;58215;62215.37784622096;72770;75384;76879.2312076872;12512.37438128108;12535.561255356019;12547;12698.174618649758;12759.681007974503;13273.402696878857;13558.322083895568;13755.587332380044;13904.860951390761;14525.27373631293;10425.478726063819;12551.246925184518;12711.36443177819;12735.172213806072;13159.868401316247;11872.821907671565;12047.33739644328;12634.684132896384;12831.037672174438;12841.293728845003;12682.175658582162;12692.365381730691;12718.809217861924;12792.424340904496;12794.168379055332;11020;11104.944475277895;11281.774364512828;11470.942645286721;11629;9894.505274736379;10975.451227438436;11094.015386152527;11288.49201785938;11350.148738844455 09:41:27 INFO - PROCESS | 1918 | __end_tp_report 09:41:27 INFO - PROCESS | 1918 | __start_cc_report 09:41:27 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,363 09:41:27 INFO - PROCESS | 1918 | __end_cc_report 09:41:27 INFO - PROCESS | 1918 | __startTimestamp1480009287556__endTimestamp 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | ------- Summary: start ------- 09:41:27 INFO - PROCESS | 1918 | Number of tests: 6 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#0] dojo.html Cycles:165 Average:5760.36 Median:5985.13 stddev:633.25 (10.6%) stddev-sans-first:607.47 09:41:27 INFO - PROCESS | 1918 | Values: 3397.9 3401.5 3431.4 3446.4 3452.9 5169.9 5213.0 5717.9 5730.4 5873.4 5828.2 5908.5 5918.4 5931.3 5937.6 5348.3 5350.7 5350.8 5351.8 5388.8 5381.8 5406.4 5408.7 5414.2 5424.4 5209.2 5240.7 5380.8 5385.7 5397.5 5270.3 5287.6 5334.1 5392.5 5422.3 5190.9 5331.4 5334.7 5363.2 5376.4 5652.3 5898.2 5902.1 5963.8 6007.3 6121.7 6122.3 6178.1 6183.8 6235.6 6266.3 6270.7 6274.2 6278.7 6297.0 5934.8 5943.1 5962.4 5971.7 5978.9 6144.6 6174.6 6264.7 6277.9 6307.6 6144.4 6198.2 6229.1 6234.8 6244.6 6245.3 6258.5 6261.2 6273.5 6279.0 6064.8 6105.5 6112.4 6160.9 6188.6 6135.3 6148.0 6163.0 6178.4 6178.9 4940.0 4943.9 4987.0 5017.2 5028.6 4396.7 4416.3 4417.6 4437.4 4451.6 4346.0 5678.6 5688.5 5940.6 5948.9 5220.4 5483.0 6043.7 6150.6 6243.8 5392.0 5413.8 5812.0 5902.1 5931.3 5463.3 5521.1 5524.0 5529.5 5540.6 5331.9 6425.7 6434.6 6436.3 6475.2 5134.3 6132.2 6170.3 6186.4 6197.0 6377.4 6402.7 6417.7 6438.4 6470.8 6187.5 6211.5 6216.6 6221.8 6231.8 6095.8 6141.6 6154.2 6218.7 6232.3 6097.6 6125.9 6147.6 6190.0 6221.7 5025.4 6016.9 6175.1 6179.2 6193.5 5896.1 5944.3 5985.1 5991.5 6010.2 6067.1 6121.8 6124.3 6125.0 6129.7 5983.6 6051.5 6111.9 6135.6 6137.0 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#1] ext.html Cycles:180 Average:70232.13 Median:39157.41 stddev:155805.17 (397.9%) stddev-sans-first:156154.15 09:41:27 INFO - PROCESS | 1918 | Values: 452.2 477.2 481.4 514.2 518.1 29335.7 34309.3 38972.4 40283.4 40489.6 41439.4 41831.6 41837.0 41883.6 41909.6 9162.8 9244.4 9306.9 9352.8 9380.8 9311.5 9402.7 9406.8 9410.2 9449.9 9368.0 9424.4 9424.8 9428.8 9448.6 9302.6 9376.2 9387.7 9390.8 9399.7 9255.6 9294.4 9316.3 9323.5 9350.7 38999.4 39066.4 39199.4 39274.0 39330.8 3184.8 3322.9 3331.5 3342.0 3366.5 28053.7 28420.7 28543.6 28565.3 29133.3 3043.9 3236.0 3251.2 3262.9 3315.3 413492.0 504757.0 514050.0 519321.0 524927.0 61087.7 61665.7 61900.4 61975.0 62129.4 59802.7 64545.7 64696.7 64901.7 64914.0 16253.8 16406.4 16508.3 16532.6 16541.9 12673.2 12674.9 12684.1 12694.9 12720.9 18269.7 18519.7 18830.9 18873.5 19004.3 3155.7 3262.7 3268.7 7330.8 7583.8 916.7 946.4 1038.7 1055.7 1074.7 29084.7 29459.7 29630.3 29944.0 30269.8 896.5 906.7 1046.3 1069.2 1069.9 15075.9 15486.7 15519.6 15624.6 15825.2 700239.0 703131.0 706809.0 708605.0 709655.0 53693.7 54416.5 54794.0 54902.2 55169.0 1342.6 1358.2 1377.1 1378.9 1383.5 28508.6 29253.0 29292.3 29385.9 29810.7 49751.0 50222.7 50433.7 50553.0 51543.2 434593.7 534913.0 538263.0 541478.0 541992.0 26235.9 26366.5 26464.6 26619.1 26733.0 45669.0 45895.1 46109.0 46141.5 47030.2 38254.0 38342.2 38636.0 38984.4 39349.8 38113.6 38756.2 39115.4 39415.0 39596.0 37123.6 37544.1 37794.6 37836.4 38515.4 33749.7 33916.7 34433.5 34544.7 34778.8 24723.9 25460.0 25713.6 25780.6 25995.9 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#2] jquery.html Cycles:180 Average:35760.41 Median:14192.05 stddev:105270.77 (741.8%) stddev-sans-first:105532.50 09:41:27 INFO - PROCESS | 1918 | Values: 350.9 377.8 385.2 389.6 405.4 18291.0 19754.7 20340.5 20389.7 20529.1 19299.6 19583.5 20043.6 20260.4 20424.9 5808.3 5897.1 5920.6 5951.4 6036.9 5848.9 6000.7 6006.1 6006.8 6009.9 3956.7 4133.8 4336.2 4369.5 5463.3 6534.5 6573.7 6642.3 6701.8 6718.4 5683.3 5817.3 5830.4 5835.3 5844.0 21548.2 23244.0 25573.1 25742.4 25792.6 2172.6 2232.6 2459.3 2591.5 2834.7 13236.3 14960.6 14962.6 15186.2 15231.0 1843.8 1948.6 1959.7 1960.0 1983.0 95406.0 103072.0 109882.0 124041.4 126737.4 10090.2 10793.9 11009.1 11269.3 11287.1 11870.7 14167.0 14189.0 14223.8 14247.3 8345.0 8608.7 8681.3 8782.6 8791.4 8639.9 8675.3 8702.3 8797.4 8818.7 6690.3 6900.4 6911.2 6913.6 6916.2 1864.7 1913.6 1915.3 1918.4 1919.3 879.8 936.2 955.3 968.1 1000.4 20697.9 21178.6 22165.3 22239.8 22363.4 933.2 956.5 980.3 1009.6 1028.7 11319.5 11588.1 11609.7 11686.4 11705.3 624788.0 625679.0 634105.0 640758.0 643094.0 114899.0 119170.0 128580.7 131102.9 138205.3 969.0 977.8 992.8 993.5 993.9 19001.9 19412.1 19628.5 19635.4 19717.3 52634.0 53883.0 54310.0 54351.2 56120.0 71486.0 73798.0 75362.0 75785.0 76419.6 7590.3 7702.6 7738.3 7845.8 7857.4 9528.0 11745.1 11780.1 11869.9 12038.9 10191.3 10205.3 10295.5 10370.7 10626.8 10059.7 10118.1 10567.3 10577.6 10663.9 8408.9 9527.6 10229.2 10354.6 10786.2 6864.6 7586.8 7684.3 8133.8 8201.2 9706.8 10301.5 10370.8 10537.7 10544.9 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#3] mootools.html Cycles:180 Average:5574.38 Median:5075.33 stddev:3091.73 (60.9%) stddev-sans-first:3084.67 09:41:27 INFO - PROCESS | 1918 | Values: 1424.6 1477.1 1533.2 1550.2 1800.8 7105.8 7227.9 8224.5 8707.0 8708.0 8231.7 8585.7 8610.0 8641.6 8675.5 2078.1 2288.5 2337.0 2337.3 2340.9 2333.8 2353.8 2356.8 2403.0 2408.8 2090.6 2287.7 2317.5 2326.3 2345.0 2242.4 2329.0 2332.4 2349.7 2358.9 2349.9 2371.3 2373.0 2376.2 2383.4 8585.0 8604.4 8663.0 8719.4 8719.4 4848.3 4857.8 5111.7 5282.2 5290.9 3310.6 3463.7 3512.2 3625.7 3649.1 1058.7 1072.3 1084.9 1088.8 1099.2 11334.6 11341.8 11369.0 11485.0 11491.2 4575.9 4666.8 4734.9 4752.7 4759.3 9583.1 9829.8 9838.7 9841.2 9879.3 5230.7 5245.6 5274.4 5283.8 5285.9 4133.3 4748.8 4803.0 4816.5 4827.4 3891.3 3893.7 3956.3 3991.4 4007.2 1291.4 1301.2 1304.4 1313.1 1315.7 749.7 854.8 888.5 891.8 908.8 4710.4 5555.7 5584.8 5749.8 5841.4 878.4 903.6 931.9 966.8 982.5 3764.3 3938.6 4069.3 4090.0 4101.6 10448.3 10591.2 10606.8 10622.3 10644.8 9894.6 10282.1 10324.1 10409.4 10576.7 7963.9 8204.7 8214.2 8240.0 8280.9 5696.7 5790.7 5791.2 5803.5 5968.4 8731.6 9552.2 9612.8 9614.1 9693.0 8649.2 9761.3 9767.2 9772.4 9821.6 6160.6 6736.5 6960.8 7267.5 7435.3 8094.4 8163.8 8298.5 8301.9 8323.7 6671.8 7237.3 7277.4 7480.1 7571.9 6268.9 7119.4 7321.1 7362.3 7473.6 6863.6 6991.0 7025.0 7035.5 7047.3 4809.5 4927.2 4929.6 4939.8 5025.0 4898.9 4945.0 4960.1 5052.4 5098.2 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#4] prototype.html Cycles:180 Average:4433.37 Median:4937.53 stddev:1353.50 (27.4%) stddev-sans-first:1321.25 09:41:27 INFO - PROCESS | 1918 | Values: 299.5 300.1 310.2 314.4 319.5 4781.3 5107.0 5166.8 5326.5 5501.0 5012.0 5317.4 5373.5 5382.5 5430.3 3594.4 4099.4 4119.3 4138.6 4173.6 3799.6 4061.6 4130.6 4148.9 4177.9 4013.4 4025.8 4035.5 4053.5 4055.2 4025.7 4044.8 4054.4 4065.3 4069.5 3516.3 3541.1 3541.7 3546.7 3554.5 4961.6 5134.8 5144.8 5188.3 5213.8 4082.8 4362.5 4614.8 4630.9 4665.3 4635.8 5323.8 5390.2 5665.5 5698.8 3232.7 3576.1 3596.3 3621.9 3832.6 5493.8 5654.8 5949.0 5964.5 5977.7 3898.7 3914.3 3926.5 3938.6 3954.2 3502.7 3848.1 3938.9 3956.2 3994.9 3686.0 4188.3 4605.9 4622.8 4669.2 5168.9 5411.4 5648.7 5726.4 5726.8 1058.7 1082.7 1232.7 1276.4 1283.0 848.3 872.7 881.4 882.6 882.7 4337.4 4407.3 4668.0 4909.0 4989.3 5023.6 5363.8 5524.4 5553.4 5567.3 4143.6 4730.9 4850.3 5102.6 5120.5 2578.5 2740.7 2878.4 2887.4 2908.0 4934.2 4952.6 4972.6 5161.7 5544.2 4607.9 4645.6 5182.4 5610.9 5788.9 5290.4 5515.1 5743.7 5758.0 5783.7 5503.8 5516.0 5542.9 5556.0 5565.4 4376.0 4710.0 5408.9 5420.7 5479.0 4651.6 4900.6 5059.4 5113.6 5536.3 3243.9 3477.7 3508.3 3732.5 3752.3 4188.4 4506.6 4821.9 4898.5 5556.7 5004.6 5383.4 5584.3 5601.5 5708.6 4923.6 5500.9 5708.5 5715.8 5724.9 5125.6 5291.5 5504.2 5585.6 5588.5 5661.6 5683.7 5691.5 5728.7 5729.7 4940.8 5327.1 5513.6 5593.3 5611.8 09:41:27 INFO - PROCESS | 1918 | 09:41:27 INFO - PROCESS | 1918 | [#5] yui.html Cycles:180 Average:20164.88 Median:50925.99 stddev:29994.39 (58.9%) stddev-sans-first:30042.88 09:41:27 INFO - PROCESS | 1918 | Values: 688.2 702.3 703.8 773.5 799.4 14827.5 15415.5 15468.6 15491.4 15529.8 13350.4 13382.6 13382.9 13394.3 13407.5 749.0 817.9 846.3 846.6 849.3 815.7 826.6 830.2 833.9 837.6 860.5 876.3 878.0 880.3 881.7 856.6 865.5 866.1 866.1 869.5 641.3 653.1 656.6 657.0 657.1 10855.9 11540.4 12641.9 12792.2 13220.9 11541.6 11690.9 11776.4 11841.7 11996.7 10343.4 10384.5 10555.6 10576.8 10964.1 3551.5 3605.1 3621.0 3622.2 3687.8 77118.6 87723.4 91557.5 93605.1 94376.0 8728.7 8831.9 8895.7 8967.5 9184.8 18765.0 18774.2 18833.2 18909.4 19089.6 7534.6 7782.1 7856.8 7878.2 7945.8 3692.4 4127.5 4211.9 4371.4 4429.4 3227.8 3423.5 3424.3 3429.2 3430.0 603.5 613.5 615.3 617.3 629.0 549.3 646.6 654.4 666.7 673.7 8978.2 9142.2 9225.2 9411.9 9478.8 584.2 665.7 666.4 676.7 688.5 3981.5 4167.6 4502.5 4507.4 4549.6 85242.0 114910.4 118772.4 120494.4 120921.0 64661.0 93420.6 97086.0 104268.0 105411.4 82480.6 82547.0 83275.2 85793.0 86846.1 9662.0 9726.9 9926.6 9927.0 9961.3 50660.0 51192.0 52694.0 52912.7 54784.7 58215.0 62215.4 72770.0 75384.0 76879.2 12512.4 12535.6 12547.0 12698.2 12759.7 13273.4 13558.3 13755.6 13904.9 14525.3 10425.5 12551.2 12711.4 12735.2 13159.9 11872.8 12047.3 12634.7 12831.0 12841.3 12682.2 12692.4 12718.8 12792.4 12794.2 11020.0 11104.9 11281.8 11470.9 11629.0 9894.5 10975.5 11094.0 11288.5 11350.1 09:41:27 INFO - PROCESS | 1918 | -------- Summary: end -------- 09:41:27 INFO - PROCESS | 1918 | 09:41:28 INFO - TEST-INFO | 1918: exit 0 09:41:28 INFO - TEST-OK | dromaeo_css | took 1116414ms 09:41:28 INFO - TEST-START | kraken 09:41:28 INFO - operating with platform_type : mac_ 09:41:28 INFO - Initialising browser for kraken test... 09:41:28 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpPeGXdE/profile http://localhost:53487/getInfo.html) 09:41:31 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 09:41:31 INFO - PROCESS | 1924 | colorDepth:24 09:41:31 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 09:41:31 INFO - PROCESS | 1924 | __metrics 09:41:31 ERROR - PROCESS | 1924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:41:32 INFO - TEST-INFO | 1924: exit 0 09:41:32 INFO - Browser initialized. 09:41:32 INFO - Running cycle 1/1 for kraken test... 09:41:32 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpPeGXdE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:44 INFO - PROCESS | 1926 | RSS: Main: 229511168 09:41:44 INFO - PROCESS | 1926 | 09:41:47 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53487/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:48 INFO - PROCESS | 1926 | RSS: Main: 241508352 09:41:48 INFO - PROCESS | 1926 | 09:41:51 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53487/tests/kraken/driver.html?testName=audio-dft) 09:41:51 INFO - PROCESS | 1926 | RSS: Main: 249028608 09:41:51 INFO - PROCESS | 1926 | 09:41:54 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53487/tests/kraken/driver.html?testName=audio-fft) 09:41:55 INFO - PROCESS | 1926 | RSS: Main: 252788736 09:41:55 INFO - PROCESS | 1926 | 09:41:57 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53487/tests/kraken/driver.html?testName=audio-oscillator) 09:41:58 INFO - PROCESS | 1926 | RSS: Main: 254386176 09:41:58 INFO - PROCESS | 1926 | 09:42:00 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:00 INFO - PROCESS | 1926 | RSS: Main: 254353408 09:42:00 INFO - PROCESS | 1926 | 09:42:03 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53487/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:04 INFO - PROCESS | 1926 | RSS: Main: 258826240 09:42:04 INFO - PROCESS | 1926 | 09:42:07 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53487/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:08 INFO - PROCESS | 1926 | RSS: Main: 257888256 09:42:08 INFO - PROCESS | 1926 | 09:42:11 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53487/tests/kraken/driver.html?testName=json-parse-financial) 09:42:11 INFO - PROCESS | 1926 | RSS: Main: 258334720 09:42:11 INFO - PROCESS | 1926 | 09:42:13 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:13 INFO - PROCESS | 1926 | RSS: Main: 257355776 09:42:13 INFO - PROCESS | 1926 | 09:42:15 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:16 INFO - PROCESS | 1926 | RSS: Main: 257511424 09:42:16 INFO - PROCESS | 1926 | 09:42:18 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:19 INFO - PROCESS | 1926 | RSS: Main: 257388544 09:42:19 INFO - PROCESS | 1926 | 09:42:22 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:23 INFO - PROCESS | 1926 | RSS: Main: 257642496 09:42:23 INFO - PROCESS | 1926 | 09:42:26 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:26 INFO - PROCESS | 1926 | RSS: Main: 265854976 09:42:26 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53487/tests/kraken/driver.html?testName=ai-astar) 09:42:28 INFO - PROCESS | 1926 | RSS: Main: 267296768 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | __start_tp_report 09:42:28 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 09:42:28 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 09:42:28 INFO - PROCESS | 1926 | |i|pagename|runs| 09:42:28 INFO - PROCESS | 1926 | |0;ai-astar;105;118;117;119;116;129;170;166;120;120 09:42:28 INFO - PROCESS | 1926 | |1;audio-beat-detection;150;120;114;151;114;118;118;119;176;116 09:42:28 INFO - PROCESS | 1926 | |2;audio-dft;199;197;195;196;195;199;200;197;199;210 09:42:28 INFO - PROCESS | 1926 | |3;audio-fft;84;57;58;82;61;60;58;58;77;59 09:42:28 INFO - PROCESS | 1926 | |4;audio-oscillator;88;72;97;84;68;57;109;97;101;120 09:42:28 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;107;74;78;76;103;102;78;76;117;131 09:42:28 INFO - PROCESS | 1926 | |6;imaging-darkroom;174;100;100;108;101;99;100;100;130;170 09:42:28 INFO - PROCESS | 1926 | |7;imaging-desaturate;90;100;85;87;87;88;121;145;91;97 09:42:28 INFO - PROCESS | 1926 | |8;json-parse-financial;54;55;53;57;55;59;58;58;59;58 09:42:28 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;67;78;103;68;104;104;102;105;74;71 09:42:28 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;87;88;84;86;88;86;88;87;89;85 09:42:28 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;151;164;167;165;164;163;174;161;218;164 09:42:28 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;168;155;207;167;170;167;168;166;167;170 09:42:28 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;62;85;87;90;88;77;68;67;69;86 09:42:28 INFO - PROCESS | 1926 | __end_tp_report 09:42:28 INFO - PROCESS | 1926 | __start_cc_report 09:42:28 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,986 09:42:28 INFO - PROCESS | 1926 | __end_cc_report 09:42:28 INFO - PROCESS | 1926 | __startTimestamp1480009348799__endTimestamp 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | ------- Summary: start ------- 09:42:28 INFO - PROCESS | 1926 | Number of tests: 14 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:128.00 Median:120.00 stddev:21.89 (18.2%) stddev-sans-first:21.58 09:42:28 INFO - PROCESS | 1926 | Values: 105.0 118.0 117.0 119.0 116.0 129.0 170.0 166.0 120.0 120.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:119.50 stddev:21.53 (18.0%) stddev-sans-first:21.53 09:42:28 INFO - PROCESS | 1926 | Values: 150.0 120.0 114.0 151.0 114.0 118.0 118.0 119.0 176.0 116.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:198.70 Median:199.00 stddev:4.35 (2.2%) stddev-sans-first:4.61 09:42:28 INFO - PROCESS | 1926 | Values: 199.0 197.0 195.0 196.0 195.0 199.0 200.0 197.0 199.0 210.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:10.96 (18.1%) stddev-sans-first:9.33 09:42:28 INFO - PROCESS | 1926 | Values: 84.0 57.0 58.0 82.0 61.0 60.0 58.0 58.0 77.0 59.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:78.00 stddev:19.47 (25.0%) stddev-sans-first:20.65 09:42:28 INFO - PROCESS | 1926 | Values: 88.0 72.0 97.0 84.0 68.0 57.0 109.0 97.0 101.0 120.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:75.00 stddev:20.47 (27.3%) stddev-sans-first:21.18 09:42:28 INFO - PROCESS | 1926 | Values: 107.0 74.0 78.0 76.0 103.0 102.0 78.0 76.0 117.0 131.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:118.20 Median:119.00 stddev:29.87 (25.1%) stddev-sans-first:23.90 09:42:28 INFO - PROCESS | 1926 | Values: 174.0 100.0 100.0 108.0 101.0 99.0 100.0 100.0 130.0 170.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:87.50 stddev:19.31 (22.1%) stddev-sans-first:20.20 09:42:28 INFO - PROCESS | 1926 | Values: 90.0 100.0 85.0 87.0 87.0 88.0 121.0 145.0 91.0 97.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:2.17 (3.7%) stddev-sans-first:2.09 09:42:28 INFO - PROCESS | 1926 | Values: 54.0 55.0 53.0 57.0 55.0 59.0 58.0 58.0 59.0 58.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:87.60 Median:67.50 stddev:17.15 (25.4%) stddev-sans-first:16.49 09:42:28 INFO - PROCESS | 1926 | Values: 67.0 78.0 103.0 68.0 104.0 104.0 102.0 105.0 74.0 71.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.50 stddev:1.55 (1.8%) stddev-sans-first:1.64 09:42:28 INFO - PROCESS | 1926 | Values: 87.0 88.0 84.0 86.0 88.0 86.0 88.0 87.0 89.0 85.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:169.10 Median:164.50 stddev:18.09 (11.0%) stddev-sans-first:17.96 09:42:28 INFO - PROCESS | 1926 | Values: 151.0 164.0 167.0 165.0 164.0 163.0 174.0 161.0 218.0 164.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:168.00 stddev:13.51 (8.0%) stddev-sans-first:14.30 09:42:28 INFO - PROCESS | 1926 | Values: 168.0 155.0 207.0 167.0 170.0 167.0 168.0 166.0 167.0 170.0 09:42:28 INFO - PROCESS | 1926 | 09:42:28 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:85.50 stddev:10.52 (12.3%) stddev-sans-first:9.46 09:42:28 INFO - PROCESS | 1926 | Values: 62.0 85.0 87.0 90.0 88.0 77.0 68.0 67.0 69.0 86.0 09:42:28 INFO - PROCESS | 1926 | -------- Summary: end -------- 09:42:28 INFO - PROCESS | 1926 | 09:42:29 INFO - TEST-INFO | 1926: exit 0 09:42:29 INFO - TEST-OK | kraken | took 61515ms 09:42:29 INFO - SUITE-END | took 1177s 09:42:29 INFO - Completed test suite (00:19:38) 09:42:29 INFO - javascript benchmark 09:42:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7197.570158997764, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.881074162404, 3401.4897765335195, 3431.416659167942, 3446.396880545904, 3452.8791492297773, 5169.870753231162, 5212.983468223698, 5717.856428714253, 5730.398308177644, 5873.442023007808, 5828.1840542324, 5908.497777688891, 5918.378570250126, 5931.347551769302, 5937.584369094165, 5348.304720386344, 5350.678959262456, 5350.785968561253, 5351.759170837312, 5388.78444862207, 5381.838544843661, 5406.40529541752, 5408.675479471244, 5414.242006119146, 5424.376196737367, 5209.244659524366, 5240.737963101848, 5380.838574842742, 5385.67685938843, 5397.46025397461, 5270.314859068335, 5287.629865909388, 5334.119870221409, 5392.460753924615, 5422.322209723785, 5190.896182076337, 5331.386890507563, 5334.733263336818, 5363.168708850135, 5376.354837419534, 5652.265205523297, 5898.216702491855, 5902.055671092605, 5963.761449542013, 6007.339192688801, 6121.696863452133, 6122.337166850137, 6178.07328900664, 6183.783567575113, 6235.563510554263, 6266.279377871512, 6270.686465676744, 6274.247090349141, 6278.748850045993, 6296.968515157395, 5934.792282270143, 5943.10853371989, 5962.403759624046, 5971.651346436507, 5978.910316345258, 6144.648177400964, 6174.567780255429, 6264.686765661699, 6277.874442511215, 6307.62154270736, 6144.402455361638, 6198.194234749454, 6229.0967809667345, 6234.844128896814, 6244.562880598314, 6245.313015568284, 6258.468030217483, 6261.154744109487, 6273.466755325757, 6278.968605156945, 6064.75740970365, 6105.511559075263, 6112.358202388774, 6160.9383906160365, 6188.597741146811, 6135.324535308531, 6148.047052706837, 6163.013917773134, 6178.351273116258, 6178.876422471525, 4940.0, 4943.876403089879, 4987.0, 5017.222330538772, 5028.622853286018, 4396.714213576107, 4416.315471101984, 4417.558244175557, 4437.378766972626, 4451.59935605797, 4346.0, 5678.602497825195, 5688.516476099495, 5940.6435613863305, 5948.940510594839, 5220.3735551734035, 5482.972585137049, 6043.700604370081, 6150.630962142286, 6243.8126856194385, 5392.0, 5413.756380962787, 5811.970940145272, 5902.114682797529, 5931.288245410578, 5463.289772329651, 5521.116621340566, 5524.0, 5529.502344788988, 5540.612157149041, 5331.893362132736, 6425.710843012169, 6434.613923164625, 6436.259830119596, 6475.222973243241, 5134.255532947627, 6132.202813634199, 6170.321264660974, 6186.412290832363, 6197.0, 6377.426031657174, 6402.711877965409, 6417.679116044085, 6438.420542151229, 6470.838229044311, 6187.504999600112, 6211.534134939807, 6216.627002379872, 6221.844453888508, 6231.844203894939, 6095.786647467317, 6141.578063794062, 6154.230721159855, 6218.720157592828, 6232.283287421823, 6097.634141951497, 6125.908111378422, 6147.616786223064, 6190.0, 6221.688915554295, 5025.422076461107, 6016.878308984536, 6175.135481032569, 6179.227596550431, 6193.535484838565, 5896.145058966512, 5944.286685597756, 5985.132155837467, 5991.490723288569, 6010.188624535806, 6067.059605760937, 6121.818815678001, 6124.295705993868, 6124.95875701123, 6129.695011270001, 5983.611065280743, 6051.5461340400525, 6111.908321375272, 6135.631862088289, 6137.0], "value": 5722.884991710668, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.2063778069488, 477.18877907557163, 481.4391234212143, 514.244061229992, 518.1398877862748, 29335.706642933565, 34309.31381372371, 38972.41541376878, 40283.395749063784, 40489.59510404895, 41439.37840932389, 41831.58168418315, 41837.0, 41883.58116418835, 41909.580904191025, 9162.816743665122, 9244.399114057565, 9306.883174019093, 9352.766180845465, 9380.765480862965, 9311.487868167249, 9402.670906518273, 9406.764830879214, 9410.153086222239, 9449.858252126223, 9367.953160234223, 9424.38741481805, 9424.81150376992, 9428.81142377152, 9448.622055117787, 9302.581383837709, 9376.249900008017, 9387.718368448957, 9390.765230869283, 9399.718008459757, 9255.583498742573, 9294.442333459947, 9316.301277404154, 9323.533823308875, 9350.71947841559, 38999.41500877461, 39066.41400378996, 39199.41200881989, 39274.0, 39330.803345983375, 3184.7611429142908, 3322.933541329184, 3331.4503106987318, 3341.983290083534, 3366.5286859839644, 28053.71946280552, 28420.715792842013, 28543.57184642232, 28565.28586785347, 29133.271668208254, 3043.8630261638277, 3236.0453666168537, 3251.1872031992, 3262.934741305184, 3315.336932613463, 413492.0, 504757.0, 514050.0, 519321.0, 524927.0, 61087.694561527795, 61665.691671542256, 61900.38099618946, 61975.0, 62129.37870621326, 59802.70098649479, 64545.67727161334, 64696.67651661712, 64901.67549162224, 64914.0, 16253.756193657104, 16406.425775097814, 16508.25712842925, 16532.586685332964, 16541.917290413472, 12673.239605623692, 12674.873251267554, 12684.112112152245, 12694.873051269555, 12720.93639531815, 18269.689796199473, 18519.72220416695, 18830.905845470686, 18873.52816179579, 19004.334848280243, 3155.668654791214, 3262.7226685731503, 3268.6894744999186, 7330.780076597711, 7583.810404739816, 916.706653870755, 946.394307643109, 1038.672818062308, 1055.6991257491732, 1074.7259448840496, 29084.709152908625, 29459.705402946125, 29630.259243518653, 29944.0, 30269.848650756605, 896.5024411451576, 906.7007887397143, 1046.3146638951498, 1069.155367259856, 1069.9251052426412, 15075.924620377047, 15486.690266194613, 15519.617158235544, 15624.609384765472, 15825.208739562975, 700239.0, 703131.0, 706809.0, 708605.0, 709655.0, 53693.73153134209, 54416.45583544193, 54794.0, 54902.17646735302, 55169.0, 1342.5502456676927, 1358.1918758338772, 1377.091119860887, 1378.8827949624394, 1383.522684673806, 28508.57237141486, 29253.0, 29292.267693307836, 29385.853070735364, 29810.701892980793, 49751.00497990092, 50222.74443138805, 50433.74783126061, 50553.0, 51543.226851598, 434593.6540634553, 534913.0, 538263.0, 541478.0, 541992.0, 26235.868820655774, 26366.472670546096, 26464.603030954935, 26619.068332608265, 26733.0, 45669.0, 45895.082098358514, 46109.0, 46141.53858461372, 47030.178189308754, 38254.0, 38342.23315533618, 38636.0, 38984.415233770946, 39349.83575903353, 38113.61886381212, 38756.224875501764, 39115.413268800425, 39415.0, 39596.0, 37123.62876371202, 37544.06139846526, 37794.62205377911, 37836.43245351377, 38515.42226866655, 33749.66250337465, 33916.660833391354, 34433.48349774705, 34544.654553454144, 34778.82610586931, 24723.87638061798, 25460.0, 25713.614295785203, 25780.61329080103, 25995.870020649774], "value": 19496.2007233201, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.86316336628715, 377.831864820155, 385.1834111683232, 389.56368866869076, 405.42024904386716, 18290.993995330253, 19754.703679444785, 20340.491487712814, 20389.694154587694, 20529.076191571377, 19299.614007719836, 19583.510412239702, 20043.599128017468, 20260.392188234375, 20424.89787551064, 5808.303003639569, 5897.112923864365, 5920.615160014607, 5951.375105613914, 6036.9396306036815, 5848.883022339551, 6000.699965001754, 6006.129111278862, 6006.7897623583185, 6009.909851352211, 3956.6834653227675, 4133.813978370966, 4336.176126535964, 4369.453818272716, 5463.31708536433, 6534.509911756613, 6573.704183311763, 6642.269350371455, 6701.832454188636, 6718.42893354063, 5683.3464151622675, 5817.272840894888, 5830.4169583041785, 5835.270591176103, 5843.9707801461145, 21548.245811396526, 23244.0, 25573.104941326965, 25742.356441088934, 25792.61311080335, 2172.576347612216, 2232.564649893255, 2459.323685986368, 2591.481703659276, 2834.744872961423, 13236.338183090807, 14960.551183464513, 14962.551123466314, 15186.240687965668, 15231.0, 1843.769528808899, 1948.5615736459324, 1959.7256384106236, 1960.0, 1982.9900850495799, 95406.0459395404, 103072.0, 109882.0, 124041.37979310135, 126737.36631316876, 10090.243231757648, 10793.892061079447, 11009.119270458345, 11269.323840569592, 11287.097032237401, 11870.703232419259, 14167.0, 14189.0, 14223.786643200361, 14247.287635618177, 8344.958275208706, 8608.65565377378, 8681.348898832613, 8782.60478278479, 8791.428557143765, 8639.870401943976, 8675.305975521944, 8702.260307873776, 8797.428167169113, 8818.721285413707, 6690.264070952191, 6900.413464855544, 6911.205211400653, 6913.619750913647, 6916.23921368649, 1864.655038817823, 1913.6077104193607, 1915.339207973247, 1918.3669389101563, 1919.2610844824842, 879.8020445399734, 936.2042264075482, 955.3264948211494, 968.1141755293968, 1000.3747657713928, 20697.896510517352, 21178.576428471653, 22165.335039948826, 22239.77760222377, 22363.44091397728, 933.1786334958334, 956.5217391304348, 980.2648013989508, 1009.6314845081639, 1028.7068185567227, 11319.490622921989, 11588.14024722695, 11609.6517104487, 11686.415679216005, 11705.297682139098, 624788.0, 625679.0, 634105.0, 640758.0, 643094.0, 114899.0, 119170.0, 128580.71419285687, 131102.93386374938, 138205.3089734545, 968.9951550242204, 977.7848873248016, 992.8262554053011, 993.4933184076173, 993.9453330066916, 19001.90499047496, 19412.126454309873, 19628.509287267934, 19635.41093767189, 19717.309894153637, 52634.0, 53883.0, 54310.0, 54351.184732228256, 56120.0, 71486.0, 73798.0, 75362.0, 75785.0, 76419.61790191014, 7590.278923502258, 7702.614869256403, 7738.264864837832, 7845.803854903673, 7857.371410287277, 9527.952360238154, 11745.060395168195, 11780.116491263361, 11869.881301186877, 12038.879611204125, 10191.337563058378, 10205.336653117523, 10295.485225738832, 10370.688879333633, 10626.787464250827, 10059.69820905374, 10118.139958103644, 10567.313124646873, 10577.576896924036, 10663.8933610666, 8408.915910840813, 9527.57125929321, 10229.181665466893, 10354.637587684394, 10786.191035672513, 6864.553804002724, 7586.810329741801, 7684.269994350528, 8133.8373232536205, 8201.179882011751, 9706.805863882824, 10301.536430860779, 10370.844437333597, 10537.73655658584, 10544.89455105439], "value": 9653.404568641432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.5939907126467, 1477.0989696285264, 1533.2180587900168, 1550.155165434838, 1800.784470482424, 7105.751298704547, 7227.9277207227915, 8224.50652960822, 8706.998695150052, 8708.042115367312, 8231.711890083849, 8585.656573737044, 8610.009848867383, 8641.611127499262, 8675.47947123173, 2078.1375729072415, 2288.473651060257, 2337.041812856729, 2337.275444612167, 2340.8829558522007, 2333.7899589036983, 2353.8116950643907, 2356.7761062699014, 2403.038784486202, 2408.8434251773665, 2090.634139025672, 2287.7025986621716, 2317.5249073939804, 2326.2672258238686, 2344.988275058622, 2242.405762472938, 2328.9767102329097, 2332.416895776056, 2349.6710460535537, 2358.858468491896, 2349.89425475854, 2371.2530552875787, 2373.0270589058578, 2376.2277259890607, 2383.4398916254668, 8585.0, 8604.35467339952, 8662.956685216597, 8719.389642725011, 8719.433236839584, 4848.321235027099, 4857.82997595086, 5111.744412779383, 5282.234076058989, 5290.867728306785, 3310.586176727909, 3463.7229021678204, 3512.1570823002294, 3625.655562721537, 3649.105969037603, 1058.687687132298, 1072.3405105859918, 1084.9186311026626, 1088.771358014818, 1099.1536516881956, 11334.60328888485, 11341.829872551836, 11369.0, 11485.0, 11491.195616306863, 4575.872219417986, 4666.836660716858, 4734.881627959328, 4752.714837109785, 4759.309900064541, 9583.089606487372, 9829.80340393188, 9838.65564705232, 9841.163501102486, 9879.308448408687, 5230.686158830483, 5245.632805703564, 5274.393444753826, 5283.841484755463, 5285.920711189336, 4133.318002529609, 4748.810047598057, 4802.991371811889, 4816.494268101869, 4827.42070951488, 3891.299566078133, 3893.707971902062, 3956.3076461619103, 3991.381335892941, 4007.198560287954, 1291.4317700211877, 1301.2452777389092, 1304.4325718312564, 1313.0546006875036, 1315.684235783405, 749.7076140305285, 854.7563944275852, 888.5113187746714, 891.7681402835309, 908.8182363527321, 4710.36410084641, 5555.749991250404, 5584.804531841366, 5749.770009199585, 5841.357450680422, 878.3631866896577, 903.5708038681705, 931.9394239374554, 966.8308046091905, 982.4596471940404, 3764.3412402829395, 3938.6061393860386, 4069.328560787437, 4089.9959020079946, 4101.610347017028, 10448.32085914413, 10591.205659575562, 10606.840897386546, 10622.256442049136, 10644.84032739494, 9894.554745036347, 10282.126019288295, 10324.12244959172, 10409.375437473776, 10576.735581610521, 7963.8805417918775, 8204.712835050865, 8214.219649133323, 8239.970003749531, 8280.917190828135, 5696.686682232517, 5790.652560846363, 5791.247137872049, 5803.47768700819, 5968.403159683997, 8731.607077681392, 9552.23582113443, 9612.807743844944, 9614.134727874525, 9693.0, 8649.221570058726, 9761.267904907018, 9767.218622510325, 9772.364796288219, 9821.607135714492, 6160.568760186744, 6736.461083113241, 6960.79117626472, 7267.527610705287, 7435.256474352522, 8094.392920530866, 8163.755087347389, 8298.543580103153, 8301.875471867806, 8323.708670196515, 6671.766488172891, 7237.276272372721, 7277.38142257914, 7480.0649918760155, 7571.886421703569, 6268.937310626835, 7119.394851437686, 7321.12146542397, 7362.263773622809, 7473.551586904803, 6863.588184708933, 6991.0, 7025.01649769043, 7035.47233957445, 7047.330503602149, 4809.519048095162, 4927.236278376858, 4929.5809856161195, 4939.75301234944, 5025.0, 4898.926516102332, 4944.950550494449, 4960.082384758831, 5052.418971818141, 5098.2352647103235], "value": 4501.020640809353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.49086552860143, 300.0787582122883, 310.20432590405596, 314.42617223567, 319.50636266967535, 4781.298566310033, 5107.0296643637685, 5166.819161329354, 5326.547243484304, 5501.0098182327165, 5011.974940125303, 5317.41508434072, 5373.489518495747, 5382.461753824616, 5430.321209848769, 3594.370985077614, 4099.385092236166, 4119.320312148507, 4138.565450627686, 4173.56177601352, 3799.5630502492154, 4061.57353477885, 4130.648894843926, 4148.917021659565, 4177.9373309400235, 4013.3779264214095, 4025.75845449274, 4035.4955630546183, 4053.4730485036903, 4055.2092341993325, 4025.691650213663, 4044.757314561136, 4054.432379466877, 4065.337204131269, 4069.4709687740406, 3516.261585067139, 3541.11472131967, 3541.698955588778, 3546.6985306249, 3554.4668299754985, 4961.561147267288, 5134.8202812901745, 5144.761508019167, 5188.299579556787, 5213.843584692465, 4082.836686532535, 4362.454693163355, 4614.792334344963, 4630.86107416778, 4665.253559430509, 4635.791389387452, 5323.813666521653, 5390.21841832932, 5665.535492060967, 5698.800541981052, 3232.7090561849545, 3576.123849656825, 3596.2627661329366, 3621.8732344367822, 3832.559255685604, 5493.7802487900435, 5654.773809047633, 5948.97025514874, 5964.522838172936, 5977.731002104916, 3898.688104951597, 3914.336407027002, 3926.489556357655, 3938.5667576566557, 3954.189391174802, 3502.7372947029075, 3848.134169811826, 3938.901527461779, 3956.188981258835, 3994.8801535953967, 3685.963140368562, 4188.28799104153, 4605.917609361797, 4622.791974361162, 4669.2062349400685, 5168.94036722471, 5411.404745477994, 5648.74580643872, 5726.427357264323, 5726.828195154152, 1058.6718117383482, 1082.680609220282, 1232.679503329141, 1276.425608476171, 1283.0249010751709, 848.3467729847982, 872.6596627315353, 881.4358810361374, 882.5587206396801, 882.6910581296623, 4337.392765012901, 4407.3168658857285, 4668.043051174569, 4909.0, 4989.251612258117, 5023.598112151019, 5363.785448582091, 5524.447555244444, 5553.361363443175, 5567.331920169606, 4143.647789937829, 4730.858074257778, 4850.296706977469, 5102.550775627719, 5120.539151476385, 2578.510083084208, 2740.670085845707, 2878.424315136981, 2887.4080813433197, 2908.0, 4934.235193545006, 4952.626400355654, 4972.627052971042, 5161.66449180802, 5544.22380866679, 4607.8573463339035, 4645.581897629229, 5182.434694826085, 5610.887782244414, 5788.913166302509, 5290.365156181283, 5515.090010148441, 5743.655380677173, 5758.013485347548, 5783.739731712083, 5503.8259887345075, 5516.0, 5542.861428464159, 5556.0, 5565.415631358649, 4375.956240437555, 4709.9529004710885, 5408.864778380572, 5420.674759514442, 5479.000164939848, 4651.558101980307, 4900.583450406612, 5059.367579052619, 5113.565346945551, 5536.287219262613, 3243.90207351983, 3477.7043951264427, 3508.280802435546, 3732.480575611397, 3752.343339915449, 4188.434561334181, 4506.571875671937, 4821.879453013703, 4898.510148985073, 5556.666600003851, 5004.649674522749, 5383.353997520323, 5584.274044374205, 5601.467860553241, 5708.628939118944, 4923.5814955729165, 5500.917486237629, 5708.514776244066, 5715.799947001835, 5724.885502290014, 5125.616588286464, 5291.470852914677, 5504.174373843955, 5585.581081418829, 5588.469095435927, 5661.603687741818, 5683.708799856082, 5691.516221121251, 5728.713564321851, 5729.742161602821, 4940.827071052496, 5327.135502574068, 5513.636681624286, 5593.300837395325, 5611.803586874603], "value": 3999.2983810242094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.2119972631338, 702.3117345001899, 703.8064532253633, 773.5474747272846, 799.3525244551912, 14827.481038163667, 15415.537533873974, 15468.613284667888, 15491.380344786196, 15529.844701552982, 13350.399232034557, 13382.598522044329, 13382.933085334584, 13394.330283485835, 13407.463701451954, 748.9888650322076, 817.889584906039, 846.3440833354139, 846.6359465429863, 849.3375167369462, 815.7022686719334, 826.6280173921729, 830.1698301698302, 833.9374546908975, 837.6440012994483, 860.5181098584782, 876.2814492116468, 877.999081047603, 880.2913654508119, 881.6914080071988, 856.6145234644373, 865.5066612031113, 866.0733015673233, 866.1252135343285, 869.4565896314804, 641.3202005873788, 653.0987237612065, 656.6421300391298, 656.993430065698, 657.1194599236998, 10855.891441085567, 11540.422978851107, 12641.873581264254, 12792.232466052066, 13220.933895330558, 11541.596044138414, 11690.941545292219, 11776.41117944108, 11841.703957401047, 11996.70008249792, 10343.37939723619, 10384.532696028697, 10555.630552930686, 10576.788464230749, 10964.122870170368, 3551.4672799080085, 3605.13476765577, 3620.9637903621156, 3622.166901612644, 3687.797171155585, 77118.61440692817, 87723.36829895049, 91557.54221228918, 93605.06394936031, 94376.0, 8728.650853965897, 8831.867521987175, 8895.688650897187, 8967.461952282754, 9184.770380740534, 18765.0, 18774.249030038918, 18833.24667013304, 18909.43271701851, 19089.618207636046, 7534.623268836646, 7782.105057918298, 7856.803579910434, 7878.172791856887, 7945.761627151194, 3692.4461330800596, 4127.545969943304, 4211.894702632459, 4371.366151907955, 4429.402030725811, 3227.8063316200632, 3423.5207071010077, 3424.3493736190044, 3429.228423604669, 3429.9828500857334, 603.5202014398564, 613.5122577550858, 615.2678312807744, 617.2901163661825, 628.9842753931097, 549.2722143160329, 646.6217262901162, 654.4404534123352, 666.6933210723025, 673.7069374821968, 8978.236849867835, 9142.222911052502, 9225.169734723908, 9411.90588094124, 9478.810423791623, 584.2414332858127, 665.7170702451439, 666.4368608525788, 676.7157793726647, 688.5455599304435, 3981.5023122109737, 4167.624913757716, 4502.527234640381, 4507.3915021471685, 4549.567791059844, 85242.0, 114910.4254478739, 118772.40613797048, 120494.39752801355, 120921.0, 64661.03008454877, 93420.5986910197, 97086.0291397091, 104268.0, 105411.41882871764, 82480.58759706163, 82547.0, 83275.16724832795, 85793.0, 86846.13153868506, 9662.0, 9726.902730972599, 9926.602935882484, 9927.0, 9961.302708810314, 50659.986800263054, 51192.0, 52694.0, 52912.735436322575, 54784.72607636936, 58215.0, 62215.37784622096, 72770.0, 75384.0, 76879.2312076872, 12512.37438128108, 12535.561255356019, 12547.0, 12698.174618649758, 12759.681007974503, 13273.402696878857, 13558.322083895568, 13755.587332380044, 13904.860951390761, 14525.27373631293, 10425.478726063819, 12551.246925184518, 12711.36443177819, 12735.172213806072, 13159.868401316247, 11872.821907671565, 12047.33739644328, 12634.684132896384, 12831.037672174438, 12841.293728845003, 12682.175658582162, 12692.365381730691, 12718.809217861924, 12792.424340904496, 12794.168379055332, 11020.0, 11104.944475277895, 11281.774364512828, 11470.942645286721, 11629.0, 9894.505274736379, 10975.451227438436, 11094.015386152527, 11288.49201785938, 11350.148738844455], "value": 7170.151975490645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 117.0, 119.0, 116.0, 129.0, 170.0, 166.0, 120.0, 120.0], "value": 128.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 114.0, 151.0, 114.0, 118.0, 118.0, 119.0, 176.0, 116.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 195.0, 196.0, 195.0, 199.0, 200.0, 197.0, 199.0, 210.0], "value": 198.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 58.0, 82.0, 61.0, 60.0, 58.0, 58.0, 77.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 97.0, 84.0, 68.0, 57.0, 109.0, 97.0, 101.0, 120.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 74.0, 78.0, 76.0, 103.0, 102.0, 78.0, 76.0, 117.0, 131.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 100.0, 100.0, 108.0, 101.0, 99.0, 100.0, 100.0, 130.0, 170.0], "value": 118.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 100.0, 85.0, 87.0, 87.0, 88.0, 121.0, 145.0, 91.0, 97.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 57.0, 55.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 103.0, 68.0, 104.0, 104.0, 102.0, 105.0, 74.0, 71.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 84.0, 86.0, 88.0, 86.0, 88.0, 87.0, 89.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 164.0, 167.0, 165.0, 164.0, 163.0, 174.0, 161.0, 218.0, 164.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 155.0, 207.0, 167.0, 170.0, 167.0, 168.0, 166.0, 167.0, 170.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 85.0, 87.0, 90.0, 88.0, 77.0, 68.0, 67.0, 69.0, 86.0], "value": 77.9, "unit": "score"}]}]} 09:42:30 INFO - Return code: 0 09:42:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:42:30 ERROR - # TBPL SUCCESS # 09:42:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:42:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:42:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:42:30 INFO - 2016-11-24 09:42:30.120 screenresolution[1931:18882] starting screenresolution argv=screenresolution get 09:42:30 INFO - 2016-11-24 09:42:30.123 screenresolution[1931:18882] Display 0: 1600x1200x32@60 09:42:30 INFO - 2016-11-24 09:42:30.130 screenresolution[1932:18885] starting screenresolution argv=screenresolution list 09:42:30 INFO - Available Modes on Display 0 09:42:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:42:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:42:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:42:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:42:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:42:30 INFO - Intel Iris: 09:42:30 INFO - Chipset Model: Intel Iris 09:42:30 INFO - Type: GPU 09:42:30 INFO - Bus: Built-In 09:42:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:42:30 INFO - Vendor: Intel (0x8086) 09:42:30 INFO - Device ID: 0x0a2e 09:42:30 INFO - Revision ID: 0x0009 09:42:30 INFO - Displays: 09:42:30 INFO - Display: 09:42:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:42:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:42:30 INFO - Display Serial Number: 1600x1200 60 09:42:30 INFO - Main Display: Yes 09:42:30 INFO - Mirror: Off 09:42:30 INFO - Online: Yes 09:42:30 INFO - Rotation: Supported 09:42:30 INFO - Return code: 0 09:42:30 INFO - Running post-action listener: _resource_record_post_action 09:42:30 INFO - [mozharness: 2016-11-24 17:42:30.374014Z] Finished run-tests step (success) 09:42:30 INFO - Running post-run listener: _resource_record_post_run 09:42:30 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 749568; Write bytes: 655410176; Read time: 14; Write time: 1879 09:42:30 INFO - TinderboxPrint: CPU usage
54.7% 09:42:30 INFO - TinderboxPrint: I/O read bytes / time
749,568 / 14 09:42:30 INFO - TinderboxPrint: I/O write bytes / time
655,410,176 / 1,879 09:42:30 INFO - TinderboxPrint: CPU idle
2,193.0 (45.3%) 09:42:30 INFO - TinderboxPrint: CPU system
982.7 (20.3%) 09:42:30 INFO - TinderboxPrint: CPU user
1,662.0 (34.4%) 09:42:30 INFO - TinderboxPrint: Swap in / out
349,298,688 / 0 09:42:30 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349030912; Write bytes: 351430656; Read time: 26956; Write time: 737 09:42:30 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 593920; Write bytes: 302566400; Read time: 12; Write time: 1133 09:42:30 INFO - Running post-run listener: _upload_blobber_files 09:42:30 INFO - Blob upload gear active. 09:42:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:30 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 09:42:30 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:42:30 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:42:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:31 INFO - (blobuploader) - INFO - Done attempting. 09:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:42:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:33 INFO - (blobuploader) - INFO - Done attempting. 09:42:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:42:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:36 INFO - (blobuploader) - INFO - Done attempting. 09:42:36 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:36 INFO - Return code: 0 09:42:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fbbe428091bc89a6c8c7b196205010067118d5178a2aa0d11f8c9f56128f400889910a26afdd96b5dfb56df47c4b418113fc7508d912cf30ec15ee77f98276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c78b98449dc4c2e91b7f59f63fc7323b0d9451cb3fa672b2df8521a059bbf9dfe4fc81e0c6ded0c3150ff96d0b152bf2a48787c1bbb446720948ba97b3e0c2c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c38eb798525215bac67abf92c3a1c44611743988e812b88a234e534c696a1cc60e51db2c8593c72bfcc2a35ee8a605ec9caf74fd55405a43e48f875e11bcc9a"} 09:42:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:36 INFO - Contents: 09:42:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fbbe428091bc89a6c8c7b196205010067118d5178a2aa0d11f8c9f56128f400889910a26afdd96b5dfb56df47c4b418113fc7508d912cf30ec15ee77f98276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c78b98449dc4c2e91b7f59f63fc7323b0d9451cb3fa672b2df8521a059bbf9dfe4fc81e0c6ded0c3150ff96d0b152bf2a48787c1bbb446720948ba97b3e0c2c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c38eb798525215bac67abf92c3a1c44611743988e812b88a234e534c696a1cc60e51db2c8593c72bfcc2a35ee8a605ec9caf74fd55405a43e48f875e11bcc9a"} 09:42:36 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:36 INFO - Copying logs to upload dir... 09:42:36 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.412632 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-24 09:42:36.089076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:42:36.093139) ========= 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.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fbbe428091bc89a6c8c7b196205010067118d5178a2aa0d11f8c9f56128f400889910a26afdd96b5dfb56df47c4b418113fc7508d912cf30ec15ee77f98276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c78b98449dc4c2e91b7f59f63fc7323b0d9451cb3fa672b2df8521a059bbf9dfe4fc81e0c6ded0c3150ff96d0b152bf2a48787c1bbb446720948ba97b3e0c2c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c38eb798525215bac67abf92c3a1c44611743988e812b88a234e534c696a1cc60e51db2c8593c72bfcc2a35ee8a605ec9caf74fd55405a43e48f875e11bcc9a"} build_url:https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010515 build_url: 'https://queue.taskcluster.net/v1/task/e0ek61HuSpqpUqKl1-mBIg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fbbe428091bc89a6c8c7b196205010067118d5178a2aa0d11f8c9f56128f400889910a26afdd96b5dfb56df47c4b418113fc7508d912cf30ec15ee77f98276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c78b98449dc4c2e91b7f59f63fc7323b0d9451cb3fa672b2df8521a059bbf9dfe4fc81e0c6ded0c3150ff96d0b152bf2a48787c1bbb446720948ba97b3e0c2c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c38eb798525215bac67abf92c3a1c44611743988e812b88a234e534c696a1cc60e51db2c8593c72bfcc2a35ee8a605ec9caf74fd55405a43e48f875e11bcc9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:42:36.126241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:42:36.126566) ========= 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.6FBfv4W44g/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.RMVZz0eUbG/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:42:36.175341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:42:36.175646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:42:36.175962) ========= ========= Total master_lag: 0.18 =========