builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1473735316.64 results: success (0) buildid: 20160912172409 builduid: ef69c4329e574b2597bdf46381087a12 revision: f719635c68de1c14515b4eb1bbb523d56876e1a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.641415) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.641878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.642196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.668524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.669275) ========= 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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-12 19:55:16-- 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% 37.1M=0s 2016-09-12 19:55:16 (37.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086104 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.782856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.783538) ========= 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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.026490 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:16.835459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 19:55:16.836246) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f719635c68de1c14515b4eb1bbb523d56876e1a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f719635c68de1c14515b4eb1bbb523d56876e1a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-12 19:55:16,920 truncating revision to first 12 chars 2016-09-12 19:55:16,920 Setting DEBUG logging. 2016-09-12 19:55:16,920 attempt 1/10 2016-09-12 19:55:16,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f719635c68de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 19:55:17,953 unpacking tar archive at: fx-team-f719635c68de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302244 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 19:55:18.166095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:18.166893) ========= script_repo_revision: f719635c68de1c14515b4eb1bbb523d56876e1a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:18.167860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:18.168587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 19:55:18.188951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-12 19:55:18.189638) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:18 INFO - MultiFileLogger online at 20160912 19:55:18 in /builds/slave/test 19:55:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:55:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:18 INFO - {'append_to_log': False, 19:55:18 INFO - 'base_work_dir': '/builds/slave/test', 19:55:18 INFO - 'blob_upload_branch': 'Fx-Team', 19:55:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:18 INFO - 'branch': 'Fx-Team', 19:55:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:18 INFO - 'config_files': ('talos/mac_config.py',), 19:55:18 INFO - 'default_actions': ('clobber', 19:55:18 INFO - 'read-buildbot-config', 19:55:18 INFO - 'download-and-extract', 19:55:18 INFO - 'populate-webroot', 19:55:18 INFO - 'create-virtualenv', 19:55:18 INFO - 'install', 19:55:18 INFO - 'run-tests'), 19:55:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:18 INFO - 'download_minidump_stackwalk': True, 19:55:18 INFO - 'download_symbols': 'ondemand', 19:55:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:18 INFO - 'installer_path': 'installer.exe', 19:55:18 INFO - 'log_level': 'info', 19:55:18 INFO - 'log_name': 'talos', 19:55:18 INFO - 'log_to_console': True, 19:55:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:55:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:55:18 INFO - 'opt_config_files': (), 19:55:18 INFO - 'pip_index': False, 19:55:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:18 INFO - 'cmd': ('bash', 19:55:18 INFO - '-c', 19:55:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:18 INFO - 'enabled': True, 19:55:18 INFO - 'halt_on_failure': False, 19:55:18 INFO - 'name': 'check_screen_resolution'},), 19:55:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:18 INFO - 'cmd': ('bash', 19:55:18 INFO - '-c', 19:55:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:18 INFO - 'enabled': True, 19:55:18 INFO - 'halt_on_failure': False, 19:55:18 INFO - 'name': 'check_screen_resolution'},), 19:55:18 INFO - 'run_cmd_checks_enabled': True, 19:55:18 INFO - 'sps_profile': False, 19:55:18 INFO - 'sps_profile_interval': 0, 19:55:18 INFO - 'suite': 'dromaeojs-e10s', 19:55:18 INFO - 'system_bits': '32', 19:55:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:18 INFO - 'title': 't-yosemite-r7-0224', 19:55:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:18 INFO - 'use_talos_json': True, 19:55:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:18 INFO - 'work_dir': 'build'} 19:55:18 INFO - [mozharness: 2016-09-13 02:55:18.390253Z] Running clobber step. 19:55:18 INFO - Running pre-action listener: _resource_record_pre_action 19:55:18 INFO - Running main action method: clobber 19:55:18 INFO - rmtree: /builds/slave/test/build 19:55:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:20 INFO - Running post-action listener: _resource_record_post_action 19:55:20 INFO - [mozharness: 2016-09-13 02:55:20.439505Z] Finished clobber step (success) 19:55:20 INFO - [mozharness: 2016-09-13 02:55:20.439621Z] Running read-buildbot-config step. 19:55:20 INFO - Running pre-action listener: _resource_record_pre_action 19:55:20 INFO - Running main action method: read_buildbot_config 19:55:20 INFO - Using buildbot properties: 19:55:20 INFO - { 19:55:20 INFO - "project": "", 19:55:20 INFO - "product": "firefox", 19:55:20 INFO - "script_repo_revision": "production", 19:55:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:55:20 INFO - "repository": "", 19:55:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:55:20 INFO - "buildid": "20160912172409", 19:55:20 INFO - "pgo_build": "False", 19:55:20 INFO - "basedir": "/builds/slave/test", 19:55:20 INFO - "buildnumber": 1, 19:55:20 INFO - "slavename": "t-yosemite-r7-0224", 19:55:20 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:55:20 INFO - "platform": "yosemite_r7", 19:55:20 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 19:55:20 INFO - "branch": "fx-team", 19:55:20 INFO - "repo_path": "integration/fx-team", 19:55:20 INFO - "revision": "f719635c68de1c14515b4eb1bbb523d56876e1a3", 19:55:20 INFO - "stage_platform": "macosx64", 19:55:20 INFO - "builduid": "ef69c4329e574b2597bdf46381087a12", 19:55:20 INFO - "slavebuilddir": "test" 19:55:20 INFO - } 19:55:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:55:20 INFO - Running post-action listener: _resource_record_post_action 19:55:20 INFO - [mozharness: 2016-09-13 02:55:20.442935Z] Finished read-buildbot-config step (success) 19:55:20 INFO - [mozharness: 2016-09-13 02:55:20.443058Z] Running download-and-extract step. 19:55:20 INFO - Running pre-action listener: _resource_record_pre_action 19:55:20 INFO - Running main action method: download_and_extract 19:55:20 INFO - mkdir: /builds/slave/test/build/tests 19:55: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')]} 19:55:20 INFO - trying https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:55:20 INFO - Downloading https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:55:21 INFO - Downloaded 1199 bytes. 19:55:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:55:21 INFO - Using the following test package requirements: 19:55:21 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:55:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:55:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:55:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'jsshell-mac.zip'], 19:55:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:55:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:55:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:55:21 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:55:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:55:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:55:21 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:55:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:55:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:55:22 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:55:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:55:30 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:55:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:55:37 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:55:38 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')]} 19:55:38 INFO - trying https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:55:38 INFO - Downloading https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:55:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:55:41 INFO - Downloaded 111405102 bytes. 19:55:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:55:41 INFO - mkdir: /builds/slave/test/properties 19:55:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:41 INFO - Contents: 19:55:41 INFO - build_url:https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:55:41 INFO - Running post-action listener: _resource_record_post_action 19:55:41 INFO - Running post-action listener: set_extra_try_arguments 19:55:41 INFO - [mozharness: 2016-09-13 02:55:41.665514Z] Finished download-and-extract step (success) 19:55:41 INFO - [mozharness: 2016-09-13 02:55:41.665667Z] Running populate-webroot step. 19:55:41 INFO - Running pre-action listener: _resource_record_pre_action 19:55:41 INFO - Running main action method: populate_webroot 19:55:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:41 INFO - '--tppagecycles', 19:55:41 INFO - '7'], 19:55:41 INFO - 'tests': ['tsvgm']}}, 19:55:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:55:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:55:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:55:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['damp', 'tps']}, 19:55:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'tests': ['damp', 'tps']}, 19:55:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['dromaeo_dom']}, 19:55:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['basic_compositor_video']}, 19:55:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:55:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'other-e10s': {'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['a11yr', 19:55:41 INFO - 'ts_paint', 19:55:41 INFO - 'tpaint', 19:55:41 INFO - 'sessionrestore', 19:55:41 INFO - 'sessionrestore_no_auto_restore', 19:55:41 INFO - 'tabpaint']}, 19:55:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['tsvgx', 19:55:41 INFO - 'tsvgr_opacity', 19:55:41 INFO - 'tart', 19:55:41 INFO - 'tscrollx', 19:55:41 INFO - 'cart']}, 19:55:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:55:41 INFO - 'tsvgr_opacity', 19:55:41 INFO - 'tart', 19:55:41 INFO - 'tscrollx', 19:55:41 INFO - 'cart']}, 19:55:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'talos_options': ['--disable-e10s'], 19:55:41 INFO - 'tests': ['tp5o']}, 19:55:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'tests': ['tp5o']}, 19:55:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'talos_options': ['--disable-e10s', 19:55:41 INFO - '--xperf_path', 19:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:41 INFO - 'tests': ['tp5n']}, 19:55:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:41 INFO - 'talos_options': ['--xperf_path', 19:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:41 INFO - 'tests': ['tp5n']}}, 19:55:41 INFO - 'talos.zip': {'path': '', 19:55:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:41 INFO - Running post-action listener: _resource_record_post_action 19:55:41 INFO - [mozharness: 2016-09-13 02:55:41.684679Z] Finished populate-webroot step (success) 19:55:41 INFO - [mozharness: 2016-09-13 02:55:41.684819Z] Running create-virtualenv step. 19:55:41 INFO - Running pre-action listener: _resource_record_pre_action 19:55:41 INFO - Running main action method: create_virtualenv 19:55:41 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:41 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 19:55:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:41 INFO - Using real prefix '/tools/python27' 19:55:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:45 INFO - Installing pip.................done. 19:55:45 INFO - Return code: 0 19:55:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:45 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')]} 19:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:45 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')]} 19:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:45 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:45 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 19:55:45 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 19:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:45 INFO - 'HOME': '/Users/cltbld', 19:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:45 INFO - 'LOGNAME': 'cltbld', 19:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:45 INFO - 'MOZ_NO_REMOTE': '1', 19:55:45 INFO - 'NO_EM_RESTART': '1', 19:55:45 INFO - 'PAGER': '/bin/cat', 19:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:45 INFO - 'PWD': '/builds/slave/test', 19:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:45 INFO - 'SHELL': '/bin/bash', 19:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:45 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:45 INFO - 'USER': 'cltbld', 19:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:45 INFO - 'XPC_FLAGS': '0x0', 19:55:45 INFO - 'XPC_SERVICE_NAME': '0', 19:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:45 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 19:55:45 INFO - Cleaning up... 19:55:45 INFO - Return code: 0 19:55:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:55:45 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')]} 19:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:45 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')]} 19:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:45 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:45 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 19:55:45 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 19:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:45 INFO - 'HOME': '/Users/cltbld', 19:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:45 INFO - 'LOGNAME': 'cltbld', 19:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:45 INFO - 'MOZ_NO_REMOTE': '1', 19:55:45 INFO - 'NO_EM_RESTART': '1', 19:55:45 INFO - 'PAGER': '/bin/cat', 19:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:45 INFO - 'PWD': '/builds/slave/test', 19:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:45 INFO - 'SHELL': '/bin/bash', 19:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:45 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:45 INFO - 'USER': 'cltbld', 19:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:45 INFO - 'XPC_FLAGS': '0x0', 19:55:45 INFO - 'XPC_SERVICE_NAME': '0', 19:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:45 INFO - Downloading/unpacking psutil>=3.1.1 19:55:45 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 19:55:45 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 19:55:45 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 19:55:45 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 19:55:45 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 19:55:45 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 19:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:49 INFO - Installing collected packages: psutil 19:55:49 INFO - Running setup.py install for psutil 19:55:49 INFO - building 'psutil._psutil_osx' extension 19:55:49 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 19:55:49 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 19:55:49 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 19:55:49 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 19:55:49 INFO - building 'psutil._psutil_posix' extension 19:55:49 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 19:55:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:55:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:55:50 INFO - ^ 19:55:50 INFO - 1 warning generated. 19:55:50 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 19:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:50 INFO - Successfully installed psutil 19:55:50 INFO - Cleaning up... 19:55:50 INFO - Return code: 0 19:55:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:55:50 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')]} 19:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:50 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')]} 19:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:50 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:50 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 19:55:50 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 19:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:50 INFO - 'HOME': '/Users/cltbld', 19:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:50 INFO - 'LOGNAME': 'cltbld', 19:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:50 INFO - 'MOZ_NO_REMOTE': '1', 19:55:50 INFO - 'NO_EM_RESTART': '1', 19:55:50 INFO - 'PAGER': '/bin/cat', 19:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:50 INFO - 'PWD': '/builds/slave/test', 19:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:50 INFO - 'SHELL': '/bin/bash', 19:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:50 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:50 INFO - 'USER': 'cltbld', 19:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:50 INFO - 'XPC_FLAGS': '0x0', 19:55:50 INFO - 'XPC_SERVICE_NAME': '0', 19:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:50 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 19:55:50 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 19:55:50 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 19:55:50 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 19:55:50 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 19:55:50 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 19:55:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:55:53 INFO - Installing collected packages: mozsystemmonitor 19:55:53 INFO - Running setup.py install for mozsystemmonitor 19:55:53 INFO - Successfully installed mozsystemmonitor 19:55:53 INFO - Cleaning up... 19:55:53 INFO - Return code: 0 19:55:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:53 INFO - 'HOME': '/Users/cltbld', 19:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:53 INFO - 'LOGNAME': 'cltbld', 19:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:53 INFO - 'MOZ_NO_REMOTE': '1', 19:55:53 INFO - 'NO_EM_RESTART': '1', 19:55:53 INFO - 'PAGER': '/bin/cat', 19:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:53 INFO - 'PWD': '/builds/slave/test', 19:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:53 INFO - 'SHELL': '/bin/bash', 19:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:53 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:53 INFO - 'USER': 'cltbld', 19:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:53 INFO - 'XPC_FLAGS': '0x0', 19:55:53 INFO - 'XPC_SERVICE_NAME': '0', 19:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:53 INFO - Downloading/unpacking jsonschema==2.5.1 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:55:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:55:56 INFO - warning: no files found matching '*.txt' 19:55:56 INFO - no previously-included directories found matching 'build' 19:55:56 INFO - no previously-included directories found matching 'dist' 19:55:56 INFO - no previously-included directories found matching '.git*' 19:55:56 INFO - Installing collected packages: jsonschema, functools32 19:55:56 INFO - Running setup.py install for functools32 19:55:56 INFO - warning: no files found matching '*.txt' 19:55:56 INFO - no previously-included directories found matching 'build' 19:55:56 INFO - no previously-included directories found matching 'dist' 19:55:56 INFO - no previously-included directories found matching '.git*' 19:55:56 INFO - Successfully installed jsonschema functools32 19:55:56 INFO - Cleaning up... 19:55:56 INFO - Return code: 0 19:55:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:56 INFO - 'HOME': '/Users/cltbld', 19:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:56 INFO - 'LOGNAME': 'cltbld', 19:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:56 INFO - 'MOZ_NO_REMOTE': '1', 19:55:56 INFO - 'NO_EM_RESTART': '1', 19:55:56 INFO - 'PAGER': '/bin/cat', 19:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:56 INFO - 'PWD': '/builds/slave/test', 19:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:56 INFO - 'SHELL': '/bin/bash', 19:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:56 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:56 INFO - 'USER': 'cltbld', 19:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:56 INFO - 'XPC_FLAGS': '0x0', 19:55:56 INFO - 'XPC_SERVICE_NAME': '0', 19:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:55:57 INFO - Cleaning up... 19:55:57 INFO - Return code: 0 19:55:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:55:57 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')]} 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 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')]} 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:55:57 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 19:55:57 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 19:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:57 INFO - 'HOME': '/Users/cltbld', 19:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:57 INFO - 'LOGNAME': 'cltbld', 19:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:57 INFO - 'MOZ_NO_REMOTE': '1', 19:55:57 INFO - 'NO_EM_RESTART': '1', 19:55:57 INFO - 'PAGER': '/bin/cat', 19:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:57 INFO - 'PWD': '/builds/slave/test', 19:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:57 INFO - 'SHELL': '/bin/bash', 19:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:55:57 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:57 INFO - 'USER': 'cltbld', 19:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:57 INFO - 'XPC_FLAGS': '0x0', 19:55:57 INFO - 'XPC_SERVICE_NAME': '0', 19:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:57 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 19:55:57 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 19:55:57 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 19:55:57 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 19:55:57 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 19:55:57 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 19:55:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:00 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 19:56:00 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 19:56:00 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 19:56:00 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 19:56:00 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 19:56:00 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 19:56:00 INFO - Downloading docopt-0.6.1.tar.gz 19:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:01 INFO - Running setup.py install for blobuploader 19:56:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:56:01 INFO - Running setup.py install for requests 19:56:01 INFO - Running setup.py install for docopt 19:56:01 INFO - Successfully installed blobuploader requests docopt 19:56:01 INFO - Cleaning up... 19:56:01 INFO - Return code: 0 19:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:01 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')]} 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:01 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')]} 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:01 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:56:01 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 19:56:01 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 19:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:01 INFO - 'HOME': '/Users/cltbld', 19:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:01 INFO - 'LOGNAME': 'cltbld', 19:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:01 INFO - 'MOZ_NO_REMOTE': '1', 19:56:01 INFO - 'NO_EM_RESTART': '1', 19:56:01 INFO - 'PAGER': '/bin/cat', 19:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:01 INFO - 'PWD': '/builds/slave/test', 19:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:01 INFO - 'SHELL': '/bin/bash', 19:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:56:01 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:01 INFO - 'USER': 'cltbld', 19:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:01 INFO - 'XPC_FLAGS': '0x0', 19:56:01 INFO - 'XPC_SERVICE_NAME': '0', 19:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-BKchIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-r8qE7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-P9mPrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-K4zhaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-bOklQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-tjdJc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-qNeBRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:02 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-qFvpZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-rSHK2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-wNrIca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-DDCP7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-BCmtYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-69j7kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-vpz0T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-EJef_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-f2QtjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:03 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-QFVBqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:03 INFO - Running setup.py install for manifestparser 19:56:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:56:04 INFO - Running setup.py install for mozcrash 19:56:04 INFO - Running setup.py install for mozdebug 19:56:04 INFO - Running setup.py install for mozdevice 19:56:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:56:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:56:04 INFO - Running setup.py install for mozfile 19:56:04 INFO - Running setup.py install for mozhttpd 19:56:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:56:04 INFO - Running setup.py install for mozinfo 19:56:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:56:04 INFO - Running setup.py install for mozInstall 19:56:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Running setup.py install for mozleak 19:56:05 INFO - Running setup.py install for mozlog 19:56:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Running setup.py install for moznetwork 19:56:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Running setup.py install for mozprocess 19:56:05 INFO - Running setup.py install for mozprofile 19:56:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:05 INFO - Running setup.py install for mozrunner 19:56:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:06 INFO - Running setup.py install for mozscreenshot 19:56:06 INFO - Running setup.py install for moztest 19:56:06 INFO - Running setup.py install for mozversion 19:56:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:06 INFO - Cleaning up... 19:56:06 INFO - Return code: 0 19:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:06 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')]} 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:06 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')]} 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:06 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:56:06 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 19:56:06 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 19:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:06 INFO - 'HOME': '/Users/cltbld', 19:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:06 INFO - 'LOGNAME': 'cltbld', 19:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:06 INFO - 'MOZ_NO_REMOTE': '1', 19:56:06 INFO - 'NO_EM_RESTART': '1', 19:56:06 INFO - 'PAGER': '/bin/cat', 19:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:06 INFO - 'PWD': '/builds/slave/test', 19:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:06 INFO - 'SHELL': '/bin/bash', 19:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:56:06 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:06 INFO - 'USER': 'cltbld', 19:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:06 INFO - 'XPC_FLAGS': '0x0', 19:56:06 INFO - 'XPC_SERVICE_NAME': '0', 19:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:06 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-T2Scmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:06 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)) 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:06 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-WXaUxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-e0zdLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-HWmwBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-MOCAdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-4Olk_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-WeGNAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-EGKR1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-cI3WXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-FUNf_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-60en3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:07 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)) 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:07 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-cJRotE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:08 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)) 19:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-sAwyXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:08 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)) 19:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-KpNzAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:08 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)) 19:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-gmUcF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:08 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)) 19:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-JXi9lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:08 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)) 19:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-NK5DY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:08 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)) 19:56:08 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)) 19:56:08 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)) 19:56:08 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)) 19:56:08 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)) 19:56:08 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)) 19:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:08 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 19:56:08 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 19:56:08 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 19:56:08 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 19:56:08 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 19:56:08 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 19:56:11 INFO - Downloading blessings-1.6.tar.gz 19:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:11 INFO - Installing collected packages: blessings 19:56:11 INFO - Running setup.py install for blessings 19:56:11 INFO - Successfully installed blessings 19:56:11 INFO - Cleaning up... 19:56:11 INFO - Return code: 0 19:56:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:11 INFO - Reading from file tmpfile_stdout 19:56:11 INFO - Current package versions: 19:56:11 INFO - blessings == 1.6 19:56:11 INFO - blobuploader == 1.2.4 19:56:11 INFO - docopt == 0.6.1 19:56:11 INFO - functools32 == 3.2.3-2 19:56:11 INFO - jsonschema == 2.5.1 19:56:11 INFO - manifestparser == 1.1 19:56:11 INFO - mozInstall == 1.12 19:56:11 INFO - mozcrash == 0.17 19:56:11 INFO - mozdebug == 0.1 19:56:11 INFO - mozdevice == 0.48 19:56:11 INFO - mozfile == 1.2 19:56:11 INFO - mozhttpd == 0.7 19:56:11 INFO - mozinfo == 0.9 19:56:11 INFO - mozleak == 0.1 19:56:11 INFO - mozlog == 3.3 19:56:11 INFO - moznetwork == 0.27 19:56:11 INFO - mozprocess == 0.23 19:56:11 INFO - mozprofile == 0.28 19:56:11 INFO - mozrunner == 6.12 19:56:11 INFO - mozscreenshot == 0.1 19:56:11 INFO - mozsystemmonitor == 0.3 19:56:11 INFO - moztest == 0.7 19:56:11 INFO - mozversion == 1.4 19:56:11 INFO - psutil == 3.1.1 19:56:11 INFO - requests == 1.2.3 19:56:11 INFO - wsgiref == 0.1.2 19:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:11 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')]} 19:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:11 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')]} 19:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:11 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:56:11 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 19:56:11 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 19:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:11 INFO - 'HOME': '/Users/cltbld', 19:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:11 INFO - 'LOGNAME': 'cltbld', 19:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:11 INFO - 'MOZ_NO_REMOTE': '1', 19:56:11 INFO - 'NO_EM_RESTART': '1', 19:56:11 INFO - 'PAGER': '/bin/cat', 19:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:11 INFO - 'PWD': '/builds/slave/test', 19:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:11 INFO - 'SHELL': '/bin/bash', 19:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:56:11 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:11 INFO - 'USER': 'cltbld', 19:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:11 INFO - 'XPC_FLAGS': '0x0', 19:56:11 INFO - 'XPC_SERVICE_NAME': '0', 19:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 INFO - Cleaning up... 19:56:12 INFO - Return code: 0 19:56:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56: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')]} 19:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:12 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 0x1091c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10913a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c34dc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, '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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 19:56:12 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 19:56:12 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 19:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:12 INFO - 'HOME': '/Users/cltbld', 19:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:12 INFO - 'LOGNAME': 'cltbld', 19:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:12 INFO - 'MOZ_NO_REMOTE': '1', 19:56:12 INFO - 'NO_EM_RESTART': '1', 19:56:12 INFO - 'PAGER': '/bin/cat', 19:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:12 INFO - 'PWD': '/builds/slave/test', 19:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:12 INFO - 'SHELL': '/bin/bash', 19:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:56:12 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:12 INFO - 'USER': 'cltbld', 19:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:12 INFO - 'XPC_FLAGS': '0x0', 19:56:12 INFO - 'XPC_SERVICE_NAME': '0', 19:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:56:12 INFO - Cleaning up... 19:56:12 INFO - Return code: 0 19:56:12 INFO - Running post-action listener: _resource_record_post_action 19:56:12 INFO - Running post-action listener: _start_resource_monitoring 19:56:12 INFO - Starting resource monitoring. 19:56:12 INFO - [mozharness: 2016-09-13 02:56:12.354753Z] Finished create-virtualenv step (success) 19:56:12 INFO - [mozharness: 2016-09-13 02:56:12.355748Z] Running install step. 19:56:12 INFO - Running pre-action listener: _resource_record_pre_action 19:56:12 INFO - Running main action method: install 19:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:12 INFO - Reading from file tmpfile_stdout 19:56:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:12 INFO - Reading from file tmpfile_stdout 19:56:12 INFO - Output received: 19:56:12 INFO - Usage: mozinstall [options] installer 19:56:12 INFO - Options: 19:56:12 INFO - -h, --help show this help message and exit 19:56:12 INFO - -d DEST, --destination=DEST 19:56:12 INFO - Directory to install application into. [default: 19:56:12 INFO - "/builds/slave/test"] 19:56:12 INFO - --app=APP Application being installed. [default: firefox] 19:56:12 INFO - mkdir: /builds/slave/test/build/application 19:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:56:46 INFO - Reading from file tmpfile_stdout 19:56:46 INFO - Output received: 19:56:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:56:46 INFO - Running post-action listener: _resource_record_post_action 19:56:46 INFO - [mozharness: 2016-09-13 02:56:46.806721Z] Finished install step (success) 19:56:46 INFO - [mozharness: 2016-09-13 02:56:46.806846Z] Running run-tests step. 19:56:46 INFO - Running pre-action listener: _resource_record_pre_action 19:56:46 INFO - Running main action method: run_tests 19:56:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:56:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:56:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:56:46 INFO - 2016-09-12 19:56:46.821 screenresolution[1639:7477] starting screenresolution argv=screenresolution get 19:56:46 INFO - 2016-09-12 19:56:46.824 screenresolution[1639:7477] Display 0: 1600x1200x32@60 19:56:46 INFO - 2016-09-12 19:56:46.830 screenresolution[1640:7479] starting screenresolution argv=screenresolution list 19:56:46 INFO - Available Modes on Display 0 19:56:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:56:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:56:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:56:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:56:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:56:47 INFO - Intel Iris: 19:56:47 INFO - Chipset Model: Intel Iris 19:56:47 INFO - Type: GPU 19:56:47 INFO - Bus: Built-In 19:56:47 INFO - VRAM (Dynamic, Max): 1536 MB 19:56:47 INFO - Vendor: Intel (0x8086) 19:56:47 INFO - Device ID: 0x0a2e 19:56:47 INFO - Revision ID: 0x0009 19:56:47 INFO - Displays: 19:56:47 INFO - Display: 19:56:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:56:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:56:47 INFO - Display Serial Number: 1600x1200 60 19:56:47 INFO - Main Display: Yes 19:56:47 INFO - Mirror: Off 19:56:47 INFO - Online: Yes 19:56:47 INFO - Rotation: Supported 19:56:47 INFO - Return code: 0 19:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:47 INFO - Python 2.7.3 19:56:47 INFO - Return code: 0 19:56:47 INFO - grabbing minidump binary from tooltool 19:56: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')]} 19:56:47 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 0x108fd8d30>, '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 0x108dfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:47 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 19:56:47 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 19:56:47 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 19:56:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:47 INFO - Return code: 0 19:56:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:56:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:56:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 19:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --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 19:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uq4HGeIFNC/Render', 19:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:47 INFO - 'HOME': '/Users/cltbld', 19:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:47 INFO - 'LOGNAME': 'cltbld', 19:56:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:47 INFO - 'MOZ_NO_REMOTE': '1', 19:56:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:47 INFO - 'NO_EM_RESTART': '1', 19:56:47 INFO - 'PAGER': '/bin/cat', 19:56:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:47 INFO - 'PWD': '/builds/slave/test', 19:56:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:47 INFO - 'SHELL': '/bin/bash', 19:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qzFuJNb5Wm/Listeners', 19:56:47 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 19:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:47 INFO - 'USER': 'cltbld', 19:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:47 INFO - 'XPC_FLAGS': '0x0', 19:56:47 INFO - 'XPC_SERVICE_NAME': '0', 19:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 19:56:47 INFO - mozversion application_buildid: 20160912172409 19:56:47 INFO - mozversion application_changeset: f719635c68de1c14515b4eb1bbb523d56876e1a3 19:56:47 INFO - mozversion application_display_name: Nightly 19:56:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:47 INFO - mozversion application_name: Firefox 19:56:47 INFO - mozversion application_remotingname: firefox 19:56:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:56:47 INFO - mozversion application_vendor: Mozilla 19:56:47 INFO - mozversion application_version: 51.0a1 19:56:47 INFO - mozversion platform_buildid: 20160912172409 19:56:47 INFO - mozversion platform_changeset: f719635c68de1c14515b4eb1bbb523d56876e1a3 19:56:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:56:47 INFO - mozversion platform_version: 51.0a1 19:56:47 INFO - using testdate: 1473735407 19:56:47 INFO - actual date: 1473735407 19:56:47 INFO - starting webserver on 'localhost:49282' 19:56:47 INFO - SUITE-START | Running 2 tests 19:56:47 INFO - TEST-START | dromaeo_css 19:56:47 INFO - operating with platform_type : mac_ 19:56:47 INFO - Initialising browser for dromaeo_css test... 19:56:47 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpZbUDqr/profile http://localhost:49282/getInfo.html) 19:56:50 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:56:50 INFO - PROCESS | 1650 | colorDepth:24 19:56:50 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:56:50 INFO - PROCESS | 1650 | __metrics 19:56:50 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3000: TypeError: this.tabs is undefined 19:56:51 INFO - TEST-INFO | 1650: exit 0 19:56:51 INFO - Browser initialized. 19:56:51 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpZbUDqr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:03 INFO - PROCESS | 1653 | RSS: Main: 245190656 19:57:03 INFO - PROCESS | 1653 | 19:57:52 INFO - PROCESS | 1653 | 1473735472760 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] 20:00:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 20:00:06 INFO - PROCESS | 1653 | RSS: Main: 264359936 20:00:06 INFO - PROCESS | 1653 | 20:03:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 20:03:09 INFO - PROCESS | 1653 | RSS: Main: 270602240 20:03:09 INFO - PROCESS | 1653 | 20:06:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 20:06:11 INFO - PROCESS | 1653 | RSS: Main: 275296256 20:06:11 INFO - PROCESS | 1653 | 20:09:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 20:09:14 INFO - PROCESS | 1653 | RSS: Main: 269475840 20:09:14 INFO - PROCESS | 1653 | 20:12:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 20:12:17 INFO - PROCESS | 1653 | RSS: Main: 275947520 20:12:17 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 20:15:20 INFO - PROCESS | 1653 | RSS: Main: 278896640 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | __start_tp_report 20:15:20 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:15:20 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:15:20 INFO - PROCESS | 1653 | |i|pagename|runs| 20:15:20 INFO - PROCESS | 1653 | |0;dojo.html;3407.7273818094545;3412.385770561301;3414.3683418567566;3430.897073087808;3449.7412694047953;5005.898702285501;5029.723365214912;5682.772689092431;5810.854728631781;5914.526837852972;5770.740316685748;5772.220750198722;5814.1278808178795;5886.793962211324;5940.495057920071;5145;5178.482151784829;5301.151815709487;5332.14685650296;5339.9733001334935;5269.341332333458;5279.868003299929;5340.279062326595;5360.892782144355;5425.403205647375;4687.90624187516;4781.541629802909;5199.922001169985;5271.051210782058;5284.048871203182;5183.611229157828;5194.039102766001;5210;5211.270422140903;5211.609129315317;4343.913121737579;5182.274481572583;5212.947870521284;5235.633505654606;5302.761375738101;5135;5692.57305702074;5805.651660900359;5828.854278643025;5850.64896106235;6198.6280823150755;6203.751849926042;6235.189425374718;6235.469985051231;6239.282482514478;6154.384561543855;6258.655773932432;6302.369763023707;6304.621722696653;6318.4313411793155;5857.4435428634215;5909.7636094556165;5954.821355359346;5960.986632272524;6056.212692350055;6347.619142851444;6369.363063693593;6391.201099862517;6395.968020159962;6399.776007839703;6151.231096112986;6194.721237544321;6224.128621992924;6224.937750622526;6241.75032998684;4778.068276686083;4810.4467986181335;6104.664243466563;6127.739336776432;6157.138000679908;5607.579431542651;6179.134921111048;6183.258009038944;6216.627002379872;6231.3145553989025;5744.281964754406;6222.688865556704;6224.06639004153;6249.192514485008;6252.718627661766;4130.958690413057;4927.236278376858;4933.531314525115;4956.355673762388;4970.652054356233;4066.9832541864535;4237.279662457389;4500.594946454769;4533.591976722045;4581.748003859753;5657;5993.61041532299;6019.247594050744;6030.306514750772;6039.124326972565;6162.784302549389;6168.8766224675255;6250.531210159256;6267.905981410283;6305.936940630535;6011.879762404727;6012.939870601325;6037.72830222641;6069.180660610849;6076.939230607726;5466.644668096561;5496.725163741797;5509.47659972302;5516.91724624131;5551.944480555224;6203;6242.2509298882605;6418.326075762071;6420.165378500858;6429.4856411486035;6176.7838125665385;6203.131561581473;6220.34686357944;6272.5922815016875;6289.779857705142;6384.489240860627;6396.744130234739;6400;6413.102165696713;6471.385218404244;6142.170806941184;6251.187345645037;6251.874962500816;6253.37466253371;6273;4689.812407503661;5008.298838162587;6152.323244443018;6249.750009999549;6255.030470277115;6182.258129024546;6228.844278893064;6229.159063526366;6234.438900498977;6242.282137554058;6007.669578173242;6112;6192.504599631929;6199.876002479835;6216.844578885383;5901.114832775118;5961.910571341346;6022.698865056642;6119.877602448015;6141.025769127022;6108.541859360477;6166.537509686702;6187.876242475035;6194.318624951162;6196.845078873064;5966.19456373384;6081.5134789217645;6083.69581520931;6110.005967773879;6131.773645271053 20:15:20 INFO - PROCESS | 1653 | |1;ext.html;507.61167706704373;543.7254186635748;549.4834855236076;553.7093026161265;573.2719446303195;38854.22291554171;40195.59804401955;40240.99999999996;40291.388344466184;40408.79795601018;40856.59143408565;41219.79390103053;41457.7927110364;41485.37771933423;41499.792501037526;8505.659773609064;9584.041595840396;9589.808203835919;9735.318527703064;9764.511774411287;9476.099770521789;9549.809003819919;9595.328327017112;9612.471314077722;9629.181519570844;9513.238940884712;9514.857277140849;9605;9658.758531036745;9660.855087173699;9468.621255149821;9584.760380990496;9642.035796420372;9649.951750241275;9650.276229282761;9444;9575.808483830355;9609.471479068648;9644.083812037845;9683.90316096844;39278.821635350985;39379;39958.60041399578;40131.7993410034;40251.79244622666;3299.686529779667;3367.4275373186615;3372.3086767212662;3528.876489322887;3757.7369584129124;30258.254916184047;30437.23906902323;30745.846270768725;30973.22566935822;31566.684333156605;3092.9072127835975;3204.6795320468;3236.72487838534;3243.5134729790484;3347.7656564040526;420301;497874;503039;503999;504646.4767676175;60249.397506025256;60526;60952.695236523534;61169;61370.38629613736;34062.14844628854;34242.82878585591;34743.4788478173;35613.28773424517;35899.56401743901;15998.280077396312;16464;16582;16627.418040368528;16668.833311666727;12720.427580758887;12817.807732884014;12844.422001009976;12844.871551284554;12859.54991575309;18520.629587408177;18529.90735046316;18543.72184417235;18578.628427431377;18617.90691046536;7913;8030.437869349206;8030.558319292378;8039.517628942165;8302.418830681794;858.4076986879033;966.917811985975;1060.81966065769;1117.558349728857;1129.6667483092508;26381.20856374312;29691.85154074216;29886.551701724493;30503.389932201233;30607.08178754641;909.8180363927108;939.9342046056847;979.9563464909849;990.5294984882123;1131.3947038334452;12194.902458778752;14098.224597647228;14891.32989015497;15232.619184520254;15796.289166987513;561021;678778;687120;687493;688197;56025.71987140038;56298.718506407204;56490;57003.42996570064;57106.71446642823;1324.602619214232;1353.7901625248103;1355.627202519315;1361.319340329835;1367.6239034265657;27190.592141118294;28622.570661439677;29322;29962.850185748932;29990.55014174833;48028;48555.51444485651;48663.75668121778;48670.783230419525;48770.75614621904;567167;567957;568055;569399;569943;25813.838377272692;25867.0946516871;26077.869610651825;26124;26126.477470450864;45195.774021129684;45358.54641453675;45894.082118358114;46942.76528617335;47036.7648161757;28370.2907427316;29741.851290744275;33113.11410459569;33973.49039764455;34638;32179;37447.625523745504;37684.811575941945;37841.24317513689;38809;32827;32953.34093318168;37558;37716.81141594274;37729;29720.554191686708;31857.362852742353;33364.83317583396;33859;34759;22852.400331977267;24108.758912411355;24176.153834615703;25182.62226066574;25444 20:15:20 INFO - PROCESS | 1653 | |2;jquery.html;345.94118999770035;369.13806262377346;379.77972775790033;384.7479900665062;397.58849590673657;18995.905020474896;20356.287529936457;20610.38168854933;21078.789212107855;21220.681689774665;11776.175667703243;11788.233764805304;11995.280283183016;12121.878781212185;12137.211081279711;5262.315898933143;5577.470140336662;5579.246801681782;5583.190437386576;5601.439856014406;3947.407888816672;4147.730397524167;5474.808381706641;5859.824205273849;6105.938940610581;6183.19618449601;6201.441870231678;6202.751889924398;6212.192414986045;6245.812625621239;5925.377835327293;6106.3893610639025;6137.9386206137815;6138.416850399227;6144.17053697754;5718.34239062509;5901.144334071536;5910.527157827363;5995.100734889757;5999.250093738283;13317.933410332886;13518.662033449144;16381.262843172086;25554.72226388673;25803.612945805828;2149.48412381029;2275.954480910389;2402.117932124468;2711.430599574092;2911.141213342069;9621;10135.493225338703;10219.948900255451;10283.845742313872;10551.050405463468;1731.1084791332473;1734.3062774890145;1770.2122555462824;1798.3256278895415;1877.155280123936;127455.3627231858;128597.71402286044;128669;134339.32830335785;134381;9983.652206952114;11054;11275.718107047389;11429.314241145392;11448;12154.756904861853;14451.349689263798;14470.493532726305;14511.637209069857;14513.274336283144;7070.575765454089;8233.8353232935;8523.06246312905;8548.74353769388;8680.001799792979;7058.54119482232;7256.092988376453;8302.169783021649;8481.915180848237;8512.489250644981;4504.031633198812;4507.256302710016;4535.319702044654;4540.72755634663;4556.248219043887;1525.6567272363852;1638.4920674590915;1800.4328636479468;1854.110027186931;1915.0807612345873;849.4181485682327;899.67161985876;903.4037535226719;952.2049089010753;968.9273304502191;15591;20401.459671823417;21439.67840482394;21662.35012949614;21707.240246591293;949.2168960607527;954.0125969621408;963.4652767713845;963.7205210488879;970.854371844229;8406.453580517247;11386.373749443694;11397.658070257905;11409.315441073562;11411.828822567668;578167.1091644599;588782;593648;613420;636607;128541;131599;149770.767192461;153570;154352;976.067855198284;992.5583115513527;1003.4130033930087;1014.6245889020962;1019.5870672377699;17094.74357884608;18851.057447127863;19656.508587285432;19693.901530492254;19743.703844442633;57718.7114064427;58897.411025889196;59579.404205957384;60130.39869601248;60607;71838;87027.56486217528;87725.12274877424;87755;87790.90404603552;6934.8613027740175;7321.633918303957;7938.801529961797;8119.269265766109;8228.83542329162;11703.531858725555;11743.94304512598;12248.938755306166;12528.87471125277;13182.077254592086;10676.199285053808;10869.076128528848;10939.617113400993;11074.723131921766;11177.441127943408;11027.338359698444;11068.944655276671;11173.72065698364;11297.887021129683;11352.602658906899;11127.387993660426;11287.43562821872;11479.08167346627;11494.712632184262;11549.711257218636;6055.031195008777;7057.894131587927;8066.717664881701;8076.434649574473;8252.05101413345;7941.722039728582;9946.104850563484;10878.619248326271;11145.331280123219;11262.549498020315 20:15:20 INFO - PROCESS | 1653 | |3;mootools.html;1397.769368054271;1501.8347981722013;1675.36336192247;1814.4375243674453;1855.3877220517222;7906.683732650694;8119.700847864336;8134;8267.379946504007;9041.819163616723;7330.8900366494545;7348.669309881055;8633.568321583927;8703.260222881063;8820.073892241318;2349.4361353275217;2371.1108334374608;2374.6675465434855;2389.462370966536;2390.916317928873;2341.1454818991115;2360.492494113765;2381.499885024147;2396.305071529263;2405.9398515037087;2264.3659775262954;2266.6033444147292;2267.1044937249776;2358.174638876397;2364.397078744926;2305.5849947009533;2345.636426353918;2360.9645855312183;2365.988170059156;2380.214529205358;2352.447174913894;2362.8582285062953;2369.57347677418;2385.5705972924866;2390.0678735293077;8822.955885220534;8858.114188581154;8896.822063558757;8915.68795092175;8937.553122343857;4824.831130910401;5287.814926477593;5477.808276710296;5481.397046324941;5488.231647569343;3451.6711066239427;3466.959912026382;3610.7291953103622;3666.0285024468535;3678.981605091984;1019.7246743379246;1085.16442339399;1092.5575142067476;1094.8905109489067;1108.711734948911;9903.950480247697;11262.380569068699;11934.940325298405;12083.275003499819;12103.515859365614;4719.882002949954;4746.245645534305;4763.356946812136;4887.65786394956;4896.559309662148;8446.957765211257;9952.303338766362;9960.651377201762;10004.099631033241;10111.494425278706;5395.271638328853;5434.2935418395355;5443.374011988592;5443.482869127427;5452.236686863842;4463.687541872037;4563.247064234431;4762.4285085789925;4860;4987.900241995139;3868.381059030598;3879.4180872869297;3983.143624120828;4027.0536423940353;4039.6768258539246;1276.5340650662442;1281.14803655568;1292.3796577642784;1303.4069498378215;1318.8615195404345;763.3168314358618;898.4025622960788;930.8650245714468;933.8272419602396;939.9248060155171;4665.766711664471;5704.657720536781;5902.026165682701;6000.0999850022845;6114.785982490592;437.2850389613006;437.5974103824489;445.3720254441287;445.37647293788956;449.2071493813422;3989.5212574491247;4001.199760047944;4044.838206471708;4083.530394004668;4087.46862907826;10338.844917326247;10653.627123050655;10740;10765.084967777826;10780.245382823285;10505;10634.468276586294;10653.520591573399;10710.839337409945;10727.892721072689;8089.069756978023;8113.5131892086665;8178.427510074238;8194.344452443791;8197.79505512355;4617.330487079422;5734.05388110957;5854.677992710442;5886.676232807236;5887.52899768009;10013.949930250303;10014.198864091;10100.393976361442;10106.989301069834;10114.342567733074;9844.704658860246;10059.798804024025;10216.489175541044;10241.07830295277;10270.897291026995;7025.789226323219;7153.818085483769;7310.2689731028595;7441.069866266716;7457.589832559262;8239.382046346429;8305.086440491421;8318.542480163407;8364.079951205242;8398.664053437795;6154.846128846814;7321.890171647323;7578.848423031619;7603.125640551408;7657.885131722917;7385.9630701846145;7388.704451822082;7435.070616172979;7442.106947166375;7537.660805263667;6898.689558969758;6928.757493487704;6983.057287266154;7002.649867506502;7025.613591252531;5018.874528136826;5059.418166910852;5095.515925987025;5109.795608175631;5157.045946499909;5075.010372977382;5077;5183.0670479314085;5196.9740151299;5249.790008399621 20:15:20 INFO - PROCESS | 1653 | |4;prototype.html;286.1301643005264;288.6305528922979;297.8049377657634;311.6908982274448;312.3487528503071;4119.569454022127;4187.366926898512;4534.322300748723;4603.309503574465;5503.367112782032;4336.934945975813;4385.780710964447;4533.546645335465;5421.21392398102;5467.425920278373;3581.910452238689;4062.7156099073077;4176.624103830654;4177.603127702871;4213.346931225665;3852.9807350963206;4216.409702641633;4216.460991738024;4220.788960551976;4234.66122710184;4072.6131017553284;4086.346184610463;4090.89772755682;4125.608067233608;4152.418661387408;4093.85671501499;4106.650934670557;4109.239790638741;4128.938065929014;4157.563455837124;3551.3607550640872;3570.7500474966764;3575.3743094958277;3576.7675101118602;3586.4261718125235;4340.717853339523;4889;5030.874228144289;5192.58459323257;5324.946750532484;4320.824194217248;4363.563643635643;4691.319758635013;4701.576858082754;4731.503192164808;5465.234867118606;5707.800226992077;5711.114777209539;5758.942410575883;5829.854253643651;3444.603870554893;3592.8383222755037;3842.7502212356108;3866.8259928303296;3890.1830615570766;5265.815696450606;5973.163757074013;6023.969880150615;6075.878482430371;6188.47397971173;3276.8033917965;3943.82252798619;3952.2490726761825;3959.6832253419657;3968.2460332536725;3380.154961259685;3909.4135879618284;4022.5374081980362;4024.7786371749835;4115.156392939441;4491.483479399911;4721;4796.208625576741;4820.325154478376;4845.394325709286;4933.728644924564;5223.608229382811;5600.4959553639555;5838.824835254949;5887.20522729426;1190.0182349561646;1226.5277868020698;1350.770369037266;1356.9253691047088;1409.7673883809057;809.5506993618599;920.8995250675513;944.3861490031535;972.295086062599;977.3158788847835;4647.721136731807;5396.354111995879;5478.205660179252;5480.835574932758;5500.019992802588;5501.614886957875;5944.097888675582;5960.6721630309885;5989.55078369124;5992.191054207626;4525.773711314421;4801;4943.629227807929;5563.860903477445;5635.464630860061;3125.109343837041;3170.6670799566173;3195.8402079895914;3224.0172294039;3225.209823593235;5074.923876141861;6118.541109416811;6286.402791734778;6331.461825744771;6394.82575924188;4841.903161936812;5637.956977959008;5805.535557155417;6128.988716861668;6183.96908015457;5339.973300133474;6201.162843016225;6281.560290779602;6314.537330441131;6343.333949935375;5137.409197942285;5639.013172694844;5709.857253568694;6061.605995610271;6098.939010609837;5316.6544174628525;5955.868385006835;5998.970005149947;6016.278046634432;6114.266288045285;4737.455192652751;5561.4716601922755;5847.327557330961;6097.7865774697675;6320.62076275425;3198.696123868229;3391.762576619613;3882.514685664292;3950.84196632143;4011.7392369495888;5717.3996730342715;5765.654060756368;5785.768569257351;6019.585397431688;6079.969600151971;5208.895822083613;5611.214429979725;5790.01569733138;5862.325832529314;5875.823725288248;4855;4869.926951095666;5442.911417716552;5526.47498487643;5841.561882858718;4879.90240195187;5145.202493613496;5207.218917162304;5766.654000759968;5799.5070419014855;5877.471027607536;5879.2944846618675;5907.675077870758;5977.671228082497;6001.609895356963;5557.694326812064;5758.366579676316;5760.337561180518;5792;5793.333766616893 20:15:20 INFO - PROCESS | 1653 | |5;yui.html;721.6499997501213;765.7013764631795;771.251885670899;820.1839170025826;851.0765819086291;15168.469103581363;15389.99965002274;15534.300956456958;15790.131542765143;15828.920855395707;11999.220050696698;14283.21442320672;14389.712205755879;14407.495737649184;14425.495107671233;834.7704381295132;844.8225872566737;869.9782505437352;883.4390162246988;885.9589981771425;828.2711214131556;855.170484629908;861.3539845116163;861.3668953319336;862.0259107208846;877.4515927545284;921.3642586615214;923.3351986569659;924.8936372317203;926.1294383279695;900.5452246615483;912.320321360584;915.5376534849859;915.748169253454;919.0350132361027;581.837085616024;655.4297760948006;686.2314208086925;690.8100272425073;693.0678237770192;15394.15332156742;15637.843621563752;15678.980866243772;15719.214039297989;15727.449539266185;14151.150930944177;14181.43274269028;14362.64093397663;14377.78433323501;14452.205128717917;11916.880831191664;11980.28118312904;12047.759044819055;12225.205361651553;12314.568990085394;3650.233450975298;3721.255748850214;3850.3261929162563;3881.6312450317455;3916.823742931575;121528;124939.12591311138;125210;125465.74534254632;126061;10729.678109656566;10849.78300433987;10880.72798180036;10965;11336.773264534828;22169.891505424665;22237.888810555844;22285.660005699167;22292.996815143357;22455.43861403478;7841.7255396062;7868.449208555347;7938.087119981276;8054.154313797084;8127.959360203161;4336.739795612273;4418.668599855024;4441.755276940153;4495.707778994421;4622.67641265115;3655.1958569114754;3717.9442308365396;3773.8867833965023;3778.263238668488;3780.1872597391143;639.6961443314389;664.1266734244454;666.9062737111142;668.4552090046597;687.965601719912;545.8335207761592;601.5578549765919;665.6006396162361;673.6261374936859;681.189384632286;7331.450141239428;9053.502057386908;9082;9167.037461066491;9299.90700093004;609.9939000610026;624.0981781326032;648.6043513456788;664.8736740019381;671.9664016799238;4470.932936005963;4496.730196188174;4861.124997500484;4921.409430868319;5055.69665820052;90407.54796225976;91655.5417222923;119326.40336798261;133889.3222135552;157270;113261;134114;136408;136514;138713.3064334672;111881;115978.98199671018;116636;117408.9999999983;118937;7624.351930085783;8765.342599305206;8856.202941735275;9984.650537231162;10154.969006198642;57187.42812571821;57655.71172144113;59040.1143982832;60172.69913650404;61250.69374653098;58214.83570328485;63632;68972;88336;96140;11258.493367798304;11657.825132622847;12889.613311600668;13181.143225690299;13914.860851391357;14190.29048547589;14748.4712556317;14954.102753834804;14992.175430351435;15025.774613380589;13486.86513134856;13716.794248086486;13752.93123534376;13817.101888377625;13913.304334783423;12085;12336.444859981142;13012.763787440179;13856.4457421702;13867.375968081258;10858.728531786768;13339.132956357806;13497.257650829299;13623.727525449238;13769.86230137726;9693.515324233618;10388.792224155626;10910.945445272722;11353.432328383382;11474.483648235682;11296.152788541056;11347.148963827582;11358.886411136113;11436.885631143583;11639.88360116388 20:15:20 INFO - PROCESS | 1653 | __end_tp_report 20:15:20 INFO - PROCESS | 1653 | __start_cc_report 20:15:20 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,381 20:15:20 INFO - PROCESS | 1653 | __end_cc_report 20:15:20 INFO - PROCESS | 1653 | __startTimestamp1473736520802__endTimestamp 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:15:20 INFO - PROCESS | 1653 | Number of tests: 6 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5745.05 Median:6039.12 stddev:686.76 (11.4%) stddev-sans-first:663.94 20:15:20 INFO - PROCESS | 1653 | Values: 3407.7 3412.4 3414.4 3430.9 3449.7 5005.9 5029.7 5682.8 5810.9 5914.5 5770.7 5772.2 5814.1 5886.8 5940.5 5145.0 5178.5 5301.2 5332.1 5340.0 5269.3 5279.9 5340.3 5360.9 5425.4 4687.9 4781.5 5199.9 5271.1 5284.0 5183.6 5194.0 5210.0 5211.3 5211.6 4343.9 5182.3 5212.9 5235.6 5302.8 5135.0 5692.6 5805.7 5828.9 5850.6 6198.6 6203.8 6235.2 6235.5 6239.3 6154.4 6258.7 6302.4 6304.6 6318.4 5857.4 5909.8 5954.8 5961.0 6056.2 6347.6 6369.4 6391.2 6396.0 6399.8 6151.2 6194.7 6224.1 6224.9 6241.8 4778.1 4810.4 6104.7 6127.7 6157.1 5607.6 6179.1 6183.3 6216.6 6231.3 5744.3 6222.7 6224.1 6249.2 6252.7 4131.0 4927.2 4933.5 4956.4 4970.7 4067.0 4237.3 4500.6 4533.6 4581.7 5657.0 5993.6 6019.2 6030.3 6039.1 6162.8 6168.9 6250.5 6267.9 6305.9 6011.9 6012.9 6037.7 6069.2 6076.9 5466.6 5496.7 5509.5 5516.9 5551.9 6203.0 6242.3 6418.3 6420.2 6429.5 6176.8 6203.1 6220.3 6272.6 6289.8 6384.5 6396.7 6400.0 6413.1 6471.4 6142.2 6251.2 6251.9 6253.4 6273.0 4689.8 5008.3 6152.3 6249.8 6255.0 6182.3 6228.8 6229.2 6234.4 6242.3 6007.7 6112.0 6192.5 6199.9 6216.8 5901.1 5961.9 6022.7 6119.9 6141.0 6108.5 6166.5 6187.9 6194.3 6196.8 5966.2 6081.5 6083.7 6110.0 6131.8 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:69128.61 Median:39328.91 stddev:154531.12 (392.9%) stddev-sans-first:154878.74 20:15:20 INFO - PROCESS | 1653 | Values: 507.6 543.7 549.5 553.7 573.3 38854.2 40195.6 40241.0 40291.4 40408.8 40856.6 41219.8 41457.8 41485.4 41499.8 8505.7 9584.0 9589.8 9735.3 9764.5 9476.1 9549.8 9595.3 9612.5 9629.2 9513.2 9514.9 9605.0 9658.8 9660.9 9468.6 9584.8 9642.0 9650.0 9650.3 9444.0 9575.8 9609.5 9644.1 9683.9 39278.8 39379.0 39958.6 40131.8 40251.8 3299.7 3367.4 3372.3 3528.9 3757.7 30258.3 30437.2 30745.8 30973.2 31566.7 3092.9 3204.7 3236.7 3243.5 3347.8 420301.0 497874.0 503039.0 503999.0 504646.5 60249.4 60526.0 60952.7 61169.0 61370.4 34062.1 34242.8 34743.5 35613.3 35899.6 15998.3 16464.0 16582.0 16627.4 16668.8 12720.4 12817.8 12844.4 12844.9 12859.5 18520.6 18529.9 18543.7 18578.6 18617.9 7913.0 8030.4 8030.6 8039.5 8302.4 858.4 966.9 1060.8 1117.6 1129.7 26381.2 29691.9 29886.6 30503.4 30607.1 909.8 939.9 980.0 990.5 1131.4 12194.9 14098.2 14891.3 15232.6 15796.3 561021.0 678778.0 687120.0 687493.0 688197.0 56025.7 56298.7 56490.0 57003.4 57106.7 1324.6 1353.8 1355.6 1361.3 1367.6 27190.6 28622.6 29322.0 29962.9 29990.6 48028.0 48555.5 48663.8 48670.8 48770.8 567167.0 567957.0 568055.0 569399.0 569943.0 25813.8 25867.1 26077.9 26124.0 26126.5 45195.8 45358.5 45894.1 46942.8 47036.8 28370.3 29741.9 33113.1 33973.5 34638.0 32179.0 37447.6 37684.8 37841.2 38809.0 32827.0 32953.3 37558.0 37716.8 37729.0 29720.6 31857.4 33364.8 33859.0 34759.0 22852.4 24108.8 24176.2 25182.6 25444.0 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35742.43 Median:14257.52 stddev:101505.73 (711.9%) stddev-sans-first:101755.69 20:15:20 INFO - PROCESS | 1653 | Values: 345.9 369.1 379.8 384.7 397.6 18995.9 20356.3 20610.4 21078.8 21220.7 11776.2 11788.2 11995.3 12121.9 12137.2 5262.3 5577.5 5579.2 5583.2 5601.4 3947.4 4147.7 5474.8 5859.8 6105.9 6183.2 6201.4 6202.8 6212.2 6245.8 5925.4 6106.4 6137.9 6138.4 6144.2 5718.3 5901.1 5910.5 5995.1 5999.3 13317.9 13518.7 16381.3 25554.7 25803.6 2149.5 2276.0 2402.1 2711.4 2911.1 9621.0 10135.5 10219.9 10283.8 10551.1 1731.1 1734.3 1770.2 1798.3 1877.2 127455.4 128597.7 128669.0 134339.3 134381.0 9983.7 11054.0 11275.7 11429.3 11448.0 12154.8 14451.3 14470.5 14511.6 14513.3 7070.6 8233.8 8523.1 8548.7 8680.0 7058.5 7256.1 8302.2 8481.9 8512.5 4504.0 4507.3 4535.3 4540.7 4556.2 1525.7 1638.5 1800.4 1854.1 1915.1 849.4 899.7 903.4 952.2 968.9 15591.0 20401.5 21439.7 21662.4 21707.2 949.2 954.0 963.5 963.7 970.9 8406.5 11386.4 11397.7 11409.3 11411.8 578167.1 588782.0 593648.0 613420.0 636607.0 128541.0 131599.0 149770.8 153570.0 154352.0 976.1 992.6 1003.4 1014.6 1019.6 17094.7 18851.1 19656.5 19693.9 19743.7 57718.7 58897.4 59579.4 60130.4 60607.0 71838.0 87027.6 87725.1 87755.0 87790.9 6934.9 7321.6 7938.8 8119.3 8228.8 11703.5 11743.9 12248.9 12528.9 13182.1 10676.2 10869.1 10939.6 11074.7 11177.4 11027.3 11068.9 11173.7 11297.9 11352.6 11127.4 11287.4 11479.1 11494.7 11549.7 6055.0 7057.9 8066.7 8076.4 8252.1 7941.7 9946.1 10878.6 11145.3 11262.5 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5664.85 Median:4754.34 stddev:3179.05 (66.9%) stddev-sans-first:3171.79 20:15:20 INFO - PROCESS | 1653 | Values: 1397.8 1501.8 1675.4 1814.4 1855.4 7906.7 8119.7 8134.0 8267.4 9041.8 7330.9 7348.7 8633.6 8703.3 8820.1 2349.4 2371.1 2374.7 2389.5 2390.9 2341.1 2360.5 2381.5 2396.3 2405.9 2264.4 2266.6 2267.1 2358.2 2364.4 2305.6 2345.6 2361.0 2366.0 2380.2 2352.4 2362.9 2369.6 2385.6 2390.1 8823.0 8858.1 8896.8 8915.7 8937.6 4824.8 5287.8 5477.8 5481.4 5488.2 3451.7 3467.0 3610.7 3666.0 3679.0 1019.7 1085.2 1092.6 1094.9 1108.7 9904.0 11262.4 11934.9 12083.3 12103.5 4719.9 4746.2 4763.4 4887.7 4896.6 8447.0 9952.3 9960.7 10004.1 10111.5 5395.3 5434.3 5443.4 5443.5 5452.2 4463.7 4563.2 4762.4 4860.0 4987.9 3868.4 3879.4 3983.1 4027.1 4039.7 1276.5 1281.1 1292.4 1303.4 1318.9 763.3 898.4 930.9 933.8 939.9 4665.8 5704.7 5902.0 6000.1 6114.8 437.3 437.6 445.4 445.4 449.2 3989.5 4001.2 4044.8 4083.5 4087.5 10338.8 10653.6 10740.0 10765.1 10780.2 10505.0 10634.5 10653.5 10710.8 10727.9 8089.1 8113.5 8178.4 8194.3 8197.8 4617.3 5734.1 5854.7 5886.7 5887.5 10013.9 10014.2 10100.4 10107.0 10114.3 9844.7 10059.8 10216.5 10241.1 10270.9 7025.8 7153.8 7310.3 7441.1 7457.6 8239.4 8305.1 8318.5 8364.1 8398.7 6154.8 7321.9 7578.8 7603.1 7657.9 7386.0 7388.7 7435.1 7442.1 7537.7 6898.7 6928.8 6983.1 7002.6 7025.6 5018.9 5059.4 5095.5 5109.8 5157.0 5075.0 5077.0 5183.1 5197.0 5249.8 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4636.75 Median:5106.17 stddev:1452.82 (28.5%) stddev-sans-first:1419.72 20:15:20 INFO - PROCESS | 1653 | Values: 286.1 288.6 297.8 311.7 312.3 4119.6 4187.4 4534.3 4603.3 5503.4 4336.9 4385.8 4533.5 5421.2 5467.4 3581.9 4062.7 4176.6 4177.6 4213.3 3853.0 4216.4 4216.5 4220.8 4234.7 4072.6 4086.3 4090.9 4125.6 4152.4 4093.9 4106.7 4109.2 4128.9 4157.6 3551.4 3570.8 3575.4 3576.8 3586.4 4340.7 4889.0 5030.9 5192.6 5324.9 4320.8 4363.6 4691.3 4701.6 4731.5 5465.2 5707.8 5711.1 5758.9 5829.9 3444.6 3592.8 3842.8 3866.8 3890.2 5265.8 5973.2 6024.0 6075.9 6188.5 3276.8 3943.8 3952.2 3959.7 3968.2 3380.2 3909.4 4022.5 4024.8 4115.2 4491.5 4721.0 4796.2 4820.3 4845.4 4933.7 5223.6 5600.5 5838.8 5887.2 1190.0 1226.5 1350.8 1356.9 1409.8 809.6 920.9 944.4 972.3 977.3 4647.7 5396.4 5478.2 5480.8 5500.0 5501.6 5944.1 5960.7 5989.6 5992.2 4525.8 4801.0 4943.6 5563.9 5635.5 3125.1 3170.7 3195.8 3224.0 3225.2 5074.9 6118.5 6286.4 6331.5 6394.8 4841.9 5638.0 5805.5 6129.0 6184.0 5340.0 6201.2 6281.6 6314.5 6343.3 5137.4 5639.0 5709.9 6061.6 6098.9 5316.7 5955.9 5999.0 6016.3 6114.3 4737.5 5561.5 5847.3 6097.8 6320.6 3198.7 3391.8 3882.5 3950.8 4011.7 5717.4 5765.7 5785.8 6019.6 6080.0 5208.9 5611.2 5790.0 5862.3 5875.8 4855.0 4869.9 5442.9 5526.5 5841.6 4879.9 5145.2 5207.2 5766.7 5799.5 5877.5 5879.3 5907.7 5977.7 6001.6 5557.7 5758.4 5760.3 5792.0 5793.3 20:15:20 INFO - PROCESS | 1653 | 20:15:20 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24133.96 Median:3719.60 stddev:38355.48 (1031.2%) stddev-sans-first:38422.79 20:15:20 INFO - PROCESS | 1653 | Values: 721.6 765.7 771.3 820.2 851.1 15168.5 15390.0 15534.3 15790.1 15828.9 11999.2 14283.2 14389.7 14407.5 14425.5 834.8 844.8 870.0 883.4 886.0 828.3 855.2 861.4 861.4 862.0 877.5 921.4 923.3 924.9 926.1 900.5 912.3 915.5 915.7 919.0 581.8 655.4 686.2 690.8 693.1 15394.2 15637.8 15679.0 15719.2 15727.4 14151.2 14181.4 14362.6 14377.8 14452.2 11916.9 11980.3 12047.8 12225.2 12314.6 3650.2 3721.3 3850.3 3881.6 3916.8 121528.0 124939.1 125210.0 125465.7 126061.0 10729.7 10849.8 10880.7 10965.0 11336.8 22169.9 22237.9 22285.7 22293.0 22455.4 7841.7 7868.4 7938.1 8054.2 8128.0 4336.7 4418.7 4441.8 4495.7 4622.7 3655.2 3717.9 3773.9 3778.3 3780.2 639.7 664.1 666.9 668.5 688.0 545.8 601.6 665.6 673.6 681.2 7331.5 9053.5 9082.0 9167.0 9299.9 610.0 624.1 648.6 664.9 672.0 4470.9 4496.7 4861.1 4921.4 5055.7 90407.5 91655.5 119326.4 133889.3 157270.0 113261.0 134114.0 136408.0 136514.0 138713.3 111881.0 115979.0 116636.0 117409.0 118937.0 7624.4 8765.3 8856.2 9984.7 10155.0 57187.4 57655.7 59040.1 60172.7 61250.7 58214.8 63632.0 68972.0 88336.0 96140.0 11258.5 11657.8 12889.6 13181.1 13914.9 14190.3 14748.5 14954.1 14992.2 15025.8 13486.9 13716.8 13752.9 13817.1 13913.3 12085.0 12336.4 13012.8 13856.4 13867.4 10858.7 13339.1 13497.3 13623.7 13769.9 9693.5 10388.8 10910.9 11353.4 11474.5 11296.2 11347.1 11358.9 11436.9 11639.9 20:15:20 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:15:20 INFO - PROCESS | 1653 | 20:15:21 INFO - TEST-INFO | 1653: exit 0 20:15:21 INFO - TEST-OK | dromaeo_css | took 1113975ms 20:15:21 INFO - TEST-START | kraken 20:15:21 INFO - operating with platform_type : mac_ 20:15:21 INFO - Initialising browser for kraken test... 20:15:21 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpsvftVK/profile http://localhost:49282/getInfo.html) 20:15:24 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 20:15:24 INFO - PROCESS | 1664 | colorDepth:24 20:15:24 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 20:15:24 INFO - PROCESS | 1664 | __metrics 20:15:24 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3000: TypeError: this.tabs is undefined 20:15:24 INFO - TEST-INFO | 1664: exit 0 20:15:24 INFO - Browser initialized. 20:15:24 INFO - Running cycle 1/1 for kraken test... 20:15:24 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpsvftVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:36 INFO - PROCESS | 1666 | RSS: Main: 245235712 20:15:36 INFO - PROCESS | 1666 | 20:15:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:40 INFO - PROCESS | 1666 | RSS: Main: 257830912 20:15:40 INFO - PROCESS | 1666 | 20:15:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 20:15:43 INFO - PROCESS | 1666 | RSS: Main: 265728000 20:15:43 INFO - PROCESS | 1666 | 20:15:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 20:15:48 INFO - PROCESS | 1666 | RSS: Main: 262598656 20:15:48 INFO - PROCESS | 1666 | 20:15:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 20:15:50 INFO - PROCESS | 1666 | RSS: Main: 263680000 20:15:50 INFO - PROCESS | 1666 | 20:15:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:53 INFO - PROCESS | 1666 | RSS: Main: 265351168 20:15:53 INFO - PROCESS | 1666 | 20:15:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:57 INFO - PROCESS | 1666 | RSS: Main: 265576448 20:15:57 INFO - PROCESS | 1666 | 20:16:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:00 INFO - PROCESS | 1666 | RSS: Main: 265801728 20:16:00 INFO - PROCESS | 1666 | 20:16:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 20:16:04 INFO - PROCESS | 1666 | RSS: Main: 265953280 20:16:04 INFO - PROCESS | 1666 | 20:16:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:06 INFO - PROCESS | 1666 | RSS: Main: 265850880 20:16:06 INFO - PROCESS | 1666 | 20:16:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:09 INFO - PROCESS | 1666 | RSS: Main: 265904128 20:16:09 INFO - PROCESS | 1666 | 20:16:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:11 INFO - PROCESS | 1666 | RSS: Main: 265957376 20:16:11 INFO - PROCESS | 1666 | 20:16:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:15 INFO - PROCESS | 1666 | RSS: Main: 266145792 20:16:15 INFO - PROCESS | 1666 | 20:16:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:19 INFO - PROCESS | 1666 | RSS: Main: 266182656 20:16:19 INFO - PROCESS | 1666 | 20:16:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 20:16:21 INFO - PROCESS | 1666 | RSS: Main: 267845632 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | __start_tp_report 20:16:21 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 20:16:21 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 20:16:21 INFO - PROCESS | 1666 | |i|pagename|runs| 20:16:21 INFO - PROCESS | 1666 | |0;ai-astar;122;158;109;115;116;115;91;116;114;118 20:16:21 INFO - PROCESS | 1666 | |1;audio-beat-detection;139;112;137;162;109;135;121;144;154;149 20:16:21 INFO - PROCESS | 1666 | |2;audio-dft;232;246;261;274;210;198;197;200;192;200 20:16:21 INFO - PROCESS | 1666 | |3;audio-fft;68;82;75;148;60;59;59;61;135;60 20:16:21 INFO - PROCESS | 1666 | |4;audio-oscillator;69;72;131;95;90;76;108;68;72;110 20:16:21 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;128;122;81;132;91;86;92;106;135;87 20:16:21 INFO - PROCESS | 1666 | |6;imaging-darkroom;99;100;100;127;131;99;99;121;172;111 20:16:21 INFO - PROCESS | 1666 | |7;imaging-desaturate;76;151;146;92;92;91;93;91;90;93 20:16:21 INFO - PROCESS | 1666 | |8;json-parse-financial;56;58;57;57;65;84;85;89;56;56 20:16:21 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;65;66;68;73;71;91;71;67;66;68 20:16:21 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;98;89;89;86;85;87;90;88;91;88 20:16:21 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;138;163;155;151;157;155;158;140;178;140 20:16:21 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;170;173;248;225;174;240;186;171;174;169 20:16:21 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;69;67;61;74;85;90;79;57;78 20:16:21 INFO - PROCESS | 1666 | __end_tp_report 20:16:21 INFO - PROCESS | 1666 | __start_cc_report 20:16:21 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,949 20:16:21 INFO - PROCESS | 1666 | __end_cc_report 20:16:21 INFO - PROCESS | 1666 | __startTimestamp1473736581224__endTimestamp 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | ------- Summary: start ------- 20:16:21 INFO - PROCESS | 1666 | Number of tests: 14 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:117.40 Median:117.00 stddev:16.55 (14.1%) stddev-sans-first:17.47 20:16:21 INFO - PROCESS | 1666 | Values: 122.0 158.0 109.0 115.0 116.0 115.0 91.0 116.0 114.0 118.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:141.50 stddev:17.55 (12.4%) stddev-sans-first:18.59 20:16:21 INFO - PROCESS | 1666 | Values: 139.0 112.0 137.0 162.0 109.0 135.0 121.0 144.0 154.0 149.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:221.00 Median:221.00 stddev:30.01 (13.6%) stddev-sans-first:31.56 20:16:21 INFO - PROCESS | 1666 | Values: 232.0 246.0 261.0 274.0 210.0 198.0 197.0 200.0 192.0 200.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:80.70 Median:60.50 stddev:33.10 (54.7%) stddev-sans-first:34.79 20:16:21 INFO - PROCESS | 1666 | Values: 68.0 82.0 75.0 148.0 60.0 59.0 59.0 61.0 135.0 60.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:72.00 stddev:21.58 (30.0%) stddev-sans-first:21.63 20:16:21 INFO - PROCESS | 1666 | Values: 69.0 72.0 131.0 95.0 90.0 76.0 108.0 68.0 72.0 110.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:83.50 stddev:21.25 (25.4%) stddev-sans-first:20.99 20:16:21 INFO - PROCESS | 1666 | Values: 128.0 122.0 81.0 132.0 91.0 86.0 92.0 106.0 135.0 87.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:115.90 Median:151.50 stddev:23.36 (15.4%) stddev-sans-first:23.96 20:16:21 INFO - PROCESS | 1666 | Values: 99.0 100.0 100.0 127.0 131.0 99.0 99.0 121.0 172.0 111.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:91.50 stddev:25.29 (27.6%) stddev-sans-first:25.09 20:16:21 INFO - PROCESS | 1666 | Values: 76.0 151.0 146.0 92.0 92.0 91.0 93.0 91.0 90.0 93.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:61.50 stddev:13.90 (22.6%) stddev-sans-first:14.24 20:16:21 INFO - PROCESS | 1666 | Values: 56.0 58.0 57.0 57.0 65.0 84.0 85.0 89.0 56.0 56.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:69.50 stddev:7.62 (11.0%) stddev-sans-first:7.81 20:16:21 INFO - PROCESS | 1666 | Values: 65.0 66.0 68.0 73.0 71.0 91.0 71.0 67.0 66.0 68.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:89.00 stddev:3.60 (4.0%) stddev-sans-first:1.90 20:16:21 INFO - PROCESS | 1666 | Values: 98.0 89.0 89.0 86.0 85.0 87.0 90.0 88.0 91.0 88.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:156.00 stddev:12.20 (7.8%) stddev-sans-first:11.57 20:16:21 INFO - PROCESS | 1666 | Values: 138.0 163.0 155.0 151.0 157.0 155.0 158.0 140.0 178.0 140.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.00 Median:180.00 stddev:31.65 (17.6%) stddev-sans-first:32.46 20:16:21 INFO - PROCESS | 1666 | Values: 170.0 173.0 248.0 225.0 174.0 240.0 186.0 171.0 174.0 169.0 20:16:21 INFO - PROCESS | 1666 | 20:16:21 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:76.00 stddev:10.45 (13.7%) stddev-sans-first:10.87 20:16:21 INFO - PROCESS | 1666 | Values: 67.0 69.0 67.0 61.0 74.0 85.0 90.0 79.0 57.0 78.0 20:16:21 INFO - PROCESS | 1666 | -------- Summary: end -------- 20:16:21 INFO - PROCESS | 1666 | 20:16:22 INFO - TEST-INFO | 1666: exit 0 20:16:22 INFO - TEST-OK | kraken | took 60778ms 20:16:22 INFO - SUITE-END | took 1174s 20:16:22 INFO - Completed test suite (00:19:34) 20:16:22 INFO - javascript benchmark 20:16:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.919759424431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3407.7273818094545, 3412.385770561301, 3414.3683418567566, 3430.897073087808, 3449.7412694047953, 5005.898702285501, 5029.723365214912, 5682.772689092431, 5810.854728631781, 5914.526837852972, 5770.740316685748, 5772.220750198722, 5814.1278808178795, 5886.793962211324, 5940.495057920071, 5145.0, 5178.482151784829, 5301.151815709487, 5332.14685650296, 5339.9733001334935, 5269.341332333458, 5279.868003299929, 5340.279062326595, 5360.892782144355, 5425.403205647375, 4687.90624187516, 4781.541629802909, 5199.922001169985, 5271.051210782058, 5284.048871203182, 5183.611229157828, 5194.039102766001, 5210.0, 5211.270422140903, 5211.609129315317, 4343.913121737579, 5182.274481572583, 5212.947870521284, 5235.633505654606, 5302.761375738101, 5135.0, 5692.57305702074, 5805.651660900359, 5828.854278643025, 5850.64896106235, 6198.6280823150755, 6203.751849926042, 6235.189425374718, 6235.469985051231, 6239.282482514478, 6154.384561543855, 6258.655773932432, 6302.369763023707, 6304.621722696653, 6318.4313411793155, 5857.4435428634215, 5909.7636094556165, 5954.821355359346, 5960.986632272524, 6056.212692350055, 6347.619142851444, 6369.363063693593, 6391.201099862517, 6395.968020159962, 6399.776007839703, 6151.231096112986, 6194.721237544321, 6224.128621992924, 6224.937750622526, 6241.75032998684, 4778.068276686083, 4810.4467986181335, 6104.664243466563, 6127.739336776432, 6157.138000679908, 5607.579431542651, 6179.134921111048, 6183.258009038944, 6216.627002379872, 6231.3145553989025, 5744.281964754406, 6222.688865556704, 6224.06639004153, 6249.192514485008, 6252.718627661766, 4130.958690413057, 4927.236278376858, 4933.531314525115, 4956.355673762388, 4970.652054356233, 4066.9832541864535, 4237.279662457389, 4500.594946454769, 4533.591976722045, 4581.748003859753, 5657.0, 5993.61041532299, 6019.247594050744, 6030.306514750772, 6039.124326972565, 6162.784302549389, 6168.8766224675255, 6250.531210159256, 6267.905981410283, 6305.936940630535, 6011.879762404727, 6012.939870601325, 6037.72830222641, 6069.180660610849, 6076.939230607726, 5466.644668096561, 5496.725163741797, 5509.47659972302, 5516.91724624131, 5551.944480555224, 6203.0, 6242.2509298882605, 6418.326075762071, 6420.165378500858, 6429.4856411486035, 6176.7838125665385, 6203.131561581473, 6220.34686357944, 6272.5922815016875, 6289.779857705142, 6384.489240860627, 6396.744130234739, 6400.0, 6413.102165696713, 6471.385218404244, 6142.170806941184, 6251.187345645037, 6251.874962500816, 6253.37466253371, 6273.0, 4689.812407503661, 5008.298838162587, 6152.323244443018, 6249.750009999549, 6255.030470277115, 6182.258129024546, 6228.844278893064, 6229.159063526366, 6234.438900498977, 6242.282137554058, 6007.669578173242, 6112.0, 6192.504599631929, 6199.876002479835, 6216.844578885383, 5901.114832775118, 5961.910571341346, 6022.698865056642, 6119.877602448015, 6141.025769127022, 6108.541859360477, 6166.537509686702, 6187.876242475035, 6194.318624951162, 6196.845078873064, 5966.19456373384, 6081.5134789217645, 6083.69581520931, 6110.005967773879, 6131.773645271053], "value": 5702.124972549139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.61167706704373, 543.7254186635748, 549.4834855236076, 553.7093026161265, 573.2719446303195, 38854.22291554171, 40195.59804401955, 40240.99999999996, 40291.388344466184, 40408.79795601018, 40856.59143408565, 41219.79390103053, 41457.7927110364, 41485.37771933423, 41499.792501037526, 8505.659773609064, 9584.041595840396, 9589.808203835919, 9735.318527703064, 9764.511774411287, 9476.099770521789, 9549.809003819919, 9595.328327017112, 9612.471314077722, 9629.181519570844, 9513.238940884712, 9514.857277140849, 9605.0, 9658.758531036745, 9660.855087173699, 9468.621255149821, 9584.760380990496, 9642.035796420372, 9649.951750241275, 9650.276229282761, 9444.0, 9575.808483830355, 9609.471479068648, 9644.083812037845, 9683.90316096844, 39278.821635350985, 39379.0, 39958.60041399578, 40131.7993410034, 40251.79244622666, 3299.686529779667, 3367.4275373186615, 3372.3086767212662, 3528.876489322887, 3757.7369584129124, 30258.254916184047, 30437.23906902323, 30745.846270768725, 30973.22566935822, 31566.684333156605, 3092.9072127835975, 3204.6795320468, 3236.72487838534, 3243.5134729790484, 3347.7656564040526, 420301.0, 497874.0, 503039.0, 503999.0, 504646.4767676175, 60249.397506025256, 60526.0, 60952.695236523534, 61169.0, 61370.38629613736, 34062.14844628854, 34242.82878585591, 34743.4788478173, 35613.28773424517, 35899.56401743901, 15998.280077396312, 16464.0, 16582.0, 16627.418040368528, 16668.833311666727, 12720.427580758887, 12817.807732884014, 12844.422001009976, 12844.871551284554, 12859.54991575309, 18520.629587408177, 18529.90735046316, 18543.72184417235, 18578.628427431377, 18617.90691046536, 7913.0, 8030.437869349206, 8030.558319292378, 8039.517628942165, 8302.418830681794, 858.4076986879033, 966.917811985975, 1060.81966065769, 1117.558349728857, 1129.6667483092508, 26381.20856374312, 29691.85154074216, 29886.551701724493, 30503.389932201233, 30607.08178754641, 909.8180363927108, 939.9342046056847, 979.9563464909849, 990.5294984882123, 1131.3947038334452, 12194.902458778752, 14098.224597647228, 14891.32989015497, 15232.619184520254, 15796.289166987513, 561021.0, 678778.0, 687120.0, 687493.0, 688197.0, 56025.71987140038, 56298.718506407204, 56490.0, 57003.42996570064, 57106.71446642823, 1324.602619214232, 1353.7901625248103, 1355.627202519315, 1361.319340329835, 1367.6239034265657, 27190.592141118294, 28622.570661439677, 29322.0, 29962.850185748932, 29990.55014174833, 48028.0, 48555.51444485651, 48663.75668121778, 48670.783230419525, 48770.75614621904, 567167.0, 567957.0, 568055.0, 569399.0, 569943.0, 25813.838377272692, 25867.0946516871, 26077.869610651825, 26124.0, 26126.477470450864, 45195.774021129684, 45358.54641453675, 45894.082118358114, 46942.76528617335, 47036.7648161757, 28370.2907427316, 29741.851290744275, 33113.11410459569, 33973.49039764455, 34638.0, 32179.0, 37447.625523745504, 37684.811575941945, 37841.24317513689, 38809.0, 32827.0, 32953.34093318168, 37558.0, 37716.81141594274, 37729.0, 29720.554191686708, 31857.362852742353, 33364.83317583396, 33859.0, 34759.0, 22852.400331977267, 24108.758912411355, 24176.153834615703, 25182.62226066574, 25444.0], "value": 19392.715231030063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.94118999770035, 369.13806262377346, 379.77972775790033, 384.7479900665062, 397.58849590673657, 18995.905020474896, 20356.287529936457, 20610.38168854933, 21078.789212107855, 21220.681689774665, 11776.175667703243, 11788.233764805304, 11995.280283183016, 12121.878781212185, 12137.211081279711, 5262.315898933143, 5577.470140336662, 5579.246801681782, 5583.190437386576, 5601.439856014406, 3947.407888816672, 4147.730397524167, 5474.808381706641, 5859.824205273849, 6105.938940610581, 6183.19618449601, 6201.441870231678, 6202.751889924398, 6212.192414986045, 6245.812625621239, 5925.377835327293, 6106.3893610639025, 6137.9386206137815, 6138.416850399227, 6144.17053697754, 5718.34239062509, 5901.144334071536, 5910.527157827363, 5995.100734889757, 5999.250093738283, 13317.933410332886, 13518.662033449144, 16381.262843172086, 25554.72226388673, 25803.612945805828, 2149.48412381029, 2275.954480910389, 2402.117932124468, 2711.430599574092, 2911.141213342069, 9621.0, 10135.493225338703, 10219.948900255451, 10283.845742313872, 10551.050405463468, 1731.1084791332473, 1734.3062774890145, 1770.2122555462824, 1798.3256278895415, 1877.155280123936, 127455.3627231858, 128597.71402286044, 128669.0, 134339.32830335785, 134381.0, 9983.652206952114, 11054.0, 11275.718107047389, 11429.314241145392, 11448.0, 12154.756904861853, 14451.349689263798, 14470.493532726305, 14511.637209069857, 14513.274336283144, 7070.575765454089, 8233.8353232935, 8523.06246312905, 8548.74353769388, 8680.001799792979, 7058.54119482232, 7256.092988376453, 8302.169783021649, 8481.915180848237, 8512.489250644981, 4504.031633198812, 4507.256302710016, 4535.319702044654, 4540.72755634663, 4556.248219043887, 1525.6567272363852, 1638.4920674590915, 1800.4328636479468, 1854.110027186931, 1915.0807612345873, 849.4181485682327, 899.67161985876, 903.4037535226719, 952.2049089010753, 968.9273304502191, 15591.0, 20401.459671823417, 21439.67840482394, 21662.35012949614, 21707.240246591293, 949.2168960607527, 954.0125969621408, 963.4652767713845, 963.7205210488879, 970.854371844229, 8406.453580517247, 11386.373749443694, 11397.658070257905, 11409.315441073562, 11411.828822567668, 578167.1091644599, 588782.0, 593648.0, 613420.0, 636607.0, 128541.0, 131599.0, 149770.767192461, 153570.0, 154352.0, 976.067855198284, 992.5583115513527, 1003.4130033930087, 1014.6245889020962, 1019.5870672377699, 17094.74357884608, 18851.057447127863, 19656.508587285432, 19693.901530492254, 19743.703844442633, 57718.7114064427, 58897.411025889196, 59579.404205957384, 60130.39869601248, 60607.0, 71838.0, 87027.56486217528, 87725.12274877424, 87755.0, 87790.90404603552, 6934.8613027740175, 7321.633918303957, 7938.801529961797, 8119.269265766109, 8228.83542329162, 11703.531858725555, 11743.94304512598, 12248.938755306166, 12528.87471125277, 13182.077254592086, 10676.199285053808, 10869.076128528848, 10939.617113400993, 11074.723131921766, 11177.441127943408, 11027.338359698444, 11068.944655276671, 11173.72065698364, 11297.887021129683, 11352.602658906899, 11127.387993660426, 11287.43562821872, 11479.08167346627, 11494.712632184262, 11549.711257218636, 6055.031195008777, 7057.894131587927, 8066.717664881701, 8076.434649574473, 8252.05101413345, 7941.722039728582, 9946.104850563484, 10878.619248326271, 11145.331280123219, 11262.549498020315], "value": 9330.828856178461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.769368054271, 1501.8347981722013, 1675.36336192247, 1814.4375243674453, 1855.3877220517222, 7906.683732650694, 8119.700847864336, 8134.0, 8267.379946504007, 9041.819163616723, 7330.8900366494545, 7348.669309881055, 8633.568321583927, 8703.260222881063, 8820.073892241318, 2349.4361353275217, 2371.1108334374608, 2374.6675465434855, 2389.462370966536, 2390.916317928873, 2341.1454818991115, 2360.492494113765, 2381.499885024147, 2396.305071529263, 2405.9398515037087, 2264.3659775262954, 2266.6033444147292, 2267.1044937249776, 2358.174638876397, 2364.397078744926, 2305.5849947009533, 2345.636426353918, 2360.9645855312183, 2365.988170059156, 2380.214529205358, 2352.447174913894, 2362.8582285062953, 2369.57347677418, 2385.5705972924866, 2390.0678735293077, 8822.955885220534, 8858.114188581154, 8896.822063558757, 8915.68795092175, 8937.553122343857, 4824.831130910401, 5287.814926477593, 5477.808276710296, 5481.397046324941, 5488.231647569343, 3451.6711066239427, 3466.959912026382, 3610.7291953103622, 3666.0285024468535, 3678.981605091984, 1019.7246743379246, 1085.16442339399, 1092.5575142067476, 1094.8905109489067, 1108.711734948911, 9903.950480247697, 11262.380569068699, 11934.940325298405, 12083.275003499819, 12103.515859365614, 4719.882002949954, 4746.245645534305, 4763.356946812136, 4887.65786394956, 4896.559309662148, 8446.957765211257, 9952.303338766362, 9960.651377201762, 10004.099631033241, 10111.494425278706, 5395.271638328853, 5434.2935418395355, 5443.374011988592, 5443.482869127427, 5452.236686863842, 4463.687541872037, 4563.247064234431, 4762.4285085789925, 4860.0, 4987.900241995139, 3868.381059030598, 3879.4180872869297, 3983.143624120828, 4027.0536423940353, 4039.6768258539246, 1276.5340650662442, 1281.14803655568, 1292.3796577642784, 1303.4069498378215, 1318.8615195404345, 763.3168314358618, 898.4025622960788, 930.8650245714468, 933.8272419602396, 939.9248060155171, 4665.766711664471, 5704.657720536781, 5902.026165682701, 6000.0999850022845, 6114.785982490592, 437.2850389613006, 437.5974103824489, 445.3720254441287, 445.37647293788956, 449.2071493813422, 3989.5212574491247, 4001.199760047944, 4044.838206471708, 4083.530394004668, 4087.46862907826, 10338.844917326247, 10653.627123050655, 10740.0, 10765.084967777826, 10780.245382823285, 10505.0, 10634.468276586294, 10653.520591573399, 10710.839337409945, 10727.892721072689, 8089.069756978023, 8113.5131892086665, 8178.427510074238, 8194.344452443791, 8197.79505512355, 4617.330487079422, 5734.05388110957, 5854.677992710442, 5886.676232807236, 5887.52899768009, 10013.949930250303, 10014.198864091, 10100.393976361442, 10106.989301069834, 10114.342567733074, 9844.704658860246, 10059.798804024025, 10216.489175541044, 10241.07830295277, 10270.897291026995, 7025.789226323219, 7153.818085483769, 7310.2689731028595, 7441.069866266716, 7457.589832559262, 8239.382046346429, 8305.086440491421, 8318.542480163407, 8364.079951205242, 8398.664053437795, 6154.846128846814, 7321.890171647323, 7578.848423031619, 7603.125640551408, 7657.885131722917, 7385.9630701846145, 7388.704451822082, 7435.070616172979, 7442.106947166375, 7537.660805263667, 6898.689558969758, 6928.757493487704, 6983.057287266154, 7002.649867506502, 7025.613591252531, 5018.874528136826, 5059.418166910852, 5095.515925987025, 5109.795608175631, 5157.045946499909, 5075.010372977382, 5077.0, 5183.0670479314085, 5196.9740151299, 5249.790008399621], "value": 4488.415163601781, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1301643005264, 288.6305528922979, 297.8049377657634, 311.6908982274448, 312.3487528503071, 4119.569454022127, 4187.366926898512, 4534.322300748723, 4603.309503574465, 5503.367112782032, 4336.934945975813, 4385.780710964447, 4533.546645335465, 5421.21392398102, 5467.425920278373, 3581.910452238689, 4062.7156099073077, 4176.624103830654, 4177.603127702871, 4213.346931225665, 3852.9807350963206, 4216.409702641633, 4216.460991738024, 4220.788960551976, 4234.66122710184, 4072.6131017553284, 4086.346184610463, 4090.89772755682, 4125.608067233608, 4152.418661387408, 4093.85671501499, 4106.650934670557, 4109.239790638741, 4128.938065929014, 4157.563455837124, 3551.3607550640872, 3570.7500474966764, 3575.3743094958277, 3576.7675101118602, 3586.4261718125235, 4340.717853339523, 4889.0, 5030.874228144289, 5192.58459323257, 5324.946750532484, 4320.824194217248, 4363.563643635643, 4691.319758635013, 4701.576858082754, 4731.503192164808, 5465.234867118606, 5707.800226992077, 5711.114777209539, 5758.942410575883, 5829.854253643651, 3444.603870554893, 3592.8383222755037, 3842.7502212356108, 3866.8259928303296, 3890.1830615570766, 5265.815696450606, 5973.163757074013, 6023.969880150615, 6075.878482430371, 6188.47397971173, 3276.8033917965, 3943.82252798619, 3952.2490726761825, 3959.6832253419657, 3968.2460332536725, 3380.154961259685, 3909.4135879618284, 4022.5374081980362, 4024.7786371749835, 4115.156392939441, 4491.483479399911, 4721.0, 4796.208625576741, 4820.325154478376, 4845.394325709286, 4933.728644924564, 5223.608229382811, 5600.4959553639555, 5838.824835254949, 5887.20522729426, 1190.0182349561646, 1226.5277868020698, 1350.770369037266, 1356.9253691047088, 1409.7673883809057, 809.5506993618599, 920.8995250675513, 944.3861490031535, 972.295086062599, 977.3158788847835, 4647.721136731807, 5396.354111995879, 5478.205660179252, 5480.835574932758, 5500.019992802588, 5501.614886957875, 5944.097888675582, 5960.6721630309885, 5989.55078369124, 5992.191054207626, 4525.773711314421, 4801.0, 4943.629227807929, 5563.860903477445, 5635.464630860061, 3125.109343837041, 3170.6670799566173, 3195.8402079895914, 3224.0172294039, 3225.209823593235, 5074.923876141861, 6118.541109416811, 6286.402791734778, 6331.461825744771, 6394.82575924188, 4841.903161936812, 5637.956977959008, 5805.535557155417, 6128.988716861668, 6183.96908015457, 5339.973300133474, 6201.162843016225, 6281.560290779602, 6314.537330441131, 6343.333949935375, 5137.409197942285, 5639.013172694844, 5709.857253568694, 6061.605995610271, 6098.939010609837, 5316.6544174628525, 5955.868385006835, 5998.970005149947, 6016.278046634432, 6114.266288045285, 4737.455192652751, 5561.4716601922755, 5847.327557330961, 6097.7865774697675, 6320.62076275425, 3198.696123868229, 3391.762576619613, 3882.514685664292, 3950.84196632143, 4011.7392369495888, 5717.3996730342715, 5765.654060756368, 5785.768569257351, 6019.585397431688, 6079.969600151971, 5208.895822083613, 5611.214429979725, 5790.01569733138, 5862.325832529314, 5875.823725288248, 4855.0, 4869.926951095666, 5442.911417716552, 5526.47498487643, 5841.561882858718, 4879.90240195187, 5145.202493613496, 5207.218917162304, 5766.654000759968, 5799.5070419014855, 5877.471027607536, 5879.2944846618675, 5907.675077870758, 5977.671228082497, 6001.609895356963, 5557.694326812064, 5758.366579676316, 5760.337561180518, 5792.0, 5793.333766616893], "value": 4173.369637371431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.6499997501213, 765.7013764631795, 771.251885670899, 820.1839170025826, 851.0765819086291, 15168.469103581363, 15389.99965002274, 15534.300956456958, 15790.131542765143, 15828.920855395707, 11999.220050696698, 14283.21442320672, 14389.712205755879, 14407.495737649184, 14425.495107671233, 834.7704381295132, 844.8225872566737, 869.9782505437352, 883.4390162246988, 885.9589981771425, 828.2711214131556, 855.170484629908, 861.3539845116163, 861.3668953319336, 862.0259107208846, 877.4515927545284, 921.3642586615214, 923.3351986569659, 924.8936372317203, 926.1294383279695, 900.5452246615483, 912.320321360584, 915.5376534849859, 915.748169253454, 919.0350132361027, 581.837085616024, 655.4297760948006, 686.2314208086925, 690.8100272425073, 693.0678237770192, 15394.15332156742, 15637.843621563752, 15678.980866243772, 15719.214039297989, 15727.449539266185, 14151.150930944177, 14181.43274269028, 14362.64093397663, 14377.78433323501, 14452.205128717917, 11916.880831191664, 11980.28118312904, 12047.759044819055, 12225.205361651553, 12314.568990085394, 3650.233450975298, 3721.255748850214, 3850.3261929162563, 3881.6312450317455, 3916.823742931575, 121528.0, 124939.12591311138, 125210.0, 125465.74534254632, 126061.0, 10729.678109656566, 10849.78300433987, 10880.72798180036, 10965.0, 11336.773264534828, 22169.891505424665, 22237.888810555844, 22285.660005699167, 22292.996815143357, 22455.43861403478, 7841.7255396062, 7868.449208555347, 7938.087119981276, 8054.154313797084, 8127.959360203161, 4336.739795612273, 4418.668599855024, 4441.755276940153, 4495.707778994421, 4622.67641265115, 3655.1958569114754, 3717.9442308365396, 3773.8867833965023, 3778.263238668488, 3780.1872597391143, 639.6961443314389, 664.1266734244454, 666.9062737111142, 668.4552090046597, 687.965601719912, 545.8335207761592, 601.5578549765919, 665.6006396162361, 673.6261374936859, 681.189384632286, 7331.450141239428, 9053.502057386908, 9082.0, 9167.037461066491, 9299.90700093004, 609.9939000610026, 624.0981781326032, 648.6043513456788, 664.8736740019381, 671.9664016799238, 4470.932936005963, 4496.730196188174, 4861.124997500484, 4921.409430868319, 5055.69665820052, 90407.54796225976, 91655.5417222923, 119326.40336798261, 133889.3222135552, 157270.0, 113261.0, 134114.0, 136408.0, 136514.0, 138713.3064334672, 111881.0, 115978.98199671018, 116636.0, 117408.9999999983, 118937.0, 7624.351930085783, 8765.342599305206, 8856.202941735275, 9984.650537231162, 10154.969006198642, 57187.42812571821, 57655.71172144113, 59040.1143982832, 60172.69913650404, 61250.69374653098, 58214.83570328485, 63632.0, 68972.0, 88336.0, 96140.0, 11258.493367798304, 11657.825132622847, 12889.613311600668, 13181.143225690299, 13914.860851391357, 14190.29048547589, 14748.4712556317, 14954.102753834804, 14992.175430351435, 15025.774613380589, 13486.86513134856, 13716.794248086486, 13752.93123534376, 13817.101888377625, 13913.304334783423, 12085.0, 12336.444859981142, 13012.763787440179, 13856.4457421702, 13867.375968081258, 10858.728531786768, 13339.132956357806, 13497.257650829299, 13623.727525449238, 13769.86230137726, 9693.515324233618, 10388.792224155626, 10910.945445272722, 11353.432328383382, 11474.483648235682, 11296.152788541056, 11347.148963827582, 11358.886411136113, 11436.885631143583, 11639.88360116388], "value": 7796.564104082105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 158.0, 109.0, 115.0, 116.0, 115.0, 91.0, 116.0, 114.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 112.0, 137.0, 162.0, 109.0, 135.0, 121.0, 144.0, 154.0, 149.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 246.0, 261.0, 274.0, 210.0, 198.0, 197.0, 200.0, 192.0, 200.0], "value": 221.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 75.0, 148.0, 60.0, 59.0, 59.0, 61.0, 135.0, 60.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 131.0, 95.0, 90.0, 76.0, 108.0, 68.0, 72.0, 110.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 81.0, 132.0, 91.0, 86.0, 92.0, 106.0, 135.0, 87.0], "value": 106.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 100.0, 127.0, 131.0, 99.0, 99.0, 121.0, 172.0, 111.0], "value": 115.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 151.0, 146.0, 92.0, 92.0, 91.0, 93.0, 91.0, 90.0, 93.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 57.0, 65.0, 84.0, 85.0, 89.0, 56.0, 56.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 73.0, 71.0, 91.0, 71.0, 67.0, 66.0, 68.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 89.0, 89.0, 86.0, 85.0, 87.0, 90.0, 88.0, 91.0, 88.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 163.0, 155.0, 151.0, 157.0, 155.0, 158.0, 140.0, 178.0, 140.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 248.0, 225.0, 174.0, 240.0, 186.0, 171.0, 174.0, 169.0], "value": 193.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 61.0, 74.0, 85.0, 90.0, 79.0, 57.0, 78.0], "value": 72.7, "unit": "score"}]}]} 20:16:22 INFO - Return code: 0 20:16:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:16:22 ERROR - # TBPL SUCCESS # 20:16:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:16:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:16:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:16:22 INFO - 2016-09-12 20:16:22.535 screenresolution[1671:10431] starting screenresolution argv=screenresolution get 20:16:22 INFO - 2016-09-12 20:16:22.537 screenresolution[1671:10431] Display 0: 1600x1200x32@60 20:16:22 INFO - 2016-09-12 20:16:22.543 screenresolution[1672:10434] starting screenresolution argv=screenresolution list 20:16:22 INFO - Available Modes on Display 0 20:16:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:16:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:16:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:16:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:16:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:16:22 INFO - Intel Iris: 20:16:22 INFO - Chipset Model: Intel Iris 20:16:22 INFO - Type: GPU 20:16:22 INFO - Bus: Built-In 20:16:22 INFO - VRAM (Dynamic, Max): 1536 MB 20:16:22 INFO - Vendor: Intel (0x8086) 20:16:22 INFO - Device ID: 0x0a2e 20:16:22 INFO - Revision ID: 0x0009 20:16:22 INFO - Displays: 20:16:22 INFO - Display: 20:16:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:16:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:16:22 INFO - Display Serial Number: 1600x1200 60 20:16:22 INFO - Main Display: Yes 20:16:22 INFO - Mirror: Off 20:16:22 INFO - Online: Yes 20:16:22 INFO - Rotation: Supported 20:16:22 INFO - Return code: 0 20:16:22 INFO - Running post-action listener: _resource_record_post_action 20:16:22 INFO - [mozharness: 2016-09-13 03:16:22.780515Z] Finished run-tests step (success) 20:16:22 INFO - Running post-run listener: _resource_record_post_run 20:16:22 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37254144; Write bytes: 704583168; Read time: 240; Write time: 2002 20:16:22 INFO - TinderboxPrint: CPU usage
54.5% 20:16:22 INFO - TinderboxPrint: I/O read bytes / time
37,254,144 / 240 20:16:22 INFO - TinderboxPrint: I/O write bytes / time
704,583,168 / 2,002 20:16:22 INFO - TinderboxPrint: CPU idle
2,201.5 (45.5%) 20:16:22 INFO - TinderboxPrint: CPU system
981.5 (20.3%) 20:16:22 INFO - TinderboxPrint: CPU user
1,654.7 (34.2%) 20:16:22 INFO - TinderboxPrint: Swap in / out
442,224,640 / 0 20:16:22 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397552128; Write bytes: 392869888; Read time: 29530; Write time: 835 20:16:22 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35185664; Write bytes: 295030272; Read time: 221; Write time: 1123 20:16:23 INFO - Running post-run listener: _upload_blobber_files 20:16:23 INFO - Blob upload gear active. 20:16:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:23 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 20:16:23 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:16:23 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:16:23 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:25 INFO - (blobuploader) - INFO - Done attempting. 20:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:26 INFO - (blobuploader) - INFO - Done attempting. 20:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:16:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:28 INFO - (blobuploader) - INFO - Done attempting. 20:16:28 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:28 INFO - Return code: 0 20:16:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586e47f8c0d3bbe90cbf70d3391734a4c16b8e21483960abbae5905ed5a78de7c8f6699b5bf498092a64ee1d35769c6a084068d844782c4d3a7e4e8efce98e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edd88ef910a05609a8f2776356e9faf3669a6ee563d9b993800fab1212d7e761891d82660b3a23f9fdc94f525732a1ae40b523f7a2b27ba8372fce4bc1945688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8e178cddad58791f188a9c823c53cdff005296b6677b21be812a279ad53672b5516a94637605ccb4d6fe2d9abad6ed677c4f0b8949f2764ba8fa2e604000e0a"} 20:16:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:28 INFO - Contents: 20:16:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586e47f8c0d3bbe90cbf70d3391734a4c16b8e21483960abbae5905ed5a78de7c8f6699b5bf498092a64ee1d35769c6a084068d844782c4d3a7e4e8efce98e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edd88ef910a05609a8f2776356e9faf3669a6ee563d9b993800fab1212d7e761891d82660b3a23f9fdc94f525732a1ae40b523f7a2b27ba8372fce4bc1945688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8e178cddad58791f188a9c823c53cdff005296b6677b21be812a279ad53672b5516a94637605ccb4d6fe2d9abad6ed677c4f0b8949f2764ba8fa2e604000e0a"} 20:16:28 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:28 INFO - Copying logs to upload dir... 20:16:28 INFO - mkdir: /builds/slave/test/build/upload/logs 20:16:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.519817 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-12 20:16:28.751142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:16:28.754694) ========= 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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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/Fx-Team/sha512/586e47f8c0d3bbe90cbf70d3391734a4c16b8e21483960abbae5905ed5a78de7c8f6699b5bf498092a64ee1d35769c6a084068d844782c4d3a7e4e8efce98e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edd88ef910a05609a8f2776356e9faf3669a6ee563d9b993800fab1212d7e761891d82660b3a23f9fdc94f525732a1ae40b523f7a2b27ba8372fce4bc1945688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8e178cddad58791f188a9c823c53cdff005296b6677b21be812a279ad53672b5516a94637605ccb4d6fe2d9abad6ed677c4f0b8949f2764ba8fa2e604000e0a"} build_url:https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010924 build_url: 'https://queue.taskcluster.net/v1/task/abHnr0pDTDCDM1CipV2Vbw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586e47f8c0d3bbe90cbf70d3391734a4c16b8e21483960abbae5905ed5a78de7c8f6699b5bf498092a64ee1d35769c6a084068d844782c4d3a7e4e8efce98e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edd88ef910a05609a8f2776356e9faf3669a6ee563d9b993800fab1212d7e761891d82660b3a23f9fdc94f525732a1ae40b523f7a2b27ba8372fce4bc1945688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8e178cddad58791f188a9c823c53cdff005296b6677b21be812a279ad53672b5516a94637605ccb4d6fe2d9abad6ed677c4f0b8949f2764ba8fa2e604000e0a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:16:28.792161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:16:28.792965) ========= 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.Uq4HGeIFNC/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.qzFuJNb5Wm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005141 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:16:28.844526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:16:28.844888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:16:28.845276) ========= ========= Total master_lag: 0.20 =========