builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0357 starttime: 1474584111.97 results: success (0) buildid: 20160922133959 builduid: 39088cd23bf84551a3185f3bf81a3349 revision: ef567dcc1de7f603ea78c2463d9d77897b6797da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:51.966057) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:51.966510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:51.966788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:51.993246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:51.993592) ========= 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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-09-22 15:41:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.34M=0.001s 2016-09-22 15:41:52 (9.34 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:52.107265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:52.107590) ========= 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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.020655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:52.159782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 15:41:52.163149) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef567dcc1de7f603ea78c2463d9d77897b6797da --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 ef567dcc1de7f603ea78c2463d9d77897b6797da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-09-22 15:41:52,242 truncating revision to first 12 chars 2016-09-22 15:41:52,243 Setting DEBUG logging. 2016-09-22 15:41:52,243 attempt 1/10 2016-09-22 15:41:52,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef567dcc1de7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 15:41:53,231 unpacking tar archive at: mozilla-aurora-ef567dcc1de7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.257062 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 15:41:53.446027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:53.446520) ========= script_repo_revision: ef567dcc1de7f603ea78c2463d9d77897b6797da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:53.447021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:53.447307) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:41:53.467041) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-22 15:41:53.467708) ========= /tools/buildbot/bin/python 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', '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:41:53 INFO - MultiFileLogger online at 20160922 15:41:53 in /builds/slave/test 15:41:53 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 15:41:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:53 INFO - {'append_to_log': False, 15:41:53 INFO - 'base_work_dir': '/builds/slave/test', 15:41:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:41:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:53 INFO - 'branch': 'Mozilla-Aurora', 15:41:53 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:53 INFO - 'config_files': ('talos/mac_config.py',), 15:41:53 INFO - 'default_actions': ('clobber', 15:41:53 INFO - 'read-buildbot-config', 15:41:53 INFO - 'download-and-extract', 15:41:53 INFO - 'populate-webroot', 15:41:53 INFO - 'create-virtualenv', 15:41:53 INFO - 'install', 15:41:53 INFO - 'run-tests'), 15:41:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:53 INFO - 'download_minidump_stackwalk': True, 15:41:53 INFO - 'download_symbols': 'ondemand', 15:41:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:53 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:53 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:53 INFO - 'installer_path': 'installer.exe', 15:41:53 INFO - 'log_level': 'info', 15:41:53 INFO - 'log_name': 'talos', 15:41:53 INFO - 'log_to_console': True, 15:41:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:41:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:41:53 INFO - 'opt_config_files': (), 15:41:53 INFO - 'pip_index': False, 15:41:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:41:53 INFO - 'cmd': ('bash', 15:41:53 INFO - '-c', 15:41:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:41:53 INFO - 'enabled': True, 15:41:53 INFO - 'halt_on_failure': False, 15:41:53 INFO - 'name': 'check_screen_resolution'},), 15:41:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:41:53 INFO - 'cmd': ('bash', 15:41:53 INFO - '-c', 15:41:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:41:53 INFO - 'enabled': True, 15:41:53 INFO - 'halt_on_failure': False, 15:41:53 INFO - 'name': 'check_screen_resolution'},), 15:41:53 INFO - 'run_cmd_checks_enabled': True, 15:41:53 INFO - 'sps_profile': False, 15:41:53 INFO - 'sps_profile_interval': 0, 15:41:53 INFO - 'suite': 'dromaeojs-e10s', 15:41:53 INFO - 'system_bits': '32', 15:41:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:53 INFO - 'title': 't-yosemite-r7-0357', 15:41:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:53 INFO - 'use_talos_json': True, 15:41:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:53 INFO - 'work_dir': 'build'} 15:41:53 INFO - [mozharness: 2016-09-22 22:41:53.663132Z] Running clobber step. 15:41:53 INFO - Running pre-action listener: _resource_record_pre_action 15:41:53 INFO - Running main action method: clobber 15:41:53 INFO - rmtree: /builds/slave/test/build 15:41:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:55 INFO - Running post-action listener: _resource_record_post_action 15:41:55 INFO - [mozharness: 2016-09-22 22:41:55.439348Z] Finished clobber step (success) 15:41:55 INFO - [mozharness: 2016-09-22 22:41:55.439478Z] Running read-buildbot-config step. 15:41:55 INFO - Running pre-action listener: _resource_record_pre_action 15:41:55 INFO - Running main action method: read_buildbot_config 15:41:55 INFO - Using buildbot properties: 15:41:55 INFO - { 15:41:55 INFO - "project": "", 15:41:55 INFO - "product": "firefox", 15:41:55 INFO - "script_repo_revision": "production", 15:41:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 15:41:55 INFO - "repository": "", 15:41:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 15:41:55 INFO - "buildid": "20160922133959", 15:41:55 INFO - "pgo_build": "False", 15:41:55 INFO - "basedir": "/builds/slave/test", 15:41:55 INFO - "buildnumber": 127, 15:41:55 INFO - "slavename": "t-yosemite-r7-0357", 15:41:55 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:41:55 INFO - "platform": "yosemite_r7", 15:41:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:41:55 INFO - "branch": "mozilla-aurora", 15:41:55 INFO - "repo_path": "releases/mozilla-aurora", 15:41:55 INFO - "revision": "ef567dcc1de7f603ea78c2463d9d77897b6797da", 15:41:55 INFO - "stage_platform": "macosx64", 15:41:55 INFO - "builduid": "39088cd23bf84551a3185f3bf81a3349", 15:41:55 INFO - "slavebuilddir": "test" 15:41:55 INFO - } 15:41:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:41:55 INFO - Running post-action listener: _resource_record_post_action 15:41:55 INFO - [mozharness: 2016-09-22 22:41:55.442805Z] Finished read-buildbot-config step (success) 15:41:55 INFO - [mozharness: 2016-09-22 22:41:55.442912Z] Running download-and-extract step. 15:41:55 INFO - Running pre-action listener: _resource_record_pre_action 15:41:55 INFO - Running main action method: download_and_extract 15:41:55 INFO - mkdir: /builds/slave/test/build/tests 15:41:55 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')]} 15:41:55 INFO - trying https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:41:55 INFO - Downloading https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:41:56 INFO - Downloaded 1199 bytes. 15:41:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:41:56 INFO - Using the following test package requirements: 15:41:56 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:41:56 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:41:56 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:41:56 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'jsshell-mac.zip'], 15:41:56 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:41:56 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:41:56 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:41:56 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:41:56 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:41:56 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:41:56 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:41:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:41:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:41:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:41:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:41:57 INFO - Expected file size: 16426592 15:42:04 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:42:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:42:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:42:04 INFO - Fetch https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:42:04 INFO - Expected file size: 16426592 15:42:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:42:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:42:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:42:12 INFO - Expected file size: 14414059 15:42: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')]} 15:42:12 INFO - trying https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:42:15 INFO - Downloaded 115245753 bytes. 15:42:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:42:15 INFO - mkdir: /builds/slave/test/properties 15:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:15 INFO - Contents: 15:42:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:42:16 INFO - Running post-action listener: _resource_record_post_action 15:42:16 INFO - Running post-action listener: set_extra_try_arguments 15:42:16 INFO - [mozharness: 2016-09-22 22:42:16.209586Z] Finished download-and-extract step (success) 15:42:16 INFO - [mozharness: 2016-09-22 22:42:16.209737Z] Running populate-webroot step. 15:42:16 INFO - Running pre-action listener: _resource_record_pre_action 15:42:16 INFO - Running main action method: populate_webroot 15:42:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:42:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:42:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:42:16 INFO - '--tppagecycles', 15:42:16 INFO - '7'], 15:42:16 INFO - 'tests': ['tsvgm']}}, 15:42:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:42:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:42:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:42:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:42:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['damp', 'tps']}, 15:42:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'tests': ['damp', 'tps']}, 15:42:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['dromaeo_dom']}, 15:42:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['basic_compositor_video']}, 15:42:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:42:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['a11yr', 15:42:16 INFO - 'ts_paint', 15:42:16 INFO - 'tpaint', 15:42:16 INFO - 'sessionrestore', 15:42:16 INFO - 'sessionrestore_no_auto_restore', 15:42:16 INFO - 'tabpaint']}, 15:42:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['tsvgx', 15:42:16 INFO - 'tsvgr_opacity', 15:42:16 INFO - 'tart', 15:42:16 INFO - 'tscrollx', 15:42:16 INFO - 'cart']}, 15:42:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:42:16 INFO - 'tsvgr_opacity', 15:42:16 INFO - 'tart', 15:42:16 INFO - 'tscrollx', 15:42:16 INFO - 'cart']}, 15:42:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'talos_options': ['--disable-e10s'], 15:42:16 INFO - 'tests': ['tp5o']}, 15:42:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'tests': ['tp5o']}, 15:42:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'talos_options': ['--disable-e10s', 15:42:16 INFO - '--xperf_path', 15:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:16 INFO - 'tests': ['tp5n']}, 15:42:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:16 INFO - 'talos_options': ['--xperf_path', 15:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:16 INFO - 'tests': ['tp5n']}}, 15:42:16 INFO - 'talos.zip': {'path': '', 15:42:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:42:16 INFO - Running post-action listener: _resource_record_post_action 15:42:16 INFO - [mozharness: 2016-09-22 22:42:16.228632Z] Finished populate-webroot step (success) 15:42:16 INFO - [mozharness: 2016-09-22 22:42:16.228754Z] Running create-virtualenv step. 15:42:16 INFO - Running pre-action listener: _resource_record_pre_action 15:42:16 INFO - Running main action method: create_virtualenv 15:42:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:16 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 15:42:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:42:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:16 INFO - Using real prefix '/tools/python27' 15:42:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:19 INFO - Installing pip.................done. 15:42:19 INFO - Return code: 0 15:42:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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')]} 15:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42: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', 'pip>=1.5'] in /builds/slave/test/build 15:42: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 pip>=1.5 15:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:19 INFO - 'HOME': '/Users/cltbld', 15:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:19 INFO - 'LOGNAME': 'cltbld', 15:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:19 INFO - 'MOZ_NO_REMOTE': '1', 15:42:19 INFO - 'NO_EM_RESTART': '1', 15:42:19 INFO - 'PAGER': '/bin/cat', 15:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:19 INFO - 'PWD': '/builds/slave/test', 15:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:19 INFO - 'SHELL': '/bin/bash', 15:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:19 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:19 INFO - 'USER': 'cltbld', 15:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:19 INFO - 'XPC_FLAGS': '0x0', 15:42:19 INFO - 'XPC_SERVICE_NAME': '0', 15:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:20 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 15:42:20 INFO - Cleaning up... 15:42:20 INFO - Return code: 0 15:42:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:42:20 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')]} 15:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:20 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')]} 15:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:20 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:20 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 15:42:20 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 15:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:20 INFO - 'HOME': '/Users/cltbld', 15:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:20 INFO - 'LOGNAME': 'cltbld', 15:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:20 INFO - 'MOZ_NO_REMOTE': '1', 15:42:20 INFO - 'NO_EM_RESTART': '1', 15:42:20 INFO - 'PAGER': '/bin/cat', 15:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:20 INFO - 'PWD': '/builds/slave/test', 15:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:20 INFO - 'SHELL': '/bin/bash', 15:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:20 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:20 INFO - 'USER': 'cltbld', 15:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:20 INFO - 'XPC_FLAGS': '0x0', 15:42:20 INFO - 'XPC_SERVICE_NAME': '0', 15:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:20 INFO - Downloading/unpacking psutil>=3.1.1 15:42:20 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 15:42:20 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 15:42:20 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 15:42:20 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 15:42:20 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 15:42:20 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 15:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:23 INFO - Installing collected packages: psutil 15:42:23 INFO - Running setup.py install for psutil 15:42:23 INFO - building 'psutil._psutil_osx' extension 15:42:23 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 15:42:24 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 15:42:24 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 15:42:24 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 15:42:24 INFO - building 'psutil._psutil_posix' extension 15:42:24 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 15:42:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:42:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:42:24 INFO - ^ 15:42:24 INFO - 1 warning generated. 15:42:24 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 15:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:24 INFO - Successfully installed psutil 15:42:24 INFO - Cleaning up... 15:42:24 INFO - Return code: 0 15:42:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:24 INFO - 'HOME': '/Users/cltbld', 15:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:24 INFO - 'LOGNAME': 'cltbld', 15:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:24 INFO - 'MOZ_NO_REMOTE': '1', 15:42:24 INFO - 'NO_EM_RESTART': '1', 15:42:24 INFO - 'PAGER': '/bin/cat', 15:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:24 INFO - 'PWD': '/builds/slave/test', 15:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:24 INFO - 'SHELL': '/bin/bash', 15:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:24 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:24 INFO - 'USER': 'cltbld', 15:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:24 INFO - 'XPC_FLAGS': '0x0', 15:42:24 INFO - 'XPC_SERVICE_NAME': '0', 15:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:42:25 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 15:42:25 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 15:42:25 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 15:42:25 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 15:42:25 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 15:42:25 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 15:42:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:42:27 INFO - Installing collected packages: mozsystemmonitor 15:42:27 INFO - Running setup.py install for mozsystemmonitor 15:42:27 INFO - Successfully installed mozsystemmonitor 15:42:27 INFO - Cleaning up... 15:42:27 INFO - Return code: 0 15:42:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:42:27 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')]} 15:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:27 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')]} 15:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:27 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:27 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 15:42:27 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 15:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:27 INFO - 'HOME': '/Users/cltbld', 15:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:27 INFO - 'LOGNAME': 'cltbld', 15:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:27 INFO - 'MOZ_NO_REMOTE': '1', 15:42:27 INFO - 'NO_EM_RESTART': '1', 15:42:27 INFO - 'PAGER': '/bin/cat', 15:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:27 INFO - 'PWD': '/builds/slave/test', 15:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:27 INFO - 'SHELL': '/bin/bash', 15:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:27 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:27 INFO - 'USER': 'cltbld', 15:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:27 INFO - 'XPC_FLAGS': '0x0', 15:42:27 INFO - 'XPC_SERVICE_NAME': '0', 15:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:28 INFO - Downloading/unpacking jsonschema==2.5.1 15:42:28 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 15:42:28 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 15:42:28 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 15:42:28 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 15:42:28 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 15:42:28 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 15:42:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:42:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:42:31 INFO - warning: no files found matching '*.txt' 15:42:31 INFO - no previously-included directories found matching 'build' 15:42:31 INFO - no previously-included directories found matching 'dist' 15:42:31 INFO - no previously-included directories found matching '.git*' 15:42:31 INFO - Installing collected packages: jsonschema, functools32 15:42:31 INFO - Running setup.py install for functools32 15:42:31 INFO - warning: no files found matching '*.txt' 15:42:31 INFO - no previously-included directories found matching 'build' 15:42:31 INFO - no previously-included directories found matching 'dist' 15:42:31 INFO - no previously-included directories found matching '.git*' 15:42:31 INFO - Successfully installed jsonschema functools32 15:42:31 INFO - Cleaning up... 15:42:31 INFO - Return code: 0 15:42:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:42:31 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')]} 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:31 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')]} 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:31 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:31 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 15:42:31 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 15:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:31 INFO - 'HOME': '/Users/cltbld', 15:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:31 INFO - 'LOGNAME': 'cltbld', 15:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:31 INFO - 'MOZ_NO_REMOTE': '1', 15:42:31 INFO - 'NO_EM_RESTART': '1', 15:42:31 INFO - 'PAGER': '/bin/cat', 15:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:31 INFO - 'PWD': '/builds/slave/test', 15:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:31 INFO - 'SHELL': '/bin/bash', 15:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:31 INFO - 'USER': 'cltbld', 15:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:31 INFO - 'XPC_FLAGS': '0x0', 15:42:31 INFO - 'XPC_SERVICE_NAME': '0', 15:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:42:31 INFO - Cleaning up... 15:42:31 INFO - Return code: 0 15:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42:31 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')]} 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:31 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')]} 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:31 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:31 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 15:42:31 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 15:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:31 INFO - 'HOME': '/Users/cltbld', 15:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:31 INFO - 'LOGNAME': 'cltbld', 15:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:31 INFO - 'MOZ_NO_REMOTE': '1', 15:42:31 INFO - 'NO_EM_RESTART': '1', 15:42:31 INFO - 'PAGER': '/bin/cat', 15:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:31 INFO - 'PWD': '/builds/slave/test', 15:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:31 INFO - 'SHELL': '/bin/bash', 15:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:31 INFO - 'USER': 'cltbld', 15:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:31 INFO - 'XPC_FLAGS': '0x0', 15:42:31 INFO - 'XPC_SERVICE_NAME': '0', 15:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:31 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 15:42:31 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 15:42:31 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 15:42:31 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 15:42:31 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 15:42:31 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 15:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:34 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 15:42:34 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 15:42:34 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 15:42:34 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 15:42:34 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 15:42:34 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 15:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:35 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 15:42:35 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 15:42:35 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 15:42:35 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 15:42:35 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 15:42:35 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 15:42:35 INFO - Downloading docopt-0.6.1.tar.gz 15:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:35 INFO - Running setup.py install for blobuploader 15:42:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:35 INFO - Running setup.py install for requests 15:42:36 INFO - Running setup.py install for docopt 15:42:36 INFO - Successfully installed blobuploader requests docopt 15:42:36 INFO - Cleaning up... 15:42:36 INFO - Return code: 0 15:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:36 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')]} 15:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:36 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')]} 15:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:36 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:36 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 15:42:36 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 15:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:36 INFO - 'HOME': '/Users/cltbld', 15:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:36 INFO - 'LOGNAME': 'cltbld', 15:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:36 INFO - 'MOZ_NO_REMOTE': '1', 15:42:36 INFO - 'NO_EM_RESTART': '1', 15:42:36 INFO - 'PAGER': '/bin/cat', 15:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:36 INFO - 'PWD': '/builds/slave/test', 15:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:36 INFO - 'SHELL': '/bin/bash', 15:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:36 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:36 INFO - 'USER': 'cltbld', 15:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:36 INFO - 'XPC_FLAGS': '0x0', 15:42:36 INFO - 'XPC_SERVICE_NAME': '0', 15:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:36 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-lQPFwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:36 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-pIlKWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-xkq6dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2yYARf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-GjGzNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-vy6VMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-YeTY1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-A0075m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-tWchB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-XdTrS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:37 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-USfOSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-lvKwgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-WT0dJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-L2sP4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-_z3Pa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-aw1m_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:38 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-SJQTAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:38 INFO - Running setup.py install for manifestparser 15:42:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:38 INFO - Running setup.py install for mozcrash 15:42:38 INFO - Running setup.py install for mozdebug 15:42:39 INFO - Running setup.py install for mozdevice 15:42:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Running setup.py install for mozfile 15:42:39 INFO - Running setup.py install for mozhttpd 15:42:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Running setup.py install for mozinfo 15:42:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Running setup.py install for mozInstall 15:42:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:39 INFO - Running setup.py install for mozleak 15:42:39 INFO - Running setup.py install for mozlog 15:42:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Running setup.py install for moznetwork 15:42:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Running setup.py install for mozprocess 15:42:40 INFO - Running setup.py install for mozprofile 15:42:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Running setup.py install for mozrunner 15:42:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:42:40 INFO - Running setup.py install for mozscreenshot 15:42:40 INFO - Running setup.py install for moztest 15:42:41 INFO - Running setup.py install for mozversion 15:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:41 INFO - Cleaning up... 15:42:41 INFO - Return code: 0 15:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:41 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')]} 15:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:41 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')]} 15:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:41 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:41 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 15:42:41 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 15:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:41 INFO - 'HOME': '/Users/cltbld', 15:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:41 INFO - 'LOGNAME': 'cltbld', 15:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:41 INFO - 'MOZ_NO_REMOTE': '1', 15:42:41 INFO - 'NO_EM_RESTART': '1', 15:42:41 INFO - 'PAGER': '/bin/cat', 15:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:41 INFO - 'PWD': '/builds/slave/test', 15:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:41 INFO - 'SHELL': '/bin/bash', 15:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:41 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:41 INFO - 'USER': 'cltbld', 15:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:41 INFO - 'XPC_FLAGS': '0x0', 15:42:41 INFO - 'XPC_SERVICE_NAME': '0', 15:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OItxRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:41 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)) 15:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mx8Ec8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-KtCSUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mntSsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-L9fZIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2qRbN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-AoSlcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-UsB7iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TvnSFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-I2nW7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:42 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)) 15:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qYJqa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:43 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-i2APIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:43 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-lNfZmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:43 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-U4wCu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3XImkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:43 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3JzmKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:43 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)) 15:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OvCRA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:43 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)) 15:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:42:43 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)) 15:42:43 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)) 15:42:43 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)) 15:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:42:43 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 15:42:43 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 15:42:43 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 15:42:43 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 15:42:43 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 15:42:43 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 15:42:46 INFO - Downloading blessings-1.6.tar.gz 15:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:42:46 INFO - Installing collected packages: blessings 15:42:46 INFO - Running setup.py install for blessings 15:42:46 INFO - Successfully installed blessings 15:42:46 INFO - Cleaning up... 15:42:47 INFO - Return code: 0 15:42:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:47 INFO - Reading from file tmpfile_stdout 15:42:47 INFO - Current package versions: 15:42:47 INFO - blessings == 1.6 15:42:47 INFO - blobuploader == 1.2.4 15:42:47 INFO - docopt == 0.6.1 15:42:47 INFO - functools32 == 3.2.3-2 15:42:47 INFO - jsonschema == 2.5.1 15:42:47 INFO - manifestparser == 1.1 15:42:47 INFO - mozInstall == 1.12 15:42:47 INFO - mozcrash == 0.17 15:42:47 INFO - mozdebug == 0.1 15:42:47 INFO - mozdevice == 0.48 15:42:47 INFO - mozfile == 1.2 15:42:47 INFO - mozhttpd == 0.7 15:42:47 INFO - mozinfo == 0.9 15:42:47 INFO - mozleak == 0.1 15:42:47 INFO - mozlog == 3.4 15:42:47 INFO - moznetwork == 0.27 15:42:47 INFO - mozprocess == 0.23 15:42:47 INFO - mozprofile == 0.28 15:42:47 INFO - mozrunner == 6.12 15:42:47 INFO - mozscreenshot == 0.1 15:42:47 INFO - mozsystemmonitor == 0.3 15:42:47 INFO - moztest == 0.7 15:42:47 INFO - mozversion == 1.4 15:42:47 INFO - psutil == 3.1.1 15:42:47 INFO - requests == 1.2.3 15:42:47 INFO - wsgiref == 0.1.2 15:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:47 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:47 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 15:42:47 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 15:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:47 INFO - 'HOME': '/Users/cltbld', 15:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:47 INFO - 'LOGNAME': 'cltbld', 15:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:47 INFO - 'MOZ_NO_REMOTE': '1', 15:42:47 INFO - 'NO_EM_RESTART': '1', 15:42:47 INFO - 'PAGER': '/bin/cat', 15:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:47 INFO - 'PWD': '/builds/slave/test', 15:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:47 INFO - 'SHELL': '/bin/bash', 15:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:47 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:47 INFO - 'USER': 'cltbld', 15:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:47 INFO - 'XPC_FLAGS': '0x0', 15:42:47 INFO - 'XPC_SERVICE_NAME': '0', 15:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 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)) 15:42:47 INFO - Cleaning up... 15:42:47 INFO - Return code: 0 15:42:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:47 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 0x10da90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf245ec10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, '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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 15:42:47 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 15:42:47 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 15:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:47 INFO - 'HOME': '/Users/cltbld', 15:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:47 INFO - 'LOGNAME': 'cltbld', 15:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:47 INFO - 'MOZ_NO_REMOTE': '1', 15:42:47 INFO - 'NO_EM_RESTART': '1', 15:42:47 INFO - 'PAGER': '/bin/cat', 15:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:47 INFO - 'PWD': '/builds/slave/test', 15:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:47 INFO - 'SHELL': '/bin/bash', 15:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:42:47 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:47 INFO - 'USER': 'cltbld', 15:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:47 INFO - 'XPC_FLAGS': '0x0', 15:42:47 INFO - 'XPC_SERVICE_NAME': '0', 15:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:42:47 INFO - Cleaning up... 15:42:47 INFO - Return code: 0 15:42:47 INFO - Running post-action listener: _resource_record_post_action 15:42:47 INFO - Running post-action listener: _start_resource_monitoring 15:42:47 INFO - Starting resource monitoring. 15:42:47 INFO - [mozharness: 2016-09-22 22:42:47.840526Z] Finished create-virtualenv step (success) 15:42:47 INFO - [mozharness: 2016-09-22 22:42:47.841549Z] Running install step. 15:42:47 INFO - Running pre-action listener: _resource_record_pre_action 15:42:47 INFO - Running main action method: install 15:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:48 INFO - Reading from file tmpfile_stdout 15:42:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:42:48 INFO - Reading from file tmpfile_stdout 15:42:48 INFO - Output received: 15:42:48 INFO - Usage: mozinstall [options] installer 15:42:48 INFO - Options: 15:42:48 INFO - -h, --help show this help message and exit 15:42:48 INFO - -d DEST, --destination=DEST 15:42:48 INFO - Directory to install application into. [default: 15:42:48 INFO - "/builds/slave/test"] 15:42:48 INFO - --app=APP Application being installed. [default: firefox] 15:42:48 INFO - mkdir: /builds/slave/test/build/application 15:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:43:20 INFO - Reading from file tmpfile_stdout 15:43:20 INFO - Output received: 15:43:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:43:20 INFO - Running post-action listener: _resource_record_post_action 15:43:20 INFO - [mozharness: 2016-09-22 22:43:20.592872Z] Finished install step (success) 15:43:20 INFO - [mozharness: 2016-09-22 22:43:20.592997Z] Running run-tests step. 15:43:20 INFO - Running pre-action listener: _resource_record_pre_action 15:43:20 INFO - Running main action method: run_tests 15:43:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:20 INFO - 2016-09-22 15:43:20.607 screenresolution[2014:11294] starting screenresolution argv=screenresolution get 15:43:20 INFO - 2016-09-22 15:43:20.610 screenresolution[2014:11294] Display 0: 1600x1200x32@60 15:43:20 INFO - 2016-09-22 15:43:20.616 screenresolution[2015:11297] starting screenresolution argv=screenresolution list 15:43:20 INFO - Available Modes on Display 0 15:43:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:20 INFO - Intel Iris: 15:43:20 INFO - Chipset Model: Intel Iris 15:43:20 INFO - Type: GPU 15:43:20 INFO - Bus: Built-In 15:43:20 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:20 INFO - Vendor: Intel (0x8086) 15:43:20 INFO - Device ID: 0x0a2e 15:43:20 INFO - Revision ID: 0x0009 15:43:20 INFO - Displays: 15:43:20 INFO - Display: 15:43:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:20 INFO - Display Serial Number: 1600x1200 60 15:43:20 INFO - Main Display: Yes 15:43:20 INFO - Mirror: Off 15:43:20 INFO - Online: Yes 15:43:20 INFO - Rotation: Supported 15:43:20 INFO - Return code: 0 15:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:20 INFO - Python 2.7.3 15:43:20 INFO - Return code: 0 15:43:20 INFO - grabbing minidump binary from tooltool 15:43:20 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')]} 15:43:20 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 0x10d8a4d30>, '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 0x10d70adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:20 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 15:43:20 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 15:43:20 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 15:43:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:20 INFO - Return code: 0 15:43:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:43:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:43:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:20 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/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 15:43:20 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/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 15:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OJFxsCLGie/Render', 15:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:20 INFO - 'HOME': '/Users/cltbld', 15:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:20 INFO - 'LOGNAME': 'cltbld', 15:43:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:20 INFO - 'MOZ_NO_REMOTE': '1', 15:43:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:20 INFO - 'NO_EM_RESTART': '1', 15:43:20 INFO - 'PAGER': '/bin/cat', 15:43:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:20 INFO - 'PWD': '/builds/slave/test', 15:43:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:20 INFO - 'SHELL': '/bin/bash', 15:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qiuzgq0SKw/Listeners', 15:43:20 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 15:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:20 INFO - 'USER': 'cltbld', 15:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:20 INFO - 'XPC_FLAGS': '0x0', 15:43:20 INFO - 'XPC_SERVICE_NAME': '0', 15:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:20 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/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 15:43:21 INFO - mozversion application_buildid: 20160922133959 15:43:21 INFO - mozversion application_changeset: ef567dcc1de7f603ea78c2463d9d77897b6797da 15:43:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:43:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:21 INFO - mozversion application_name: Firefox 15:43:21 INFO - mozversion application_remotingname: firefox-dev 15:43:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:43:21 INFO - mozversion application_vendor: Mozilla 15:43:21 INFO - mozversion application_version: 51.0a2 15:43:21 INFO - mozversion platform_buildid: 20160922133959 15:43:21 INFO - mozversion platform_changeset: ef567dcc1de7f603ea78c2463d9d77897b6797da 15:43:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:43:21 INFO - mozversion platform_version: 51.0a2 15:43:21 INFO - using testdate: 1474584201 15:43:21 INFO - actual date: 1474584201 15:43:21 INFO - starting webserver on 'localhost:49401' 15:43:21 INFO - SUITE-START | Running 2 tests 15:43:21 INFO - TEST-START | dromaeo_css 15:43:21 INFO - operating with platform_type : mac_ 15:43:21 INFO - Initialising browser for dromaeo_css test... 15:43:21 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpxdI4dS/profile http://localhost:49401/getInfo.html) 15:43:23 INFO - PROCESS | 2025 | __metrics Screen width/height:1600/1200 15:43:23 INFO - PROCESS | 2025 | colorDepth:24 15:43:23 INFO - PROCESS | 2025 | Browser inner width/height: 1024/689 15:43:23 INFO - PROCESS | 2025 | __metrics 15:43:23 ERROR - PROCESS | 2025 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 15:43:24 INFO - TEST-INFO | 2025: exit 0 15:43:24 INFO - Browser initialized. 15:43:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:43:24 INFO - TEST-INFO | started process 2028 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpxdI4dS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:36 INFO - PROCESS | 2028 | RSS: Main: 224911360 15:43:36 INFO - PROCESS | 2028 | 15:44:26 INFO - PROCESS | 2028 | 1474584266162 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] 15:46:38 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49401/tests/dromaeo/cssquery-ext.html) 15:46:39 INFO - PROCESS | 2028 | RSS: Main: 237916160 15:46:39 INFO - PROCESS | 2028 | 15:49:42 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-ext.html (next: http://localhost:49401/tests/dromaeo/cssquery-jquery.html) 15:49:42 INFO - PROCESS | 2028 | RSS: Main: 248889344 15:49:42 INFO - PROCESS | 2028 | 15:52:44 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49401/tests/dromaeo/cssquery-mootools.html) 15:52:45 INFO - PROCESS | 2028 | RSS: Main: 250818560 15:52:45 INFO - PROCESS | 2028 | 15:55:47 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49401/tests/dromaeo/cssquery-prototype.html) 15:55:47 INFO - PROCESS | 2028 | RSS: Main: 251949056 15:55:47 INFO - PROCESS | 2028 | 15:58:50 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49401/tests/dromaeo/cssquery-yui.html) 15:58:51 INFO - PROCESS | 2028 | RSS: Main: 256479232 15:58:51 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-yui.html (next: http://localhost:49401/tests/dromaeo/cssquery-dojo.html) 16:01:53 INFO - PROCESS | 2028 | RSS: Main: 258359296 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | __start_tp_report 16:01:53 INFO - PROCESS | 2028 | _x_x_mozilla_page_load 16:01:53 INFO - PROCESS | 2028 | _x_x_mozilla_page_load_details 16:01:53 INFO - PROCESS | 2028 | |i|pagename|runs| 16:01:53 INFO - PROCESS | 2028 | |0;dojo.html;2850.52966260567;3085.475469170241;3434.484827275907;3466.497357883107;3469.583649962005;4468.709533880304;4661.207594708899;5116.897662046761;5227.398849132351;5928.347881733006;5993.370696076903;6020.6086604370685;6027;6042.8489287767825;6042.909356359658;5359.249705041288;5415.350157981028;5427.674339539621;5450.754716037768;5459.3994660587305;5483.424240454755;5486.862828429301;5491.478309560585;5500.1749737539285;5528.308961379827;4583.152116858392;5359.732013399314;5367.194920761878;5470.753816078286;5483.588730845183;5349.277847490578;5422.8915421691545;5434.673919564799;5500.22996780451;5555.861103472445;4896.510348965111;5083.856132370224;5361.651492652965;5427.48438898304;5460.945390546083;5813.215215945836;6034.336223015464;6061.393860613947;6103.6032657877095;6120.234970628671;5815.505682017034;6070.848228794315;6173.660448675321;6280.937190628081;6350.26971898233;6432.51756118293;6438.645874476902;6443.3234510376205;6448.967755161241;6454.064160696719;6157.230346206724;6166.445019948182;6167.691615419211;6169.290531588835;6176.382361763833;6236.532260080512;6299.905501417483;6331.303556608769;6336.017917222838;6542.7710030149665;6225.844353891189;6272.341404152589;6280.560360774702;6286.779962701284;6297;6365.8726825464155;6369.426751592287;6391.2330520337855;6399.488040956712;6402.455791257796;6170.50635949123;6215.12988181655;6282;6308.7476500940365;6323.747050117944;6217.658028808459;6246.3753624637175;6267.091271765568;6295.401936815995;6340.175777148941;5071.594272458195;5086.92369614456;5087.465816089258;5096.923546146811;5114.181730923035;4484.820607175677;4568.223402021665;4573.428321459817;4594.081183763261;4610.2854057621125;5822.417758224228;6039.094135879654;6072.089186621954;6086.2087928569;6178.320384757673;5665.830025099253;6376.968115159394;6387.041943708481;6408.935910640927;6410.1987251593555;5990.760369585168;6042.305134909541;6058.727357268934;6072.058830881132;6114.2357205349335;4779.283107533898;5566.582506312043;5579;5600.6919619420505;5609.382967873531;6564.179477565304;6572.277049524549;6573;6578.868422631424;6597.406233439014;6159.168512250968;6202.2867370253;6302.432781049728;6367.458766004941;6394.552381333262;6398.872022559616;6578.309277525791;6587.143671322698;6600.471962242913;6608.041833934149;6322.0516922462;6323.747050117944;6329.303776584664;6353.301136875032;6354.586951848115;6214.751409943732;6270.905936411049;6359.17330747;6406.583572067801;6433.131527243762;6166.660833654013;6184.752609895554;6210.658413787285;6273.466755325849;6273.65494897785;6204.658743769136;6214.378562143749;6230.470410015199;6250.499960003098;6254.937450625435;4638.8608341749805;6058.091286307089;6185.288691800501;6221.844453888689;6258.655773932477;5752.7698892043845;6153.107799369156;6197.070439433941;6240.687965601793;6273.592216505913;6241.719122639583;6256.655883926428;6258.499320054476;6267.059941008885;6282.874342513215 16:01:53 INFO - PROCESS | 2028 | |1;ext.html;461.96519795657724;471.74290011943486;474.0660898030878;479.7097755857704;533.4212379568169;35909.64090359095;42073.57926420735;42078.57921420785;42086.57913420869;42351.78824105875;42370;42653.7867310663;42880.571194288044;42972;43021.78489107558;9622.037796220375;9825.459599722013;9854.113129818315;9873.851892221623;9879.0120987901;9820.852687209697;9896.960819113998;9909.009099090106;9921.65274215399;9943.801123977517;9889;9908.108270255676;9938.950305248463;9953.701388958307;10003.249756268273;9855.704328870146;9904.306698531105;9931.702048938543;9936.105750482455;9960.352577082538;9821.312508124434;9890.258230632731;9893.653722119763;9904.702858914245;9949.154321882648;39518;40152.39771403431;40584.39123413151;40654.79672601618;40680;3060.816351018946;3154.4006638738565;3177.8887738929257;3216.533602627629;3259.951100733491;29489.852550737323;30633.846830765702;30702.69297307043;31178.844105779554;31409.214769630715;3117.096042147797;3266.8366581671057;3273.65626609205;3278.426275401795;3288.6875746804017;461067;463109;466442;467092;467426.9999999966;31809.204769880474;60417.09374359388;64573;65178.674106629165;65260;35075.12312192216;35237.47143792845;35930.461043084375;35993.820030899675;36001.099972500895;15102.169380684169;15134.545963621109;15185.6203594911;15200;15216.543503694907;12870.420831062625;12907.935460322826;12993.220406775623;13024.869751302555;13033.218006919615;6634.336566343423;7777.1833957433655;7802.375809935192;7834.725784597512;7839.764807055797;3036.9067135831083;3039.7264246217505;3280.6883346082086;3281.425750493654;3299.6535363786456;957.2963871554402;966.6133546581424;1047.539082803564;1061.9787604248027;1068.1881769854965;30344.241393965327;30950.690493094782;30966.69033309683;30973.845130774203;31324.530132048036;985.7437066362654;996.9601215951426;1019.4249883929347;1060.7189094889861;1091.8089334366455;12006.819897701542;13195.140311781903;14304.998650094602;17047.829521704873;17137.314507419815;710849;723851;725886;726881;727124;59712;60009.09986350208;60513;60607.696961515794;60847.391526085055;1373.3888419653158;1384.0795870746042;1400.4538230090477;1405.5221224783622;1406.69052808382;30366.696333036387;30970.22574435567;32101.876434325623;32138.839305804257;32808.17979550435;51663.225051625006;51989;52300.47699523108;52382.21426678527;52658.683532911986;563024.3697563136;660944;663777;663846;665864;22677.886610566842;22954.311370658907;23932.88033559821;26033.609495857956;27161.91352345884;46535.301970469794;46797.29804052874;47458;48787.756061219465;48869.26696099633;38230.60389655354;39601.603983959794;39710;40386.19227615373;40865.38701919414;35026.299474009866;39044.41433378445;39973.60026399699;40585.79707101446;40855.38716919308;36894.077648059014;38447.8465646031;39326.21347572975;40100.1979960405;41469.79265103776;33799;35717.74987875412;35870;36047.27905441929;36230.637693622724;26863.86568067147;26963.595546067216;27047.053353132545;27103.864480677472;27482.862585686944 16:01:53 INFO - PROCESS | 2028 | |2;jquery.html;339.29257498116425;382.28894256682565;384.2833116238215;387.26613068235713;403.9457017185146;19370.70943935842;20859.478513037182;21101.366958991235;21320.827354495497;21443.785562144374;19894.70157947632;20105.497362565944;20472.89763551184;20551.794482055175;20635.484112897186;5786.797462088828;5799.072148456248;6007.699615019232;6046.486048685867;6058.39416058395;4137.110521237933;4354.738715677054;5925.733341999598;6023.975924092914;6026.126211699323;6248.750049997994;6537.738490460376;6605.603663780164;6655.567388119781;6657.533972621918;6397.200349956255;6585.407313341799;6623.039659249406;6634.966825165843;6646.734130634769;5693.601447898649;5713.74288157034;5753.079507278857;5753.7986170484255;5794;25207;25319.49361012788;25336.873315633304;25608.61587076177;25740.84166212506;2251.617225071742;2253.188852013274;2361.2089949866813;2658.2822637887857;2698.89345368398;15165.01427407215;15269.847301527065;15375.461858834888;15691.372345106181;15969.92015039929;1806.3136008316887;1836.898970556619;1873.0447471789485;1894.6400183965002;1900.9904950475297;105448.41827372595;109672.90327096627;114759;119934;122120.00439503393;11137.777244455228;11255.887441125647;11304.604338848101;11634.301941883345;11772.882271177179;12852.807207891701;14538.927305363406;14654.63363415923;14714.0435871668;14798.852011479747;8632.050474447806;8754.47473151613;8827.735167944971;8916.331275154389;8927.285817134614;6744;6889.311068893071;8212.671493140328;8563.529005904735;8900.599473023729;3937.9212415751526;4089.9182016359505;4606.848287928018;4640.767961601907;4675.13510000651;1848.3623150013225;1933.1494142577221;1980.059541649163;1988.1450976080425;1993.5813479169246;833.9666413343398;882.7042940614838;960.5917485068818;967.5936106835146;978.4716253223322;19956.800431995493;20337.694934575993;20357.77853328805;20542.69185962212;20982.47543811417;781.8741012941347;970.708787363788;973.4305431322614;985.8373368394278;1010.9797804044025;10633.787324253626;10940.945295273472;10970;10974.835377469344;10980.835287470694;526945;529231;540246;540647;561381;122234;125136;129957;130024;130286;821.7863355527486;824.1840577827908;897.8014350841569;912.5683327064029;931.5901003558413;14828.777568336267;18170.72743908816;18193.636127277117;18293.54266143357;18535.07324633736;40396.18217180175;51221.743891280305;51697.96604067822;53975.92048159093;55298.44701552933;81506;82045.58977205076;82160.76758848742;82800;83527.91180220543;7305.5981920994855;8145.79635509117;8245.95877020611;8352.707655232038;8364.832703346021;10921.563137474412;12179;12203.877961220274;12373.443195056065;12592;8781.956090219508;10630;10673.679789606324;10751.838722419327;11004.22970392097;10508.842367364648;10633.574657013942;10644.520996555018;10890.836637450602;11162.888371116185;10498.895011050097;10719;11088.611898583511;11144.108471322437;11264.324140551593;8162.918370816215;8183.836323273382;8343.791405214675;8407.45351552147;8438.987321521457;10859;10905.890941090805;10952.288101273392;11105.22845783472;11353.54585816558 16:01:53 INFO - PROCESS | 2028 | |3;mootools.html;1377.3044612470703;1458.7009663019078;1583.5011971229062;1783.500619826449;1841.1438681013326;8211.671533138668;8467.91532084679;8697.173768491992;9287.44275343479;9354.625814967401;8184.549849758261;8735.388522803407;9052.502112383816;9062.184403403693;9106.635734570626;1910.761154855643;2153.4078128514625;2403.807695384365;2416.4079800448912;2417.226487523993;2369.7748713872156;2394.1500767227644;2413.227767114524;2414.915477958272;2420.7700268474555;2403.927882163529;2405.8797060147012;2414.61366181411;2428.6842710447618;2435.2937648082034;2119.5125121222204;2339.7894189523026;2383.880805959695;2396.5087157132834;2399.9160029398886;2365.1485465232504;2381.2975172324204;2403.5192961407615;2407.3620490570015;2413.4690368118986;9070.274378049806;9090.2273306769;9174.174324310845;9177.036411176798;9194.724158275263;5347.0909945309395;5505.3393592768725;5510.559155267609;5511.834644960658;5513.338399392099;3645.5989841117457;3650.963490365089;3664.560252769658;3689.8339574719203;3709.7774133552075;1055.6727414501452;1070.925035247533;1072.7371793910543;1072.742541789965;1074.704456274523;12030.33833139177;12179.878201217964;12201.962833159103;12278.631641050693;12320.691982700415;4793.544613261734;4818.7831547580445;4839.879003024882;4965.82619608312;4980.5019498049905;10321.63874264397;10410;10435.739106522398;10444;10452;5509.3664228614225;5509.586780991362;5523.337199536081;5529.170624406372;5546.084895992116;4433.82264709408;4628.69913455631;4784.545468180518;5021.995600879839;5024.447310795809;4069.7558146511305;4095.5085389752826;4116.814743336557;4199.622034016953;4213.9578604214175;1303.7913933770742;1307.1568838099372;1317.328162637062;1321.5242512695422;1323.9470421183046;678.389449495458;686.9656517174121;779.7582749347607;877.4691311756295;949.7435692363161;6012.218411606551;6067.423594758491;6101.420365065312;6130.540209484307;6279.968600157062;373.0003590377814;429.9935500967488;438.52639149718226;438.87053319270893;443.59854331829746;3598.6401359864326;3992.5807790182193;4033.5361433434946;4045.959540404617;4119.443875076886;10860;11128.833067503994;11159.274647148071;11242.269252498561;11287.887121128684;11140.721481963015;11150.163737719704;11168.329900206014;11186.32882027081;11222.494987725571;8255.463394879314;8306.210909963544;8438.662453501915;8515.020772611106;8526.74419767408;5788;5926.762929482772;5962.284525856751;6038.607490513103;6100.75596976116;10045.296829221885;10211.029952154533;10427.426491543038;10448.58205671795;10464.686059418229;10315.793684126425;10328.431936243578;10586.523606437575;10592.523336450033;10843.295185812896;5909.23179986599;7166.928330716626;7521.0974683038385;7582.507137036075;7869;8467.66129354819;8655;8656.091110433566;8659.13408659129;8714.694985675724;7518;7742.303192712683;7786.649600768093;7814.804629884071;7962.641681124247;7500.774976750488;7643.694252230071;7649.9617501912135;7675.923240767521;7800.765977020698;5900.586958913007;6210.378962103753;6285.774274016706;6553.853075711827;6808.114945057111;4644.815572029246;4821.927671084866;5058.848234552969;5081.390233172043;5147.2279158126585;5118.948810511996;5206.088934436534;5212.400573934046;5228.189630607262;5235.528802407802 16:01:53 INFO - PROCESS | 2028 | |4;prototype.html;265.75284984963986;276.3257651330753;307.7553345090653;311.59959452104044;321.0897106702498;4862.319275301461;5291.444398338177;5379.300690910186;5686.346070201928;5756.136579513075;4534.21145995213;4664.626829853612;5551.528120109796;5559.915816415791;5611.523020543248;3760.9811950940207;3926.9018274543223;4080.632987949041;4090.4273401723635;4230.7038507304505;3357.9664203357897;3973.80785764271;4280.058387154821;4283.336082907154;4290.4636920384955;3641.6722494975447;4169.520505141917;4179.979100104495;4203.7687927164;4220.53574106848;3514.6485351464903;4209.894752631178;4219.261629214906;4227.8308867645255;4238.745675259494;3613.602503724588;3621.474886141521;3648.5074514940407;3653.6711695947492;3661.3958696814993;5272.578193744491;5354.705491197982;5403.324584426947;5441.374241962146;5477.863053423656;4837.306942570108;4865.6107511399005;4866.683665561763;4869.83124050229;4900.730459824708;5694.430556944314;5864.794732184396;5905.726295376268;5966.284045914518;5973.970130149365;3943.8028098594955;3944.467496887941;3950.8419663213435;3985.342418500944;3997.6801855851463;4995.400551933755;5144.151215049513;5681.346645135821;6177.3822617738315;6201.906971395388;3290.634386729528;3585.587657419378;4033.3748269018347;4034.720382983605;4057.9391309130388;3386.0519054664733;3932.3429210834197;3970.1861118470642;3981.8009099544906;4056.350983842571;4276.786160691953;4822.228443449031;4829.492903245179;4841.15279826029;4849.709017458964;5139.306193663882;5232.816851410183;5892.616979896293;5940.524758019435;6006.669633170218;1274.222724138275;1297.8384346010457;1358.5380970470087;1376.662717634186;1378.8968824940007;699.2972063076576;721.8881073433627;815.2133191470259;829.8049958259804;842.3093063687717;3980.0796215727487;4174.91650167001;4601.6548758842555;4689.859304220879;4709.081729062868;4348.586884245991;4734.597559207506;4947.356843610308;5027.84916452507;5146.511081447256;3886.7279290449396;3936.0553467168247;4357.368181613649;4594.5864872161665;4689.788959496831;2276.7040284763207;2562.8718564071723;2584.418505836172;2636.90164057232;2708.349996000985;4510.729356238636;4514.751688657089;4778.948631301108;5022.810515322723;5206.68302605337;4997.475265097185;5141.562967147759;5182.559482444034;5248.343957005374;5262.894742105136;4362.956370436318;4547.113312903952;5095.223103408725;5209.895802084013;5233.633645644768;4963.602911767122;5073.34046573943;5081.424758324931;5137.794488220429;5172.637915345889;4341.696081274406;4948.935978764439;5055.9494405055475;5061.672270209066;5131.717755523482;5616.775328986795;6350.253680237972;6376;6417.598672703474;6460.192475940507;3337.748344370861;3494.9126271843406;3584.301061293023;3999.5200575931076;4183.916321673489;5205.609579281645;5407.053156029894;5965.582409231312;6103.816885493442;6149.907751383644;4993.600511959107;5142.965650266361;5313.7778310987915;5910.320313164041;5981.222441082631;5796.0436527972415;5817.505512031525;5999.760009599567;6013.6692481913915;6018.488428483628;4753.691010084333;5282.286891269783;5552.944470555242;5652.547796176378;5859.648421094748;4502.7523486207265;5378.811741589026;5742.569307301886;5947.256592925884;6068.878622427438;5533.142362933751;5571.019504565038;5753.769849206153;5887.558433117619;5911.527077833849 16:01:53 INFO - PROCESS | 2028 | |5;yui.html;693.5041445366562;701.8034950213939;709.3899246647882;712.454971946461;713.5433322673487;14761.409543618256;15307.923460382683;15496.845031549696;15619.843801561981;15697.843021569795;12353.19704219225;13844.515441959533;14122.929385353058;14235.786463203034;14374.425022999094;832.4547421438967;845.3490812074699;845.6786421159951;846.9153084691543;848.4145939301893;665.9700313485905;685.2873012067469;827.5324441690456;855.700504823313;859.3812455032366;879.5250564695057;909.0228004894732;909.6816114359988;910.2490445382552;911.968081117161;894.579547612621;896.9730908072768;897.6992707443014;898.5686870302259;900.3697411811758;660.4188314283448;665.7802925034775;665.9733610655568;666.3869240298889;667.4626925325111;14764.335604897806;14764.852351476562;14778.26108694561;14918.70162596753;14960.177190254532;11458.312501249951;12708.491660333575;14745.557633270912;14786.630334241623;14959.551213463614;9088.954555227181;11271;11687.240329378563;11972.820407693891;12024.278543287342;3668.3763760160837;3795.582485926546;3814.771113733185;3861.7296789224765;3886.863959761423;117961;121628;123939;126206.3689681555;129243.99999999905;11027.72430689223;11160.274582152135;11257.831132533018;11279.041281491165;11281.887181128248;22514.774852251594;22679.546409071725;22887.771122288897;22901.770982290298;22962.31113066611;8081.111077781439;8081.595920203967;8105.878411823827;8117.512949223065;8202.179782021869;4365.236083685342;4451.399061126706;4455.910881782346;4466.7766611669285;4543.977280113644;3534.7702399344475;3639.6178401267484;3669.1927775889794;3671.0271777978855;3675.632436756303;620.0760866309167;625.2059883947452;629.8929182039064;634.2230767310008;645.3610925184128;606.493577862481;628.9370963072394;635.2155088465742;650.6193876582158;654.2214764430313;9031.77420564478;9536.904630953602;9543;9731.44989126316;9749;539.3958766181823;562.5836880708247;640.8782331357028;668.0813880913744;688.0607970120749;4029.5366032906004;4283.993261583525;4493.662975276868;4623.676342656049;4720.763961801897;86617.13382866091;122513;126800;142480;142673.29306827817;124099;125792.1131183033;130080;131837.34081329533;132978;101372.49313753532;107975;109151.45424272827;109164;111887;6939.375456208965;8282.337413006824;8349.914511113517;8634.352423568384;8958.372913895964;55696.443035570745;59858;59868.70065649818;60678;61508.69245653743;43231.567684322756;54031;57886.7105664469;88606;90368.0963190386;11392.373419462008;11773.470193841127;11889.108316876096;12036.939815300868;12194.939025304817;10240.129588985019;11992.880071199177;12173.573924912585;12178.147529672839;12556.560520381743;12040.75918481643;12075;12126.454309556268;12207.877921220674;12373.257604543756;11963.64109076729;12065.09511786602;12114;12580.87419125797;12710.36448177606;11923.94038029839;11972.281663100242;11984.940075299568;12220.877791221974;12281.692957675772;8326.625301861552;8375.539345336065;8483.490990540588;8668.696595619123;8815.471071735716;10203.234757393077;10314.535845887103;10333.896661033594;10348.22388320894;10372.325798823053 16:01:53 INFO - PROCESS | 2028 | __end_tp_report 16:01:53 INFO - PROCESS | 2028 | __start_cc_report 16:01:53 INFO - PROCESS | 2028 | _x_x_mozilla_cycle_collect,373 16:01:53 INFO - PROCESS | 2028 | __end_cc_report 16:01:53 INFO - PROCESS | 2028 | __startTimestamp1474585313709__endTimestamp 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | ------- Summary: start ------- 16:01:53 INFO - PROCESS | 2028 | Number of tests: 6 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#0] dojo.html Cycles:165 Average:5872.30 Median:6170.51 stddev:702.53 (11.4%) stddev-sans-first:663.49 16:01:53 INFO - PROCESS | 2028 | Values: 2850.5 3085.5 3434.5 3466.5 3469.6 4468.7 4661.2 5116.9 5227.4 5928.3 5993.4 6020.6 6027.0 6042.8 6042.9 5359.2 5415.4 5427.7 5450.8 5459.4 5483.4 5486.9 5491.5 5500.2 5528.3 4583.2 5359.7 5367.2 5470.8 5483.6 5349.3 5422.9 5434.7 5500.2 5555.9 4896.5 5083.9 5361.7 5427.5 5460.9 5813.2 6034.3 6061.4 6103.6 6120.2 5815.5 6070.8 6173.7 6280.9 6350.3 6432.5 6438.6 6443.3 6449.0 6454.1 6157.2 6166.4 6167.7 6169.3 6176.4 6236.5 6299.9 6331.3 6336.0 6542.8 6225.8 6272.3 6280.6 6286.8 6297.0 6365.9 6369.4 6391.2 6399.5 6402.5 6170.5 6215.1 6282.0 6308.7 6323.7 6217.7 6246.4 6267.1 6295.4 6340.2 5071.6 5086.9 5087.5 5096.9 5114.2 4484.8 4568.2 4573.4 4594.1 4610.3 5822.4 6039.1 6072.1 6086.2 6178.3 5665.8 6377.0 6387.0 6408.9 6410.2 5990.8 6042.3 6058.7 6072.1 6114.2 4779.3 5566.6 5579.0 5600.7 5609.4 6564.2 6572.3 6573.0 6578.9 6597.4 6159.2 6202.3 6302.4 6367.5 6394.6 6398.9 6578.3 6587.1 6600.5 6608.0 6322.1 6323.7 6329.3 6353.3 6354.6 6214.8 6270.9 6359.2 6406.6 6433.1 6166.7 6184.8 6210.7 6273.5 6273.7 6204.7 6214.4 6230.5 6250.5 6254.9 4638.9 6058.1 6185.3 6221.8 6258.7 5752.8 6153.1 6197.1 6240.7 6273.6 6241.7 6256.7 6258.5 6267.1 6282.9 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#1] ext.html Cycles:180 Average:72798.65 Median:40269.29 stddev:166604.15 (413.7%) stddev-sans-first:166982.99 16:01:53 INFO - PROCESS | 2028 | Values: 462.0 471.7 474.1 479.7 533.4 35909.6 42073.6 42078.6 42086.6 42351.8 42370.0 42653.8 42880.6 42972.0 43021.8 9622.0 9825.5 9854.1 9873.9 9879.0 9820.9 9897.0 9909.0 9921.7 9943.8 9889.0 9908.1 9939.0 9953.7 10003.2 9855.7 9904.3 9931.7 9936.1 9960.4 9821.3 9890.3 9893.7 9904.7 9949.2 39518.0 40152.4 40584.4 40654.8 40680.0 3060.8 3154.4 3177.9 3216.5 3260.0 29489.9 30633.8 30702.7 31178.8 31409.2 3117.1 3266.8 3273.7 3278.4 3288.7 461067.0 463109.0 466442.0 467092.0 467427.0 31809.2 60417.1 64573.0 65178.7 65260.0 35075.1 35237.5 35930.5 35993.8 36001.1 15102.2 15134.5 15185.6 15200.0 15216.5 12870.4 12907.9 12993.2 13024.9 13033.2 6634.3 7777.2 7802.4 7834.7 7839.8 3036.9 3039.7 3280.7 3281.4 3299.7 957.3 966.6 1047.5 1062.0 1068.2 30344.2 30950.7 30966.7 30973.8 31324.5 985.7 997.0 1019.4 1060.7 1091.8 12006.8 13195.1 14305.0 17047.8 17137.3 710849.0 723851.0 725886.0 726881.0 727124.0 59712.0 60009.1 60513.0 60607.7 60847.4 1373.4 1384.1 1400.5 1405.5 1406.7 30366.7 30970.2 32101.9 32138.8 32808.2 51663.2 51989.0 52300.5 52382.2 52658.7 563024.4 660944.0 663777.0 663846.0 665864.0 22677.9 22954.3 23932.9 26033.6 27161.9 46535.3 46797.3 47458.0 48787.8 48869.3 38230.6 39601.6 39710.0 40386.2 40865.4 35026.3 39044.4 39973.6 40585.8 40855.4 36894.1 38447.8 39326.2 40100.2 41469.8 33799.0 35717.7 35870.0 36047.3 36230.6 26863.9 26963.6 27047.1 27103.9 27482.9 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#2] jquery.html Cycles:180 Average:33427.48 Median:25472.74 stddev:90618.60 (355.7%) stddev-sans-first:90838.75 16:01:53 INFO - PROCESS | 2028 | Values: 339.3 382.3 384.3 387.3 403.9 19370.7 20859.5 21101.4 21320.8 21443.8 19894.7 20105.5 20472.9 20551.8 20635.5 5786.8 5799.1 6007.7 6046.5 6058.4 4137.1 4354.7 5925.7 6024.0 6026.1 6248.8 6537.7 6605.6 6655.6 6657.5 6397.2 6585.4 6623.0 6635.0 6646.7 5693.6 5713.7 5753.1 5753.8 5794.0 25207.0 25319.5 25336.9 25608.6 25740.8 2251.6 2253.2 2361.2 2658.3 2698.9 15165.0 15269.8 15375.5 15691.4 15969.9 1806.3 1836.9 1873.0 1894.6 1901.0 105448.4 109672.9 114759.0 119934.0 122120.0 11137.8 11255.9 11304.6 11634.3 11772.9 12852.8 14538.9 14654.6 14714.0 14798.9 8632.1 8754.5 8827.7 8916.3 8927.3 6744.0 6889.3 8212.7 8563.5 8900.6 3937.9 4089.9 4606.8 4640.8 4675.1 1848.4 1933.1 1980.1 1988.1 1993.6 834.0 882.7 960.6 967.6 978.5 19956.8 20337.7 20357.8 20542.7 20982.5 781.9 970.7 973.4 985.8 1011.0 10633.8 10940.9 10970.0 10974.8 10980.8 526945.0 529231.0 540246.0 540647.0 561381.0 122234.0 125136.0 129957.0 130024.0 130286.0 821.8 824.2 897.8 912.6 931.6 14828.8 18170.7 18193.6 18293.5 18535.1 40396.2 51221.7 51698.0 53975.9 55298.4 81506.0 82045.6 82160.8 82800.0 83527.9 7305.6 8145.8 8246.0 8352.7 8364.8 10921.6 12179.0 12203.9 12373.4 12592.0 8782.0 10630.0 10673.7 10751.8 11004.2 10508.8 10633.6 10644.5 10890.8 11162.9 10498.9 10719.0 11088.6 11144.1 11264.3 8162.9 8183.8 8343.8 8407.5 8439.0 10859.0 10905.9 10952.3 11105.2 11353.5 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#3] mootools.html Cycles:180 Average:5840.17 Median:4531.26 stddev:3361.71 (74.2%) stddev-sans-first:3354.41 16:01:53 INFO - PROCESS | 2028 | Values: 1377.3 1458.7 1583.5 1783.5 1841.1 8211.7 8467.9 8697.2 9287.4 9354.6 8184.5 8735.4 9052.5 9062.2 9106.6 1910.8 2153.4 2403.8 2416.4 2417.2 2369.8 2394.2 2413.2 2414.9 2420.8 2403.9 2405.9 2414.6 2428.7 2435.3 2119.5 2339.8 2383.9 2396.5 2399.9 2365.1 2381.3 2403.5 2407.4 2413.5 9070.3 9090.2 9174.2 9177.0 9194.7 5347.1 5505.3 5510.6 5511.8 5513.3 3645.6 3651.0 3664.6 3689.8 3709.8 1055.7 1070.9 1072.7 1072.7 1074.7 12030.3 12179.9 12202.0 12278.6 12320.7 4793.5 4818.8 4839.9 4965.8 4980.5 10321.6 10410.0 10435.7 10444.0 10452.0 5509.4 5509.6 5523.3 5529.2 5546.1 4433.8 4628.7 4784.5 5022.0 5024.4 4069.8 4095.5 4116.8 4199.6 4214.0 1303.8 1307.2 1317.3 1321.5 1323.9 678.4 687.0 779.8 877.5 949.7 6012.2 6067.4 6101.4 6130.5 6280.0 373.0 430.0 438.5 438.9 443.6 3598.6 3992.6 4033.5 4046.0 4119.4 10860.0 11128.8 11159.3 11242.3 11287.9 11140.7 11150.2 11168.3 11186.3 11222.5 8255.5 8306.2 8438.7 8515.0 8526.7 5788.0 5926.8 5962.3 6038.6 6100.8 10045.3 10211.0 10427.4 10448.6 10464.7 10315.8 10328.4 10586.5 10592.5 10843.3 5909.2 7166.9 7521.1 7582.5 7869.0 8467.7 8655.0 8656.1 8659.1 8714.7 7518.0 7742.3 7786.6 7814.8 7962.6 7500.8 7643.7 7650.0 7675.9 7800.8 5900.6 6210.4 6285.8 6553.9 6808.1 4644.8 4821.9 5058.8 5081.4 5147.2 5118.9 5206.1 5212.4 5228.2 5235.5 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#4] prototype.html Cycles:180 Average:4483.72 Median:4868.26 stddev:1404.52 (28.9%) stddev-sans-first:1372.31 16:01:53 INFO - PROCESS | 2028 | Values: 265.8 276.3 307.8 311.6 321.1 4862.3 5291.4 5379.3 5686.3 5756.1 4534.2 4664.6 5551.5 5559.9 5611.5 3761.0 3926.9 4080.6 4090.4 4230.7 3358.0 3973.8 4280.1 4283.3 4290.5 3641.7 4169.5 4180.0 4203.8 4220.5 3514.6 4209.9 4219.3 4227.8 4238.7 3613.6 3621.5 3648.5 3653.7 3661.4 5272.6 5354.7 5403.3 5441.4 5477.9 4837.3 4865.6 4866.7 4869.8 4900.7 5694.4 5864.8 5905.7 5966.3 5974.0 3943.8 3944.5 3950.8 3985.3 3997.7 4995.4 5144.2 5681.3 6177.4 6201.9 3290.6 3585.6 4033.4 4034.7 4057.9 3386.1 3932.3 3970.2 3981.8 4056.4 4276.8 4822.2 4829.5 4841.2 4849.7 5139.3 5232.8 5892.6 5940.5 6006.7 1274.2 1297.8 1358.5 1376.7 1378.9 699.3 721.9 815.2 829.8 842.3 3980.1 4174.9 4601.7 4689.9 4709.1 4348.6 4734.6 4947.4 5027.8 5146.5 3886.7 3936.1 4357.4 4594.6 4689.8 2276.7 2562.9 2584.4 2636.9 2708.3 4510.7 4514.8 4778.9 5022.8 5206.7 4997.5 5141.6 5182.6 5248.3 5262.9 4363.0 4547.1 5095.2 5209.9 5233.6 4963.6 5073.3 5081.4 5137.8 5172.6 4341.7 4948.9 5055.9 5061.7 5131.7 5616.8 6350.3 6376.0 6417.6 6460.2 3337.7 3494.9 3584.3 3999.5 4183.9 5205.6 5407.1 5965.6 6103.8 6149.9 4993.6 5143.0 5313.8 5910.3 5981.2 5796.0 5817.5 5999.8 6013.7 6018.5 4753.7 5282.3 5552.9 5652.5 5859.6 4502.8 5378.8 5742.6 5947.3 6068.9 5533.1 5571.0 5753.8 5887.6 5911.5 16:01:53 INFO - PROCESS | 2028 | 16:01:53 INFO - PROCESS | 2028 | [#5] yui.html Cycles:180 Average:23391.69 Median:3838.25 stddev:37736.38 (983.2%) stddev-sans-first:37803.76 16:01:53 INFO - PROCESS | 2028 | Values: 693.5 701.8 709.4 712.5 713.5 14761.4 15307.9 15496.8 15619.8 15697.8 12353.2 13844.5 14122.9 14235.8 14374.4 832.5 845.3 845.7 846.9 848.4 666.0 685.3 827.5 855.7 859.4 879.5 909.0 909.7 910.2 912.0 894.6 897.0 897.7 898.6 900.4 660.4 665.8 666.0 666.4 667.5 14764.3 14764.9 14778.3 14918.7 14960.2 11458.3 12708.5 14745.6 14786.6 14959.6 9089.0 11271.0 11687.2 11972.8 12024.3 3668.4 3795.6 3814.8 3861.7 3886.9 117961.0 121628.0 123939.0 126206.4 129244.0 11027.7 11160.3 11257.8 11279.0 11281.9 22514.8 22679.5 22887.8 22901.8 22962.3 8081.1 8081.6 8105.9 8117.5 8202.2 4365.2 4451.4 4455.9 4466.8 4544.0 3534.8 3639.6 3669.2 3671.0 3675.6 620.1 625.2 629.9 634.2 645.4 606.5 628.9 635.2 650.6 654.2 9031.8 9536.9 9543.0 9731.4 9749.0 539.4 562.6 640.9 668.1 688.1 4029.5 4284.0 4493.7 4623.7 4720.8 86617.1 122513.0 126800.0 142480.0 142673.3 124099.0 125792.1 130080.0 131837.3 132978.0 101372.5 107975.0 109151.5 109164.0 111887.0 6939.4 8282.3 8349.9 8634.4 8958.4 55696.4 59858.0 59868.7 60678.0 61508.7 43231.6 54031.0 57886.7 88606.0 90368.1 11392.4 11773.5 11889.1 12036.9 12194.9 10240.1 11992.9 12173.6 12178.1 12556.6 12040.8 12075.0 12126.5 12207.9 12373.3 11963.6 12065.1 12114.0 12580.9 12710.4 11923.9 11972.3 11984.9 12220.9 12281.7 8326.6 8375.5 8483.5 8668.7 8815.5 10203.2 10314.5 10333.9 10348.2 10372.3 16:01:53 INFO - PROCESS | 2028 | -------- Summary: end -------- 16:01:53 INFO - PROCESS | 2028 | 16:01:54 INFO - TEST-INFO | 2028: exit 0 16:01:54 INFO - TEST-OK | dromaeo_css | took 1113099ms 16:01:54 INFO - TEST-START | kraken 16:01:54 INFO - operating with platform_type : mac_ 16:01:54 INFO - Initialising browser for kraken test... 16:01:54 INFO - TEST-INFO | started process 2033 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpuMdK7t/profile http://localhost:49401/getInfo.html) 16:01:56 INFO - PROCESS | 2033 | __metrics Screen width/height:1600/1200 16:01:56 INFO - PROCESS | 2033 | colorDepth:24 16:01:56 INFO - PROCESS | 2033 | Browser inner width/height: 1024/689 16:01:56 INFO - PROCESS | 2033 | __metrics 16:01:57 ERROR - PROCESS | 2033 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:01:57 INFO - TEST-INFO | 2033: exit 0 16:01:57 INFO - Browser initialized. 16:01:57 INFO - Running cycle 1/1 for kraken test... 16:01:57 INFO - TEST-INFO | started process 2035 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpuMdK7t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:09 INFO - PROCESS | 2035 | RSS: Main: 224964608 16:02:09 INFO - PROCESS | 2035 | 16:02:12 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:13 INFO - PROCESS | 2035 | RSS: Main: 237314048 16:02:13 INFO - PROCESS | 2035 | 16:02:16 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-dft) 16:02:17 INFO - PROCESS | 2035 | RSS: Main: 244723712 16:02:17 INFO - PROCESS | 2035 | 16:02:20 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-fft) 16:02:20 INFO - PROCESS | 2035 | RSS: Main: 248373248 16:02:20 INFO - PROCESS | 2035 | 16:02:22 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator) 16:02:23 INFO - PROCESS | 2035 | RSS: Main: 250032128 16:02:23 INFO - PROCESS | 2035 | 16:02:25 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:25 INFO - PROCESS | 2035 | RSS: Main: 250220544 16:02:25 INFO - PROCESS | 2035 | 16:02:28 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:29 INFO - PROCESS | 2035 | RSS: Main: 251244544 16:02:29 INFO - PROCESS | 2035 | 16:02:32 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:33 INFO - PROCESS | 2035 | RSS: Main: 251224064 16:02:33 INFO - PROCESS | 2035 | 16:02:36 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial) 16:02:36 INFO - PROCESS | 2035 | RSS: Main: 251633664 16:02:36 INFO - PROCESS | 2035 | 16:02:38 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:39 INFO - PROCESS | 2035 | RSS: Main: 251236352 16:02:39 INFO - PROCESS | 2035 | 16:02:41 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:41 INFO - PROCESS | 2035 | RSS: Main: 251277312 16:02:41 INFO - PROCESS | 2035 | 16:02:43 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:44 INFO - PROCESS | 2035 | RSS: Main: 251191296 16:02:44 INFO - PROCESS | 2035 | 16:02:47 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:48 INFO - PROCESS | 2035 | RSS: Main: 251531264 16:02:48 INFO - PROCESS | 2035 | 16:02:51 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:51 INFO - PROCESS | 2035 | RSS: Main: 251666432 16:02:51 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49401/tests/kraken/driver.html?testName=ai-astar) 16:02:53 INFO - PROCESS | 2035 | RSS: Main: 253349888 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | __start_tp_report 16:02:53 INFO - PROCESS | 2035 | _x_x_mozilla_page_load 16:02:53 INFO - PROCESS | 2035 | _x_x_mozilla_page_load_details 16:02:53 INFO - PROCESS | 2035 | |i|pagename|runs| 16:02:53 INFO - PROCESS | 2035 | |0;ai-astar;122;159;116;116;113;117;115;115;115;116 16:02:53 INFO - PROCESS | 2035 | |1;audio-beat-detection;182;129;117;177;136;113;111;110;144;114 16:02:53 INFO - PROCESS | 2035 | |2;audio-dft;201;192;205;200;194;199;198;195;199;196 16:02:53 INFO - PROCESS | 2035 | |3;audio-fft;83;61;58;87;59;59;60;55;79;59 16:02:53 INFO - PROCESS | 2035 | |4;audio-oscillator;84;71;90;72;70;71;88;67;83;75 16:02:53 INFO - PROCESS | 2035 | |5;imaging-gaussian-blur;89;88;101;88;105;86;82;125;89;86 16:02:53 INFO - PROCESS | 2035 | |6;imaging-darkroom;150;97;129;101;147;104;149;102;148;148 16:02:53 INFO - PROCESS | 2035 | |7;imaging-desaturate;76;152;152;92;93;91;93;92;90;91 16:02:53 INFO - PROCESS | 2035 | |8;json-parse-financial;47;47;82;82;85;87;86;72;60;60 16:02:53 INFO - PROCESS | 2035 | |9;json-stringify-tinderbox;70;77;70;84;76;74;68;69;69;63 16:02:53 INFO - PROCESS | 2035 | |10;stanford-crypto-aes;83;84;84;85;84;85;88;85;80;85 16:02:53 INFO - PROCESS | 2035 | |11;stanford-crypto-ccm;135;153;157;148;138;139;158;164;195;149 16:02:53 INFO - PROCESS | 2035 | |12;stanford-crypto-pbkdf2;208;192;165;163;164;164;169;168;142;212 16:02:53 INFO - PROCESS | 2035 | |13;stanford-crypto-sha256-iterative;60;78;90;86;68;56;59;83;86;71 16:02:53 INFO - PROCESS | 2035 | __end_tp_report 16:02:53 INFO - PROCESS | 2035 | __start_cc_report 16:02:53 INFO - PROCESS | 2035 | _x_x_mozilla_cycle_collect,944 16:02:53 INFO - PROCESS | 2035 | __end_cc_report 16:02:53 INFO - PROCESS | 2035 | __startTimestamp1474585373690__endTimestamp 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | ------- Summary: start ------- 16:02:53 INFO - PROCESS | 2035 | Number of tests: 14 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#0] ai-astar Cycles:10 Average:120.40 Median:116.00 stddev:13.76 (11.9%) stddev-sans-first:14.58 16:02:53 INFO - PROCESS | 2035 | Values: 122.0 159.0 116.0 116.0 113.0 117.0 115.0 115.0 115.0 116.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:132.50 stddev:26.90 (20.3%) stddev-sans-first:22.01 16:02:53 INFO - PROCESS | 2035 | Values: 182.0 129.0 117.0 177.0 136.0 113.0 111.0 110.0 144.0 114.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#2] audio-dft Cycles:10 Average:197.90 Median:199.00 stddev:3.78 (1.9%) stddev-sans-first:3.84 16:02:53 INFO - PROCESS | 2035 | Values: 201.0 192.0 205.0 200.0 194.0 199.0 198.0 195.0 199.0 196.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.98 (19.8%) stddev-sans-first:11.02 16:02:53 INFO - PROCESS | 2035 | Values: 83.0 61.0 58.0 87.0 59.0 59.0 60.0 55.0 79.0 59.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:79.00 stddev:8.33 (10.5%) stddev-sans-first:8.46 16:02:53 INFO - PROCESS | 2035 | Values: 84.0 71.0 90.0 72.0 70.0 71.0 88.0 67.0 83.0 75.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:87.00 stddev:13.02 (15.0%) stddev-sans-first:13.68 16:02:53 INFO - PROCESS | 2035 | Values: 89.0 88.0 101.0 88.0 105.0 86.0 82.0 125.0 89.0 86.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#6] imaging-darkroom Cycles:10 Average:127.50 Median:148.00 stddev:23.63 (16.0%) stddev-sans-first:23.62 16:02:53 INFO - PROCESS | 2035 | Values: 150.0 97.0 129.0 101.0 147.0 104.0 149.0 102.0 148.0 148.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:91.50 stddev:26.72 (29.2%) stddev-sans-first:26.60 16:02:53 INFO - PROCESS | 2035 | Values: 76.0 152.0 152.0 92.0 93.0 91.0 93.0 92.0 90.0 91.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#8] json-parse-financial Cycles:10 Average:70.80 Median:82.00 stddev:16.03 (19.6%) stddev-sans-first:14.51 16:02:53 INFO - PROCESS | 2035 | Values: 47.0 47.0 82.0 82.0 85.0 87.0 86.0 72.0 60.0 60.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.00 stddev:5.89 (8.2%) stddev-sans-first:6.20 16:02:53 INFO - PROCESS | 2035 | Values: 70.0 77.0 70.0 84.0 76.0 74.0 68.0 69.0 69.0 63.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:2.00 (2.4%) stddev-sans-first:2.07 16:02:53 INFO - PROCESS | 2035 | Values: 83.0 84.0 84.0 85.0 84.0 85.0 88.0 85.0 80.0 85.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:155.00 stddev:17.35 (11.2%) stddev-sans-first:17.04 16:02:53 INFO - PROCESS | 2035 | Values: 135.0 153.0 157.0 148.0 138.0 139.0 158.0 164.0 195.0 149.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:168.50 stddev:22.13 (13.1%) stddev-sans-first:19.92 16:02:53 INFO - PROCESS | 2035 | Values: 208.0 192.0 165.0 163.0 164.0 164.0 169.0 168.0 142.0 212.0 16:02:53 INFO - PROCESS | 2035 | 16:02:53 INFO - PROCESS | 2035 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:80.50 stddev:12.61 (15.7%) stddev-sans-first:12.36 16:02:53 INFO - PROCESS | 2035 | Values: 60.0 78.0 90.0 86.0 68.0 56.0 59.0 83.0 86.0 71.0 16:02:53 INFO - PROCESS | 2035 | -------- Summary: end -------- 16:02:53 INFO - PROCESS | 2035 | 16:02:54 INFO - TEST-INFO | 2035: exit 0 16:02:54 INFO - TEST-OK | kraken | took 60311ms 16:02:54 INFO - SUITE-END | took 1173s 16:02:54 INFO - Completed test suite (00:19:33) 16:02:54 INFO - javascript benchmark 16:02:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.147201126905, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2850.52966260567, 3085.475469170241, 3434.484827275907, 3466.497357883107, 3469.583649962005, 4468.709533880304, 4661.207594708899, 5116.897662046761, 5227.398849132351, 5928.347881733006, 5993.370696076903, 6020.6086604370685, 6027.0, 6042.8489287767825, 6042.909356359658, 5359.249705041288, 5415.350157981028, 5427.674339539621, 5450.754716037768, 5459.3994660587305, 5483.424240454755, 5486.862828429301, 5491.478309560585, 5500.1749737539285, 5528.308961379827, 4583.152116858392, 5359.732013399314, 5367.194920761878, 5470.753816078286, 5483.588730845183, 5349.277847490578, 5422.8915421691545, 5434.673919564799, 5500.22996780451, 5555.861103472445, 4896.510348965111, 5083.856132370224, 5361.651492652965, 5427.48438898304, 5460.945390546083, 5813.215215945836, 6034.336223015464, 6061.393860613947, 6103.6032657877095, 6120.234970628671, 5815.505682017034, 6070.848228794315, 6173.660448675321, 6280.937190628081, 6350.26971898233, 6432.51756118293, 6438.645874476902, 6443.3234510376205, 6448.967755161241, 6454.064160696719, 6157.230346206724, 6166.445019948182, 6167.691615419211, 6169.290531588835, 6176.382361763833, 6236.532260080512, 6299.905501417483, 6331.303556608769, 6336.017917222838, 6542.7710030149665, 6225.844353891189, 6272.341404152589, 6280.560360774702, 6286.779962701284, 6297.0, 6365.8726825464155, 6369.426751592287, 6391.2330520337855, 6399.488040956712, 6402.455791257796, 6170.50635949123, 6215.12988181655, 6282.0, 6308.7476500940365, 6323.747050117944, 6217.658028808459, 6246.3753624637175, 6267.091271765568, 6295.401936815995, 6340.175777148941, 5071.594272458195, 5086.92369614456, 5087.465816089258, 5096.923546146811, 5114.181730923035, 4484.820607175677, 4568.223402021665, 4573.428321459817, 4594.081183763261, 4610.2854057621125, 5822.417758224228, 6039.094135879654, 6072.089186621954, 6086.2087928569, 6178.320384757673, 5665.830025099253, 6376.968115159394, 6387.041943708481, 6408.935910640927, 6410.1987251593555, 5990.760369585168, 6042.305134909541, 6058.727357268934, 6072.058830881132, 6114.2357205349335, 4779.283107533898, 5566.582506312043, 5579.0, 5600.6919619420505, 5609.382967873531, 6564.179477565304, 6572.277049524549, 6573.0, 6578.868422631424, 6597.406233439014, 6159.168512250968, 6202.2867370253, 6302.432781049728, 6367.458766004941, 6394.552381333262, 6398.872022559616, 6578.309277525791, 6587.143671322698, 6600.471962242913, 6608.041833934149, 6322.0516922462, 6323.747050117944, 6329.303776584664, 6353.301136875032, 6354.586951848115, 6214.751409943732, 6270.905936411049, 6359.17330747, 6406.583572067801, 6433.131527243762, 6166.660833654013, 6184.752609895554, 6210.658413787285, 6273.466755325849, 6273.65494897785, 6204.658743769136, 6214.378562143749, 6230.470410015199, 6250.499960003098, 6254.937450625435, 4638.8608341749805, 6058.091286307089, 6185.288691800501, 6221.844453888689, 6258.655773932477, 5752.7698892043845, 6153.107799369156, 6197.070439433941, 6240.687965601793, 6273.592216505913, 6241.719122639583, 6256.655883926428, 6258.499320054476, 6267.059941008885, 6282.874342513215], "value": 5825.063920225355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.96519795657724, 471.74290011943486, 474.0660898030878, 479.7097755857704, 533.4212379568169, 35909.64090359095, 42073.57926420735, 42078.57921420785, 42086.57913420869, 42351.78824105875, 42370.0, 42653.7867310663, 42880.571194288044, 42972.0, 43021.78489107558, 9622.037796220375, 9825.459599722013, 9854.113129818315, 9873.851892221623, 9879.0120987901, 9820.852687209697, 9896.960819113998, 9909.009099090106, 9921.65274215399, 9943.801123977517, 9889.0, 9908.108270255676, 9938.950305248463, 9953.701388958307, 10003.249756268273, 9855.704328870146, 9904.306698531105, 9931.702048938543, 9936.105750482455, 9960.352577082538, 9821.312508124434, 9890.258230632731, 9893.653722119763, 9904.702858914245, 9949.154321882648, 39518.0, 40152.39771403431, 40584.39123413151, 40654.79672601618, 40680.0, 3060.816351018946, 3154.4006638738565, 3177.8887738929257, 3216.533602627629, 3259.951100733491, 29489.852550737323, 30633.846830765702, 30702.69297307043, 31178.844105779554, 31409.214769630715, 3117.096042147797, 3266.8366581671057, 3273.65626609205, 3278.426275401795, 3288.6875746804017, 461067.0, 463109.0, 466442.0, 467092.0, 467426.9999999966, 31809.204769880474, 60417.09374359388, 64573.0, 65178.674106629165, 65260.0, 35075.12312192216, 35237.47143792845, 35930.461043084375, 35993.820030899675, 36001.099972500895, 15102.169380684169, 15134.545963621109, 15185.6203594911, 15200.0, 15216.543503694907, 12870.420831062625, 12907.935460322826, 12993.220406775623, 13024.869751302555, 13033.218006919615, 6634.336566343423, 7777.1833957433655, 7802.375809935192, 7834.725784597512, 7839.764807055797, 3036.9067135831083, 3039.7264246217505, 3280.6883346082086, 3281.425750493654, 3299.6535363786456, 957.2963871554402, 966.6133546581424, 1047.539082803564, 1061.9787604248027, 1068.1881769854965, 30344.241393965327, 30950.690493094782, 30966.69033309683, 30973.845130774203, 31324.530132048036, 985.7437066362654, 996.9601215951426, 1019.4249883929347, 1060.7189094889861, 1091.8089334366455, 12006.819897701542, 13195.140311781903, 14304.998650094602, 17047.829521704873, 17137.314507419815, 710849.0, 723851.0, 725886.0, 726881.0, 727124.0, 59712.0, 60009.09986350208, 60513.0, 60607.696961515794, 60847.391526085055, 1373.3888419653158, 1384.0795870746042, 1400.4538230090477, 1405.5221224783622, 1406.69052808382, 30366.696333036387, 30970.22574435567, 32101.876434325623, 32138.839305804257, 32808.17979550435, 51663.225051625006, 51989.0, 52300.47699523108, 52382.21426678527, 52658.683532911986, 563024.3697563136, 660944.0, 663777.0, 663846.0, 665864.0, 22677.886610566842, 22954.311370658907, 23932.88033559821, 26033.609495857956, 27161.91352345884, 46535.301970469794, 46797.29804052874, 47458.0, 48787.756061219465, 48869.26696099633, 38230.60389655354, 39601.603983959794, 39710.0, 40386.19227615373, 40865.38701919414, 35026.299474009866, 39044.41433378445, 39973.60026399699, 40585.79707101446, 40855.38716919308, 36894.077648059014, 38447.8465646031, 39326.21347572975, 40100.1979960405, 41469.79265103776, 33799.0, 35717.74987875412, 35870.0, 36047.27905441929, 36230.637693622724, 26863.86568067147, 26963.595546067216, 27047.053353132545, 27103.864480677472, 27482.862585686944], "value": 18952.50023729968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.29257498116425, 382.28894256682565, 384.2833116238215, 387.26613068235713, 403.9457017185146, 19370.70943935842, 20859.478513037182, 21101.366958991235, 21320.827354495497, 21443.785562144374, 19894.70157947632, 20105.497362565944, 20472.89763551184, 20551.794482055175, 20635.484112897186, 5786.797462088828, 5799.072148456248, 6007.699615019232, 6046.486048685867, 6058.39416058395, 4137.110521237933, 4354.738715677054, 5925.733341999598, 6023.975924092914, 6026.126211699323, 6248.750049997994, 6537.738490460376, 6605.603663780164, 6655.567388119781, 6657.533972621918, 6397.200349956255, 6585.407313341799, 6623.039659249406, 6634.966825165843, 6646.734130634769, 5693.601447898649, 5713.74288157034, 5753.079507278857, 5753.7986170484255, 5794.0, 25207.0, 25319.49361012788, 25336.873315633304, 25608.61587076177, 25740.84166212506, 2251.617225071742, 2253.188852013274, 2361.2089949866813, 2658.2822637887857, 2698.89345368398, 15165.01427407215, 15269.847301527065, 15375.461858834888, 15691.372345106181, 15969.92015039929, 1806.3136008316887, 1836.898970556619, 1873.0447471789485, 1894.6400183965002, 1900.9904950475297, 105448.41827372595, 109672.90327096627, 114759.0, 119934.0, 122120.00439503393, 11137.777244455228, 11255.887441125647, 11304.604338848101, 11634.301941883345, 11772.882271177179, 12852.807207891701, 14538.927305363406, 14654.63363415923, 14714.0435871668, 14798.852011479747, 8632.050474447806, 8754.47473151613, 8827.735167944971, 8916.331275154389, 8927.285817134614, 6744.0, 6889.311068893071, 8212.671493140328, 8563.529005904735, 8900.599473023729, 3937.9212415751526, 4089.9182016359505, 4606.848287928018, 4640.767961601907, 4675.13510000651, 1848.3623150013225, 1933.1494142577221, 1980.059541649163, 1988.1450976080425, 1993.5813479169246, 833.9666413343398, 882.7042940614838, 960.5917485068818, 967.5936106835146, 978.4716253223322, 19956.800431995493, 20337.694934575993, 20357.77853328805, 20542.69185962212, 20982.47543811417, 781.8741012941347, 970.708787363788, 973.4305431322614, 985.8373368394278, 1010.9797804044025, 10633.787324253626, 10940.945295273472, 10970.0, 10974.835377469344, 10980.835287470694, 526945.0, 529231.0, 540246.0, 540647.0, 561381.0, 122234.0, 125136.0, 129957.0, 130024.0, 130286.0, 821.7863355527486, 824.1840577827908, 897.8014350841569, 912.5683327064029, 931.5901003558413, 14828.777568336267, 18170.72743908816, 18193.636127277117, 18293.54266143357, 18535.07324633736, 40396.18217180175, 51221.743891280305, 51697.96604067822, 53975.92048159093, 55298.44701552933, 81506.0, 82045.58977205076, 82160.76758848742, 82800.0, 83527.91180220543, 7305.5981920994855, 8145.79635509117, 8245.95877020611, 8352.707655232038, 8364.832703346021, 10921.563137474412, 12179.0, 12203.877961220274, 12373.443195056065, 12592.0, 8781.956090219508, 10630.0, 10673.679789606324, 10751.838722419327, 11004.22970392097, 10508.842367364648, 10633.574657013942, 10644.520996555018, 10890.836637450602, 11162.888371116185, 10498.895011050097, 10719.0, 11088.611898583511, 11144.108471322437, 11264.324140551593, 8162.918370816215, 8183.836323273382, 8343.791405214675, 8407.45351552147, 8438.987321521457, 10859.0, 10905.890941090805, 10952.288101273392, 11105.22845783472, 11353.54585816558], "value": 9605.274457980533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.3044612470703, 1458.7009663019078, 1583.5011971229062, 1783.500619826449, 1841.1438681013326, 8211.671533138668, 8467.91532084679, 8697.173768491992, 9287.44275343479, 9354.625814967401, 8184.549849758261, 8735.388522803407, 9052.502112383816, 9062.184403403693, 9106.635734570626, 1910.761154855643, 2153.4078128514625, 2403.807695384365, 2416.4079800448912, 2417.226487523993, 2369.7748713872156, 2394.1500767227644, 2413.227767114524, 2414.915477958272, 2420.7700268474555, 2403.927882163529, 2405.8797060147012, 2414.61366181411, 2428.6842710447618, 2435.2937648082034, 2119.5125121222204, 2339.7894189523026, 2383.880805959695, 2396.5087157132834, 2399.9160029398886, 2365.1485465232504, 2381.2975172324204, 2403.5192961407615, 2407.3620490570015, 2413.4690368118986, 9070.274378049806, 9090.2273306769, 9174.174324310845, 9177.036411176798, 9194.724158275263, 5347.0909945309395, 5505.3393592768725, 5510.559155267609, 5511.834644960658, 5513.338399392099, 3645.5989841117457, 3650.963490365089, 3664.560252769658, 3689.8339574719203, 3709.7774133552075, 1055.6727414501452, 1070.925035247533, 1072.7371793910543, 1072.742541789965, 1074.704456274523, 12030.33833139177, 12179.878201217964, 12201.962833159103, 12278.631641050693, 12320.691982700415, 4793.544613261734, 4818.7831547580445, 4839.879003024882, 4965.82619608312, 4980.5019498049905, 10321.63874264397, 10410.0, 10435.739106522398, 10444.0, 10452.0, 5509.3664228614225, 5509.586780991362, 5523.337199536081, 5529.170624406372, 5546.084895992116, 4433.82264709408, 4628.69913455631, 4784.545468180518, 5021.995600879839, 5024.447310795809, 4069.7558146511305, 4095.5085389752826, 4116.814743336557, 4199.622034016953, 4213.9578604214175, 1303.7913933770742, 1307.1568838099372, 1317.328162637062, 1321.5242512695422, 1323.9470421183046, 678.389449495458, 686.9656517174121, 779.7582749347607, 877.4691311756295, 949.7435692363161, 6012.218411606551, 6067.423594758491, 6101.420365065312, 6130.540209484307, 6279.968600157062, 373.0003590377814, 429.9935500967488, 438.52639149718226, 438.87053319270893, 443.59854331829746, 3598.6401359864326, 3992.5807790182193, 4033.5361433434946, 4045.959540404617, 4119.443875076886, 10860.0, 11128.833067503994, 11159.274647148071, 11242.269252498561, 11287.887121128684, 11140.721481963015, 11150.163737719704, 11168.329900206014, 11186.32882027081, 11222.494987725571, 8255.463394879314, 8306.210909963544, 8438.662453501915, 8515.020772611106, 8526.74419767408, 5788.0, 5926.762929482772, 5962.284525856751, 6038.607490513103, 6100.75596976116, 10045.296829221885, 10211.029952154533, 10427.426491543038, 10448.58205671795, 10464.686059418229, 10315.793684126425, 10328.431936243578, 10586.523606437575, 10592.523336450033, 10843.295185812896, 5909.23179986599, 7166.928330716626, 7521.0974683038385, 7582.507137036075, 7869.0, 8467.66129354819, 8655.0, 8656.091110433566, 8659.13408659129, 8714.694985675724, 7518.0, 7742.303192712683, 7786.649600768093, 7814.804629884071, 7962.641681124247, 7500.774976750488, 7643.694252230071, 7649.9617501912135, 7675.923240767521, 7800.765977020698, 5900.586958913007, 6210.378962103753, 6285.774274016706, 6553.853075711827, 6808.114945057111, 4644.815572029246, 4821.927671084866, 5058.848234552969, 5081.390233172043, 5147.2279158126585, 5118.948810511996, 5206.088934436534, 5212.400573934046, 5228.189630607262, 5235.528802407802], "value": 4562.645667784433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.75284984963986, 276.3257651330753, 307.7553345090653, 311.59959452104044, 321.0897106702498, 4862.319275301461, 5291.444398338177, 5379.300690910186, 5686.346070201928, 5756.136579513075, 4534.21145995213, 4664.626829853612, 5551.528120109796, 5559.915816415791, 5611.523020543248, 3760.9811950940207, 3926.9018274543223, 4080.632987949041, 4090.4273401723635, 4230.7038507304505, 3357.9664203357897, 3973.80785764271, 4280.058387154821, 4283.336082907154, 4290.4636920384955, 3641.6722494975447, 4169.520505141917, 4179.979100104495, 4203.7687927164, 4220.53574106848, 3514.6485351464903, 4209.894752631178, 4219.261629214906, 4227.8308867645255, 4238.745675259494, 3613.602503724588, 3621.474886141521, 3648.5074514940407, 3653.6711695947492, 3661.3958696814993, 5272.578193744491, 5354.705491197982, 5403.324584426947, 5441.374241962146, 5477.863053423656, 4837.306942570108, 4865.6107511399005, 4866.683665561763, 4869.83124050229, 4900.730459824708, 5694.430556944314, 5864.794732184396, 5905.726295376268, 5966.284045914518, 5973.970130149365, 3943.8028098594955, 3944.467496887941, 3950.8419663213435, 3985.342418500944, 3997.6801855851463, 4995.400551933755, 5144.151215049513, 5681.346645135821, 6177.3822617738315, 6201.906971395388, 3290.634386729528, 3585.587657419378, 4033.3748269018347, 4034.720382983605, 4057.9391309130388, 3386.0519054664733, 3932.3429210834197, 3970.1861118470642, 3981.8009099544906, 4056.350983842571, 4276.786160691953, 4822.228443449031, 4829.492903245179, 4841.15279826029, 4849.709017458964, 5139.306193663882, 5232.816851410183, 5892.616979896293, 5940.524758019435, 6006.669633170218, 1274.222724138275, 1297.8384346010457, 1358.5380970470087, 1376.662717634186, 1378.8968824940007, 699.2972063076576, 721.8881073433627, 815.2133191470259, 829.8049958259804, 842.3093063687717, 3980.0796215727487, 4174.91650167001, 4601.6548758842555, 4689.859304220879, 4709.081729062868, 4348.586884245991, 4734.597559207506, 4947.356843610308, 5027.84916452507, 5146.511081447256, 3886.7279290449396, 3936.0553467168247, 4357.368181613649, 4594.5864872161665, 4689.788959496831, 2276.7040284763207, 2562.8718564071723, 2584.418505836172, 2636.90164057232, 2708.349996000985, 4510.729356238636, 4514.751688657089, 4778.948631301108, 5022.810515322723, 5206.68302605337, 4997.475265097185, 5141.562967147759, 5182.559482444034, 5248.343957005374, 5262.894742105136, 4362.956370436318, 4547.113312903952, 5095.223103408725, 5209.895802084013, 5233.633645644768, 4963.602911767122, 5073.34046573943, 5081.424758324931, 5137.794488220429, 5172.637915345889, 4341.696081274406, 4948.935978764439, 5055.9494405055475, 5061.672270209066, 5131.717755523482, 5616.775328986795, 6350.253680237972, 6376.0, 6417.598672703474, 6460.192475940507, 3337.748344370861, 3494.9126271843406, 3584.301061293023, 3999.5200575931076, 4183.916321673489, 5205.609579281645, 5407.053156029894, 5965.582409231312, 6103.816885493442, 6149.907751383644, 4993.600511959107, 5142.965650266361, 5313.7778310987915, 5910.320313164041, 5981.222441082631, 5796.0436527972415, 5817.505512031525, 5999.760009599567, 6013.6692481913915, 6018.488428483628, 4753.691010084333, 5282.286891269783, 5552.944470555242, 5652.547796176378, 5859.648421094748, 4502.7523486207265, 5378.811741589026, 5742.569307301886, 5947.256592925884, 6068.878622427438, 5533.142362933751, 5571.019504565038, 5753.769849206153, 5887.558433117619, 5911.527077833849], "value": 4029.438076636856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5041445366562, 701.8034950213939, 709.3899246647882, 712.454971946461, 713.5433322673487, 14761.409543618256, 15307.923460382683, 15496.845031549696, 15619.843801561981, 15697.843021569795, 12353.19704219225, 13844.515441959533, 14122.929385353058, 14235.786463203034, 14374.425022999094, 832.4547421438967, 845.3490812074699, 845.6786421159951, 846.9153084691543, 848.4145939301893, 665.9700313485905, 685.2873012067469, 827.5324441690456, 855.700504823313, 859.3812455032366, 879.5250564695057, 909.0228004894732, 909.6816114359988, 910.2490445382552, 911.968081117161, 894.579547612621, 896.9730908072768, 897.6992707443014, 898.5686870302259, 900.3697411811758, 660.4188314283448, 665.7802925034775, 665.9733610655568, 666.3869240298889, 667.4626925325111, 14764.335604897806, 14764.852351476562, 14778.26108694561, 14918.70162596753, 14960.177190254532, 11458.312501249951, 12708.491660333575, 14745.557633270912, 14786.630334241623, 14959.551213463614, 9088.954555227181, 11271.0, 11687.240329378563, 11972.820407693891, 12024.278543287342, 3668.3763760160837, 3795.582485926546, 3814.771113733185, 3861.7296789224765, 3886.863959761423, 117961.0, 121628.0, 123939.0, 126206.3689681555, 129243.99999999905, 11027.72430689223, 11160.274582152135, 11257.831132533018, 11279.041281491165, 11281.887181128248, 22514.774852251594, 22679.546409071725, 22887.771122288897, 22901.770982290298, 22962.31113066611, 8081.111077781439, 8081.595920203967, 8105.878411823827, 8117.512949223065, 8202.179782021869, 4365.236083685342, 4451.399061126706, 4455.910881782346, 4466.7766611669285, 4543.977280113644, 3534.7702399344475, 3639.6178401267484, 3669.1927775889794, 3671.0271777978855, 3675.632436756303, 620.0760866309167, 625.2059883947452, 629.8929182039064, 634.2230767310008, 645.3610925184128, 606.493577862481, 628.9370963072394, 635.2155088465742, 650.6193876582158, 654.2214764430313, 9031.77420564478, 9536.904630953602, 9543.0, 9731.44989126316, 9749.0, 539.3958766181823, 562.5836880708247, 640.8782331357028, 668.0813880913744, 688.0607970120749, 4029.5366032906004, 4283.993261583525, 4493.662975276868, 4623.676342656049, 4720.763961801897, 86617.13382866091, 122513.0, 126800.0, 142480.0, 142673.29306827817, 124099.0, 125792.1131183033, 130080.0, 131837.34081329533, 132978.0, 101372.49313753532, 107975.0, 109151.45424272827, 109164.0, 111887.0, 6939.375456208965, 8282.337413006824, 8349.914511113517, 8634.352423568384, 8958.372913895964, 55696.443035570745, 59858.0, 59868.70065649818, 60678.0, 61508.69245653743, 43231.567684322756, 54031.0, 57886.7105664469, 88606.0, 90368.0963190386, 11392.373419462008, 11773.470193841127, 11889.108316876096, 12036.939815300868, 12194.939025304817, 10240.129588985019, 11992.880071199177, 12173.573924912585, 12178.147529672839, 12556.560520381743, 12040.75918481643, 12075.0, 12126.454309556268, 12207.877921220674, 12373.257604543756, 11963.64109076729, 12065.09511786602, 12114.0, 12580.87419125797, 12710.36448177606, 11923.94038029839, 11972.281663100242, 11984.940075299568, 12220.877791221974, 12281.692957675772, 8326.625301861552, 8375.539345336065, 8483.490990540588, 8668.696595619123, 8815.471071735716, 10203.234757393077, 10314.535845887103, 10333.896661033594, 10348.22388320894, 10372.325798823053], "value": 7455.170537364922, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 159.0, 116.0, 116.0, 113.0, 117.0, 115.0, 115.0, 115.0, 116.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 129.0, 117.0, 177.0, 136.0, 113.0, 111.0, 110.0, 144.0, 114.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 192.0, 205.0, 200.0, 194.0, 199.0, 198.0, 195.0, 199.0, 196.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 58.0, 87.0, 59.0, 59.0, 60.0, 55.0, 79.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 90.0, 72.0, 70.0, 71.0, 88.0, 67.0, 83.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 101.0, 88.0, 105.0, 86.0, 82.0, 125.0, 89.0, 86.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 97.0, 129.0, 101.0, 147.0, 104.0, 149.0, 102.0, 148.0, 148.0], "value": 127.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 152.0, 152.0, 92.0, 93.0, 91.0, 93.0, 92.0, 90.0, 91.0], "value": 102.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 82.0, 82.0, 85.0, 87.0, 86.0, 72.0, 60.0, 60.0], "value": 70.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 70.0, 84.0, 76.0, 74.0, 68.0, 69.0, 69.0, 63.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 85.0, 84.0, 85.0, 88.0, 85.0, 80.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 153.0, 157.0, 148.0, 138.0, 139.0, 158.0, 164.0, 195.0, 149.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 192.0, 165.0, 163.0, 164.0, 164.0, 169.0, 168.0, 142.0, 212.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 78.0, 90.0, 86.0, 68.0, 56.0, 59.0, 83.0, 86.0, 71.0], "value": 73.7, "unit": "score"}]}]} 16:02:54 INFO - Return code: 0 16:02:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:02:55 ERROR - # TBPL SUCCESS # 16:02:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:02:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:02:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:02:55 INFO - 2016-09-22 16:02:55.030 screenresolution[2040:14060] starting screenresolution argv=screenresolution get 16:02:55 INFO - 2016-09-22 16:02:55.032 screenresolution[2040:14060] Display 0: 1600x1200x32@60 16:02:55 INFO - 2016-09-22 16:02:55.039 screenresolution[2041:14063] starting screenresolution argv=screenresolution list 16:02:55 INFO - Available Modes on Display 0 16:02:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:02:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:02:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:02:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:02:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:02:55 INFO - Intel Iris: 16:02:55 INFO - Chipset Model: Intel Iris 16:02:55 INFO - Type: GPU 16:02:55 INFO - Bus: Built-In 16:02:55 INFO - VRAM (Dynamic, Max): 1536 MB 16:02:55 INFO - Vendor: Intel (0x8086) 16:02:55 INFO - Device ID: 0x0a2e 16:02:55 INFO - Revision ID: 0x0009 16:02:55 INFO - Displays: 16:02:55 INFO - Display: 16:02:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:02:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:02:55 INFO - Display Serial Number: 1600x1200 60 16:02:55 INFO - Main Display: Yes 16:02:55 INFO - Mirror: Off 16:02:55 INFO - Online: Yes 16:02:55 INFO - Rotation: Supported 16:02:55 INFO - Return code: 0 16:02:55 INFO - Running post-action listener: _resource_record_post_action 16:02:55 INFO - [mozharness: 2016-09-22 23:02:55.282838Z] Finished run-tests step (success) 16:02:55 INFO - Running post-run listener: _resource_record_post_run 16:02:55 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 409600; Write bytes: 660819456; Read time: 15; Write time: 1826 16:02:55 INFO - TinderboxPrint: CPU usage
54.4% 16:02:55 INFO - TinderboxPrint: I/O read bytes / time
409,600 / 15 16:02:55 INFO - TinderboxPrint: I/O write bytes / time
660,819,456 / 1,826 16:02:55 INFO - TinderboxPrint: CPU idle
2,200.8 (45.6%) 16:02:55 INFO - TinderboxPrint: CPU system
975.2 (20.2%) 16:02:55 INFO - TinderboxPrint: CPU user
1,649.7 (34.2%) 16:02:55 INFO - TinderboxPrint: Swap in / out
363,159,552 / 0 16:02:55 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355666432; Write bytes: 355374592; Read time: 27488; Write time: 688 16:02:55 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 409600; Write bytes: 295266304; Read time: 15; Write time: 1102 16:02:55 INFO - Running post-run listener: _upload_blobber_files 16:02:55 INFO - Blob upload gear active. 16:02:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02:55 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 16:02:55 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'] 16:02:55 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 16:02:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:57 INFO - (blobuploader) - INFO - Done attempting. 16:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:58 INFO - (blobuploader) - INFO - Done attempting. 16:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:00 INFO - (blobuploader) - INFO - Done attempting. 16:03:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:00 INFO - Return code: 0 16:03:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72228e9388f6fafebedeec1c92a31b05e662ccb4ed80c65a89a3074ded43474df1fb8235c021aeefefe1077b0f8891d686c8e08ec9366460921d6cc44bbcd143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f505f053065f9bcf0b286aeee5f89d47c190789b967e919bfc65362e032b554d859dfb1e841def44b244fd09fb38c6fa17dc1dec2a7f41b5dfc49bc316fba2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a38ecab2ae82f1a200bd0b638dff66d42368ed83ae65982e2ccfba723230bc4de3a1973813726a8de027112668cd4d3dbc1f0771cbc807fba30fa2c2beabb5"} 16:03:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:00 INFO - Contents: 16:03:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72228e9388f6fafebedeec1c92a31b05e662ccb4ed80c65a89a3074ded43474df1fb8235c021aeefefe1077b0f8891d686c8e08ec9366460921d6cc44bbcd143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f505f053065f9bcf0b286aeee5f89d47c190789b967e919bfc65362e032b554d859dfb1e841def44b244fd09fb38c6fa17dc1dec2a7f41b5dfc49bc316fba2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a38ecab2ae82f1a200bd0b638dff66d42368ed83ae65982e2ccfba723230bc4de3a1973813726a8de027112668cd4d3dbc1f0771cbc807fba30fa2c2beabb5"} 16:03:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:00 INFO - Copying logs to upload dir... 16:03:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.066170 ========= master_lag: 11.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-22 16:03:12.205818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 18 secs) (at 2016-09-22 16:03:12.209614) ========= 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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/72228e9388f6fafebedeec1c92a31b05e662ccb4ed80c65a89a3074ded43474df1fb8235c021aeefefe1077b0f8891d686c8e08ec9366460921d6cc44bbcd143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f505f053065f9bcf0b286aeee5f89d47c190789b967e919bfc65362e032b554d859dfb1e841def44b244fd09fb38c6fa17dc1dec2a7f41b5dfc49bc316fba2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a38ecab2ae82f1a200bd0b638dff66d42368ed83ae65982e2ccfba723230bc4de3a1973813726a8de027112668cd4d3dbc1f0771cbc807fba30fa2c2beabb5"} build_url:https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/VKnx5v3OTpmq_TpIbWwG7w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72228e9388f6fafebedeec1c92a31b05e662ccb4ed80c65a89a3074ded43474df1fb8235c021aeefefe1077b0f8891d686c8e08ec9366460921d6cc44bbcd143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f505f053065f9bcf0b286aeee5f89d47c190789b967e919bfc65362e032b554d859dfb1e841def44b244fd09fb38c6fa17dc1dec2a7f41b5dfc49bc316fba2a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a38ecab2ae82f1a200bd0b638dff66d42368ed83ae65982e2ccfba723230bc4de3a1973813726a8de027112668cd4d3dbc1f0771cbc807fba30fa2c2beabb5"}' ========= master_lag: 18.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 18 secs) (at 2016-09-22 16:03:30.818469) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 16:03:30.818858) ========= 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.OJFxsCLGie/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.Qiuzgq0SKw/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005167 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 16:03:30.884527) ========= ========= Started reboot skipped (results: 3, elapsed: 53 secs) (at 2016-09-22 16:03:30.884829) ========= ========= Finished reboot skipped (results: 3, elapsed: 53 secs) (at 2016-09-22 16:04:24.166254) ========= ========= Total master_lag: 30.41 =========