builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0025 starttime: 1483725418.09 results: success (0) buildid: 20170106073357 builduid: 4a88e0005b2842d5a25924a31cd45c3c revision: e0b425ab0e852c6fef7eaae8c7801070341d14a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.090965) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.091444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.091761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.120009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.120422) ========= 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.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-06 09:56:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.9M=0.001s 2017-01-06 09:56:58 (16.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.290673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.290999) ========= 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.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.026187 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.340447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:58.340903) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0b425ab0e852c6fef7eaae8c7801070341d14a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0b425ab0e852c6fef7eaae8c7801070341d14a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-06 09:56:58,433 truncating revision to first 12 chars 2017-01-06 09:56:58,433 Setting DEBUG logging. 2017-01-06 09:56:58,433 attempt 1/10 2017-01-06 09:56:58,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0b425ab0e85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 09:56:59,099 unpacking tar archive at: mozilla-beta-e0b425ab0e85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:59.319089) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:59.319436) ========= script_repo_revision: e0b425ab0e852c6fef7eaae8c7801070341d14a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:59.319882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:59.320167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 09:56:59.340029) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-06 09:56:59.340450) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:56:59 INFO - MultiFileLogger online at 20170106 09:56:59 in /builds/slave/test 09:56:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:56:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:59 INFO - {'append_to_log': False, 09:56:59 INFO - 'base_work_dir': '/builds/slave/test', 09:56:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:56:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:59 INFO - 'branch': 'Mozilla-Beta', 09:56:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:59 INFO - 'config_files': ('talos/mac_config.py',), 09:56:59 INFO - 'default_actions': ('clobber', 09:56:59 INFO - 'read-buildbot-config', 09:56:59 INFO - 'download-and-extract', 09:56:59 INFO - 'populate-webroot', 09:56:59 INFO - 'create-virtualenv', 09:56:59 INFO - 'install', 09:56:59 INFO - 'run-tests'), 09:56:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:59 INFO - 'download_minidump_stackwalk': True, 09:56:59 INFO - 'download_symbols': 'ondemand', 09:56:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:59 INFO - 'installer_path': 'installer.exe', 09:56:59 INFO - 'log_level': 'info', 09:56:59 INFO - 'log_name': 'talos', 09:56:59 INFO - 'log_to_console': True, 09:56:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:59 INFO - 'opt_config_files': (), 09:56:59 INFO - 'pip_index': False, 09:56:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:59 INFO - 'cmd': ('bash', 09:56:59 INFO - '-c', 09:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:59 INFO - 'enabled': True, 09:56:59 INFO - 'halt_on_failure': False, 09:56:59 INFO - 'name': 'check_screen_resolution'},), 09:56:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:59 INFO - 'cmd': ('bash', 09:56:59 INFO - '-c', 09:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:59 INFO - 'enabled': True, 09:56:59 INFO - 'halt_on_failure': False, 09:56:59 INFO - 'name': 'check_screen_resolution'},), 09:56:59 INFO - 'run_cmd_checks_enabled': True, 09:56:59 INFO - 'sps_profile': False, 09:56:59 INFO - 'sps_profile_interval': 0, 09:56:59 INFO - 'suite': 'dromaeojs-e10s', 09:56:59 INFO - 'system_bits': '32', 09:56:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:59 INFO - 'title': 't-yosemite-r7-0025', 09:56:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:59 INFO - 'use_talos_json': True, 09:56:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:59 INFO - 'work_dir': 'build'} 09:56:59 INFO - [mozharness: 2017-01-06 17:56:59.529164Z] Running clobber step. 09:56:59 INFO - Running pre-action listener: _resource_record_pre_action 09:56:59 INFO - Running main action method: clobber 09:56:59 INFO - rmtree: /builds/slave/test/build 09:56:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:01 INFO - Running post-action listener: _resource_record_post_action 09:57:01 INFO - [mozharness: 2017-01-06 17:57:01.877230Z] Finished clobber step (success) 09:57:01 INFO - [mozharness: 2017-01-06 17:57:01.877352Z] Running read-buildbot-config step. 09:57:01 INFO - Running pre-action listener: _resource_record_pre_action 09:57:01 INFO - Running main action method: read_buildbot_config 09:57:01 INFO - Using buildbot properties: 09:57:01 INFO - { 09:57:01 INFO - "project": "", 09:57:01 INFO - "product": "firefox", 09:57:01 INFO - "script_repo_revision": "production", 09:57:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:57:01 INFO - "repository": "", 09:57:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:57:01 INFO - "buildid": "20170106073357", 09:57:01 INFO - "pgo_build": "False", 09:57:01 INFO - "basedir": "/builds/slave/test", 09:57:01 INFO - "buildnumber": 41, 09:57:01 INFO - "slavename": "t-yosemite-r7-0025", 09:57:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:57:01 INFO - "platform": "yosemite_r7", 09:57:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:57:01 INFO - "branch": "mozilla-beta", 09:57:01 INFO - "repo_path": "releases/mozilla-beta", 09:57:01 INFO - "revision": "e0b425ab0e852c6fef7eaae8c7801070341d14a9", 09:57:01 INFO - "stage_platform": "macosx64", 09:57:01 INFO - "builduid": "4a88e0005b2842d5a25924a31cd45c3c", 09:57:01 INFO - "slavebuilddir": "test" 09:57:01 INFO - } 09:57:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:57:01 INFO - Running post-action listener: _resource_record_post_action 09:57:01 INFO - [mozharness: 2017-01-06 17:57:01.880607Z] Finished read-buildbot-config step (success) 09:57:01 INFO - [mozharness: 2017-01-06 17:57:01.880723Z] Running download-and-extract step. 09:57:01 INFO - Running pre-action listener: _resource_record_pre_action 09:57:01 INFO - Running main action method: download_and_extract 09:57:01 INFO - mkdir: /builds/slave/test/build/tests 09:57: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')]} 09:57:01 INFO - trying https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:57:01 INFO - Downloading https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 09:57:02 INFO - Downloaded 1165 bytes. 09:57:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:57:02 INFO - Using the following test package requirements: 09:57:02 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:57:02 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:57:02 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:57:02 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:57:02 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:57:02 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:57:02 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:57:02 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:57:02 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:57:02 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:02 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:57:02 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:57:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:57:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:02 INFO - Fetch https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:57:03 INFO - Expected file size: 16234541 09:57:10 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:57:11 INFO - Expected file size: 16234541 09:57:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:57:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:57:17 INFO - Fetch https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:57:18 INFO - Expected file size: 14414089 09:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:18 INFO - trying https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 09:57:21 INFO - Downloaded 86146032 bytes. 09:57:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:21 INFO - mkdir: /builds/slave/test/properties 09:57:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:21 INFO - Contents: 09:57:21 INFO - build_url:https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:22 INFO - Running post-action listener: _resource_record_post_action 09:57:22 INFO - Running post-action listener: set_extra_try_arguments 09:57:22 INFO - [mozharness: 2017-01-06 17:57:22.100561Z] Finished download-and-extract step (success) 09:57:22 INFO - [mozharness: 2017-01-06 17:57:22.100725Z] Running populate-webroot step. 09:57:22 INFO - Running pre-action listener: _resource_record_pre_action 09:57:22 INFO - Running main action method: populate_webroot 09:57:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:22 INFO - '--tppagecycles', 09:57:22 INFO - '7'], 09:57:22 INFO - 'tests': ['tsvgm']}}, 09:57:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['damp', 'tps']}, 09:57:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'tests': ['damp', 'tps']}, 09:57:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['dromaeo_dom']}, 09:57:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['basic_compositor_video']}, 09:57:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tsvgx', 09:57:22 INFO - 'tsvgr_opacity', 09:57:22 INFO - 'tart', 09:57:22 INFO - 'tscrollx', 09:57:22 INFO - 'cart']}, 09:57:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:22 INFO - 'tsvgr_opacity', 09:57:22 INFO - 'tart', 09:57:22 INFO - 'tscrollx', 09:57:22 INFO - 'cart']}, 09:57:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tp5o']}, 09:57:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'tests': ['tp5o']}, 09:57:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s', 09:57:22 INFO - '--xperf_path', 09:57:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:22 INFO - 'tests': ['tp5n']}, 09:57:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:22 INFO - 'talos_options': ['--xperf_path', 09:57:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:22 INFO - 'tests': ['tp5n']}}, 09:57:22 INFO - 'talos.zip': {'path': '', 09:57:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:22 INFO - Running post-action listener: _resource_record_post_action 09:57:22 INFO - [mozharness: 2017-01-06 17:57:22.120140Z] Finished populate-webroot step (success) 09:57:22 INFO - [mozharness: 2017-01-06 17:57:22.120221Z] Running create-virtualenv step. 09:57:22 INFO - Running pre-action listener: _resource_record_pre_action 09:57:22 INFO - Running main action method: create_virtualenv 09:57:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:22 INFO - Using real prefix '/tools/python27' 09:57:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:25 INFO - Installing pip.................done. 09:57:25 INFO - Return code: 0 09:57:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:25 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:25 INFO - 'HOME': '/Users/cltbld', 09:57:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:25 INFO - 'LOGNAME': 'cltbld', 09:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:25 INFO - 'MOZ_NO_REMOTE': '1', 09:57:25 INFO - 'NO_EM_RESTART': '1', 09:57:25 INFO - 'PAGER': '/bin/cat', 09:57:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:25 INFO - 'PWD': '/builds/slave/test', 09:57:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:25 INFO - 'SHELL': '/bin/bash', 09:57:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:25 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:25 INFO - 'USER': 'cltbld', 09:57:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:25 INFO - 'XPC_FLAGS': '0x0', 09:57:25 INFO - 'XPC_SERVICE_NAME': '0', 09:57:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:26 INFO - Cleaning up... 09:57:26 INFO - Return code: 0 09:57:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:26 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:26 INFO - 'HOME': '/Users/cltbld', 09:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:26 INFO - 'LOGNAME': 'cltbld', 09:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:26 INFO - 'MOZ_NO_REMOTE': '1', 09:57:26 INFO - 'NO_EM_RESTART': '1', 09:57:26 INFO - 'PAGER': '/bin/cat', 09:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:26 INFO - 'PWD': '/builds/slave/test', 09:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:26 INFO - 'SHELL': '/bin/bash', 09:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:26 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:26 INFO - 'USER': 'cltbld', 09:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:26 INFO - 'XPC_FLAGS': '0x0', 09:57:26 INFO - 'XPC_SERVICE_NAME': '0', 09:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:26 INFO - Downloading/unpacking psutil>=3.1.1 09:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:29 INFO - Installing collected packages: psutil 09:57:29 INFO - Running setup.py install for psutil 09:57:29 INFO - building 'psutil._psutil_osx' extension 09:57:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:57:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:57:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:57:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:57:30 INFO - building 'psutil._psutil_posix' extension 09:57:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:57:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:30 INFO - ^ 09:57:30 INFO - 1 warning generated. 09:57:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:31 INFO - Successfully installed psutil 09:57:31 INFO - Cleaning up... 09:57:31 INFO - Return code: 0 09:57:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:31 INFO - 'HOME': '/Users/cltbld', 09:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:31 INFO - 'LOGNAME': 'cltbld', 09:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:31 INFO - 'MOZ_NO_REMOTE': '1', 09:57:31 INFO - 'NO_EM_RESTART': '1', 09:57:31 INFO - 'PAGER': '/bin/cat', 09:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:31 INFO - 'PWD': '/builds/slave/test', 09:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:31 INFO - 'SHELL': '/bin/bash', 09:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:31 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:31 INFO - 'USER': 'cltbld', 09:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:31 INFO - 'XPC_FLAGS': '0x0', 09:57:31 INFO - 'XPC_SERVICE_NAME': '0', 09:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:34 INFO - Installing collected packages: mozsystemmonitor 09:57:34 INFO - Running setup.py install for mozsystemmonitor 09:57:34 INFO - Successfully installed mozsystemmonitor 09:57:34 INFO - Cleaning up... 09:57:34 INFO - Return code: 0 09:57:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:34 INFO - 'HOME': '/Users/cltbld', 09:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:34 INFO - 'LOGNAME': 'cltbld', 09:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:34 INFO - 'MOZ_NO_REMOTE': '1', 09:57:34 INFO - 'NO_EM_RESTART': '1', 09:57:34 INFO - 'PAGER': '/bin/cat', 09:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:34 INFO - 'PWD': '/builds/slave/test', 09:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:34 INFO - 'SHELL': '/bin/bash', 09:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:34 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:34 INFO - 'USER': 'cltbld', 09:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:34 INFO - 'XPC_FLAGS': '0x0', 09:57:34 INFO - 'XPC_SERVICE_NAME': '0', 09:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:37 INFO - warning: no files found matching '*.txt' 09:57:37 INFO - no previously-included directories found matching 'build' 09:57:37 INFO - no previously-included directories found matching 'dist' 09:57:37 INFO - no previously-included directories found matching '.git*' 09:57:37 INFO - Installing collected packages: jsonschema, functools32 09:57:37 INFO - Running setup.py install for functools32 09:57:37 INFO - warning: no files found matching '*.txt' 09:57:37 INFO - no previously-included directories found matching 'build' 09:57:37 INFO - no previously-included directories found matching 'dist' 09:57:37 INFO - no previously-included directories found matching '.git*' 09:57:37 INFO - Successfully installed jsonschema functools32 09:57:37 INFO - Cleaning up... 09:57:38 INFO - Return code: 0 09:57:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:38 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:38 INFO - 'HOME': '/Users/cltbld', 09:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:38 INFO - 'LOGNAME': 'cltbld', 09:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:38 INFO - 'MOZ_NO_REMOTE': '1', 09:57:38 INFO - 'NO_EM_RESTART': '1', 09:57:38 INFO - 'PAGER': '/bin/cat', 09:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:38 INFO - 'PWD': '/builds/slave/test', 09:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:38 INFO - 'SHELL': '/bin/bash', 09:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:38 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:38 INFO - 'USER': 'cltbld', 09:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:38 INFO - 'XPC_FLAGS': '0x0', 09:57:38 INFO - 'XPC_SERVICE_NAME': '0', 09:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:38 INFO - Cleaning up... 09:57:38 INFO - Return code: 0 09:57:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:38 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:38 INFO - 'HOME': '/Users/cltbld', 09:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:38 INFO - 'LOGNAME': 'cltbld', 09:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:38 INFO - 'MOZ_NO_REMOTE': '1', 09:57:38 INFO - 'NO_EM_RESTART': '1', 09:57:38 INFO - 'PAGER': '/bin/cat', 09:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:38 INFO - 'PWD': '/builds/slave/test', 09:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:38 INFO - 'SHELL': '/bin/bash', 09:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:38 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:38 INFO - 'USER': 'cltbld', 09:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:38 INFO - 'XPC_FLAGS': '0x0', 09:57:38 INFO - 'XPC_SERVICE_NAME': '0', 09:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:42 INFO - Downloading docopt-0.6.1.tar.gz 09:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:42 INFO - Running setup.py install for blobuploader 09:57:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:42 INFO - Running setup.py install for requests 09:57:43 INFO - Running setup.py install for docopt 09:57:43 INFO - Successfully installed blobuploader requests docopt 09:57:43 INFO - Cleaning up... 09:57:43 INFO - Return code: 0 09:57:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:43 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:43 INFO - 'HOME': '/Users/cltbld', 09:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:43 INFO - 'LOGNAME': 'cltbld', 09:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:43 INFO - 'MOZ_NO_REMOTE': '1', 09:57:43 INFO - 'NO_EM_RESTART': '1', 09:57:43 INFO - 'PAGER': '/bin/cat', 09:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:43 INFO - 'PWD': '/builds/slave/test', 09:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:43 INFO - 'SHELL': '/bin/bash', 09:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:43 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:43 INFO - 'USER': 'cltbld', 09:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:43 INFO - 'XPC_FLAGS': '0x0', 09:57:43 INFO - 'XPC_SERVICE_NAME': '0', 09:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:43 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-D4IZKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:43 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-QMg12q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:43 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-qTWzL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_ch3xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-W6IvN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fRs6FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-kemsi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WusO6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_7mqOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-VVLZup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-GlwBHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:44 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-SngB5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:45 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-TXOZNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:45 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-lfLt72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:45 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6H9L6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:45 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-SvXQHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:45 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-YHwghe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:45 INFO - Running setup.py install for manifestparser 09:57:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:45 INFO - Running setup.py install for mozcrash 09:57:45 INFO - Running setup.py install for mozdebug 09:57:45 INFO - Running setup.py install for mozdevice 09:57:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Running setup.py install for mozfile 09:57:46 INFO - Running setup.py install for mozhttpd 09:57:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Running setup.py install for mozinfo 09:57:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Running setup.py install for mozInstall 09:57:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:46 INFO - Running setup.py install for mozleak 09:57:46 INFO - Running setup.py install for mozlog 09:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Running setup.py install for moznetwork 09:57:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Running setup.py install for mozprocess 09:57:47 INFO - Running setup.py install for mozprofile 09:57:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Running setup.py install for mozrunner 09:57:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:47 INFO - Running setup.py install for mozscreenshot 09:57:47 INFO - Running setup.py install for moztest 09:57:47 INFO - Running setup.py install for mozversion 09:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:48 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:48 INFO - 'HOME': '/Users/cltbld', 09:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:48 INFO - 'LOGNAME': 'cltbld', 09:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:48 INFO - 'MOZ_NO_REMOTE': '1', 09:57:48 INFO - 'NO_EM_RESTART': '1', 09:57:48 INFO - 'PAGER': '/bin/cat', 09:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:48 INFO - 'PWD': '/builds/slave/test', 09:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:48 INFO - 'SHELL': '/bin/bash', 09:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:48 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:48 INFO - 'USER': 'cltbld', 09:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:48 INFO - 'XPC_FLAGS': '0x0', 09:57:48 INFO - 'XPC_SERVICE_NAME': '0', 09:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-BbvjQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-aFdFD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:48 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)) 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-U2TcAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-LBnwTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fL9n4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Cas6k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-eju1RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-JtRYXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-1ripnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-mHmWYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-rwhRhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zJH4Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5kynEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8bkC2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:49 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)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IWZDQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-hbmNsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:50 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8DIMf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:57:50 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)) 09:57:50 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)) 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:52 INFO - Downloading blessings-1.6.tar.gz 09:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:53 INFO - Installing collected packages: blessings 09:57:53 INFO - Running setup.py install for blessings 09:57:53 INFO - Successfully installed blessings 09:57:53 INFO - Cleaning up... 09:57:53 INFO - Return code: 0 09:57:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:53 INFO - Reading from file tmpfile_stdout 09:57:53 INFO - Current package versions: 09:57:53 INFO - blessings == 1.6 09:57:53 INFO - blobuploader == 1.2.4 09:57:53 INFO - docopt == 0.6.1 09:57:53 INFO - functools32 == 3.2.3-2 09:57:53 INFO - jsonschema == 2.5.1 09:57:53 INFO - manifestparser == 1.1 09:57:53 INFO - mozInstall == 1.12 09:57:53 INFO - mozcrash == 0.17 09:57:53 INFO - mozdebug == 0.1 09:57:53 INFO - mozdevice == 0.48 09:57:53 INFO - mozfile == 1.2 09:57:53 INFO - mozhttpd == 0.7 09:57:53 INFO - mozinfo == 0.9 09:57:53 INFO - mozleak == 0.1 09:57:53 INFO - mozlog == 3.4 09:57:53 INFO - moznetwork == 0.27 09:57:53 INFO - mozprocess == 0.23 09:57:53 INFO - mozprofile == 0.28 09:57:53 INFO - mozrunner == 6.12 09:57:53 INFO - mozscreenshot == 0.1 09:57:53 INFO - mozsystemmonitor == 0.3 09:57:53 INFO - moztest == 0.7 09:57:53 INFO - mozversion == 1.4 09:57:53 INFO - psutil == 3.1.1 09:57:53 INFO - requests == 1.2.3 09:57:53 INFO - wsgiref == 0.1.2 09:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:53 INFO - 'HOME': '/Users/cltbld', 09:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:53 INFO - 'LOGNAME': 'cltbld', 09:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:53 INFO - 'MOZ_NO_REMOTE': '1', 09:57:53 INFO - 'NO_EM_RESTART': '1', 09:57:53 INFO - 'PAGER': '/bin/cat', 09:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:53 INFO - 'PWD': '/builds/slave/test', 09:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:53 INFO - 'SHELL': '/bin/bash', 09:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:53 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:53 INFO - 'USER': 'cltbld', 09:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:53 INFO - 'XPC_FLAGS': '0x0', 09:57:53 INFO - 'XPC_SERVICE_NAME': '0', 09:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:57:53 INFO - Cleaning up... 09:57:53 INFO - Return code: 0 09:57:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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 0x10b0ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b075570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0eb66f910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, '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.NorsrSyitQ/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.f1sBpovloW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:54 INFO - 'HOME': '/Users/cltbld', 09:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:54 INFO - 'LOGNAME': 'cltbld', 09:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:54 INFO - 'MOZ_NO_REMOTE': '1', 09:57:54 INFO - 'NO_EM_RESTART': '1', 09:57:54 INFO - 'PAGER': '/bin/cat', 09:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:54 INFO - 'PWD': '/builds/slave/test', 09:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:54 INFO - 'SHELL': '/bin/bash', 09:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:57:54 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:54 INFO - 'USER': 'cltbld', 09:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:54 INFO - 'XPC_FLAGS': '0x0', 09:57:54 INFO - 'XPC_SERVICE_NAME': '0', 09:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:54 INFO - Cleaning up... 09:57:54 INFO - Return code: 0 09:57:54 INFO - Running post-action listener: _resource_record_post_action 09:57:54 INFO - Running post-action listener: _start_resource_monitoring 09:57:54 INFO - Starting resource monitoring. 09:57:54 INFO - [mozharness: 2017-01-06 17:57:54.533534Z] Finished create-virtualenv step (success) 09:57:54 INFO - [mozharness: 2017-01-06 17:57:54.534558Z] Running install step. 09:57:54 INFO - Running pre-action listener: _resource_record_pre_action 09:57:54 INFO - Running main action method: install 09:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:54 INFO - Reading from file tmpfile_stdout 09:57:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:54 INFO - Reading from file tmpfile_stdout 09:57:54 INFO - Output received: 09:57:54 INFO - Usage: mozinstall [options] installer 09:57:54 INFO - Options: 09:57:54 INFO - -h, --help show this help message and exit 09:57:54 INFO - -d DEST, --destination=DEST 09:57:54 INFO - Directory to install application into. [default: 09:57:54 INFO - "/builds/slave/test"] 09:57:54 INFO - --app=APP Application being installed. [default: firefox] 09:57:54 INFO - mkdir: /builds/slave/test/build/application 09:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:58:16 INFO - Reading from file tmpfile_stdout 09:58:16 INFO - Output received: 09:58:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:58:16 INFO - Running post-action listener: _resource_record_post_action 09:58:16 INFO - [mozharness: 2017-01-06 17:58:16.872789Z] Finished install step (success) 09:58:16 INFO - [mozharness: 2017-01-06 17:58:16.872916Z] Running run-tests step. 09:58:16 INFO - Running pre-action listener: _resource_record_pre_action 09:58:16 INFO - Running main action method: run_tests 09:58:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:16 INFO - 2017-01-06 09:58:16.887 screenresolution[1617:7486] starting screenresolution argv=screenresolution get 09:58:16 INFO - 2017-01-06 09:58:16.889 screenresolution[1617:7486] Display 0: 1600x1200x32@60 09:58:16 INFO - 2017-01-06 09:58:16.895 screenresolution[1618:7488] starting screenresolution argv=screenresolution list 09:58:16 INFO - Available Modes on Display 0 09:58:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:17 INFO - Intel Iris: 09:58:17 INFO - Chipset Model: Intel Iris 09:58:17 INFO - Type: GPU 09:58:17 INFO - Bus: Built-In 09:58:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:17 INFO - Vendor: Intel (0x8086) 09:58:17 INFO - Device ID: 0x0a2e 09:58:17 INFO - Revision ID: 0x0009 09:58:17 INFO - Displays: 09:58:17 INFO - Display: 09:58:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:17 INFO - Display Serial Number: 1600x1200 60 09:58:17 INFO - Main Display: Yes 09:58:17 INFO - Mirror: Off 09:58:17 INFO - Online: Yes 09:58:17 INFO - Rotation: Supported 09:58:17 INFO - Return code: 0 09:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:17 INFO - Python 2.7.3 09:58:17 INFO - Return code: 0 09:58:17 INFO - grabbing minidump binary from tooltool 09:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:17 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 0x10af13d30>, '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 0x10ad79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af0bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:58:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:58:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:58:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:17 INFO - Return code: 0 09:58:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NorsrSyitQ/Render', 09:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:17 INFO - 'HOME': '/Users/cltbld', 09:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:17 INFO - 'LOGNAME': 'cltbld', 09:58:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:17 INFO - 'MOZ_NO_REMOTE': '1', 09:58:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:17 INFO - 'NO_EM_RESTART': '1', 09:58:17 INFO - 'PAGER': '/bin/cat', 09:58:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:17 INFO - 'PWD': '/builds/slave/test', 09:58:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:17 INFO - 'SHELL': '/bin/bash', 09:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1sBpovloW/Listeners', 09:58:17 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 09:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:17 INFO - 'USER': 'cltbld', 09:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:17 INFO - 'XPC_FLAGS': '0x0', 09:58:17 INFO - 'XPC_SERVICE_NAME': '0', 09:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:58:17 INFO - mozversion application_buildid: 20170106073357 09:58:17 INFO - mozversion application_changeset: e0b425ab0e852c6fef7eaae8c7801070341d14a9 09:58:17 INFO - mozversion application_display_name: Firefox 09:58:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:17 INFO - mozversion application_name: Firefox 09:58:17 INFO - mozversion application_remotingname: firefox 09:58:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:17 INFO - mozversion application_vendor: Mozilla 09:58:17 INFO - mozversion application_version: 51.0 09:58:17 INFO - mozversion platform_buildid: 20170106073357 09:58:17 INFO - mozversion platform_changeset: e0b425ab0e852c6fef7eaae8c7801070341d14a9 09:58:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:17 INFO - mozversion platform_version: 51.0 09:58:17 INFO - using testdate: 1483725497 09:58:17 INFO - actual date: 1483725497 09:58:17 INFO - starting webserver on 'localhost:49248' 09:58:17 INFO - SUITE-START | Running 2 tests 09:58:17 INFO - TEST-START | dromaeo_css 09:58:17 INFO - operating with platform_type : mac_ 09:58:17 INFO - Initialising browser for dromaeo_css test... 09:58:17 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpQVrgzS/profile http://localhost:49248/getInfo.html) 09:58:20 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 09:58:20 INFO - PROCESS | 1628 | colorDepth:24 09:58:20 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 09:58:20 INFO - PROCESS | 1628 | __metrics 09:58:20 ERROR - PROCESS | 1628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 09:58:20 INFO - TEST-INFO | 1628: exit 0 09:58:20 INFO - Browser initialized. 09:58:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:20 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpQVrgzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:32 INFO - PROCESS | 1632 | RSS: Main: 175251456 09:58:32 INFO - PROCESS | 1632 | 09:59:22 INFO - PROCESS | 1632 | 1483725562503 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] 10:01:34 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 10:01:35 INFO - PROCESS | 1632 | RSS: Main: 187899904 10:01:35 INFO - PROCESS | 1632 | 10:04:37 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 10:04:38 INFO - PROCESS | 1632 | RSS: Main: 199000064 10:04:38 INFO - PROCESS | 1632 | 10:07:40 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:07:40 INFO - PROCESS | 1632 | RSS: Main: 200306688 10:07:40 INFO - PROCESS | 1632 | 10:10:42 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:10:43 INFO - PROCESS | 1632 | RSS: Main: 205705216 10:10:43 INFO - PROCESS | 1632 | 10:13:45 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:13:46 INFO - PROCESS | 1632 | RSS: Main: 207908864 10:13:46 INFO - PROCESS | 1632 | 10:16:48 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:16:49 INFO - PROCESS | 1632 | RSS: Main: 208519168 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | __start_tp_report 10:16:49 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 10:16:49 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 10:16:49 INFO - PROCESS | 1632 | |i|pagename|runs| 10:16:49 INFO - PROCESS | 1632 | |0;dojo.html;3613.988083336665;3616.114052057246;3622.7101831853456;3638.5997540270564;3670.3393389189937;4645.605123564501;5980.910286345703;6053.39466053395;6064.5148388128955;6200.565960382775;6084;6138.386161383859;6142.04798256271;6149.262088549369;6169.290531588868;5441.2654291670615;5496.697681627509;5524.668519888799;5534.225208470817;5586.832395028136;5568.220449137124;5580.883823235369;5583.413741557119;5586.972065139668;5639.2668953036255;5415.729213539327;5434.103372943459;5547.833564993057;5551.084071128259;5558.888822223553;5471.261379713727;5496.972515137439;5500.944990550083;5510.256115424407;5531.612787104904;5356.758945847408;5461.453854614547;5465.945340546623;5483.424240454775;5494.670319780786;6100.206973093514;6105.9753317007;6125.938740612626;6130.917941863022;6143.631382117087;5520.199571062214;5597.824456864063;6255.437010669016;6297.307296197415;6324.209473815773;6385.872282554323;6390.872182556369;6394.104825324458;6395.488360931115;6425.164728585254;4934.8766280843265;6085.604435711664;6094.329623741385;6132.662703551303;6150.7539698411565;6420.390062944013;6421.711023003976;6451.516136289703;6455.225372955276;6461.8061458156335;5941.405859414024;6228.532860035515;6281.152044474029;6282.246130464374;6294.9685251574365;6352.205974253218;6380.361963803675;6384.32964538726;6393.808185754435;6396.200474940632;6169.876602467925;6214.37856214384;6267.373262673696;6287.308396076428;6292.4966002719675;6288.402601752826;6293.465055470337;6294.464970477561;6302.684865756693;6304.369563043659;5168.664036837594;5173.818916337986;5187;5197.454267301954;5216.66091704038;4552.6130278926;4565.315202719552;4577.862664120082;4601.976990115095;4631.305304204397;6215.098810672427;6238.594491358047;6277.654728989949;6278.843028924222;6289.96855015722;6387.584806987531;6437.613743175424;6443.581167224115;6450;6489.1888513935755;6121.81881567809;6160.9383906160365;6173.722182501709;6197.163382943245;6255.937440625627;5605.299337582802;5660.433956604306;5663.008973429633;5672.688002159838;5715.457031581993;6615;6619.437347825488;6656.5340426169705;6697.028930805006;6714.496412769062;5823.8835223294445;5838.5621078418435;6250.874982500233;6297.118403423616;6309.400606942333;6660.433863121689;6692.598444093175;6703.664816759045;6705.966470167618;6729.394354508117;6323.272823625342;6344.68276586178;6350.809475715736;6373.6175829450385;6393.328700486568;6149.41580549847;6252.280987686292;6312.400321969406;6444.677766111769;6449.322821103717;6104.26748790148;6204.162438070803;6248.5313601479165;6257.405546473078;6293.748250069946;6267.529935254783;6271.529635277464;6271.905921411274;6292.370762923671;6295.937040629535;6111.786087487095;6209.689515524115;6240.219972503437;6242.875142497215;6247.437730604086;6173.444390004921;6215.844603884939;6237.1891654084675;6246.063090536456;6266.185395898504;6232.532560057924;6253.843653908689;6263.655498947602;6268.874622507433;6299.464545513682 10:16:49 INFO - PROCESS | 1632 | |1;ext.html;468.25547379666324;499.5878400319737;520.9400918894327;539.0889396919207;551.8289330307603;41444.17111657769;43565;43793.7810310948;43829.7808510957;43861.56138438615;44490.11019779611;44815;45153.54846451535;45411.31883021749;45484.54515454845;9915.603375864957;10140.797184056315;10161.237907156956;10166.84749728751;10208.183345332392;10128.189744820396;10150.187984961221;10165.135963443116;10196.031377019171;10228.977102289786;10166.13587845034;10198.541065652027;10215.897841021606;10220.386776793417;10228.028337307944;8550.401471897001;9261.351705380626;10115.949420252888;10142.898571014342;10156.289059765819;9930.304878658497;10007.59969601215;10013.299069065168;10043.096121349114;10057.647982320657;34403.655963440295;41886.58113418857;42378.78810605958;42637.57362426367;43139.35290970607;3327.7836940599027;3442.122258823984;3458.9827050864837;3490.3019396120876;4313.503947046099;31122.533162002586;31171.53242701361;31497;31647.20881977969;33354.83322583396;3370.4944258361197;3375.8480868360984;3419;3421.5894092708786;3471.531343268677;469155;493925;499453;503411;505187.99999999633;58025;62552.748945020845;63522.364776352566;64029.35970640234;64205;35749.46375804365;36166.45750313748;36239.81880090635;37423;38668.806655967106;17783.19975601101;17972.37096701635;18013.2794688211;18013.459596212135;18022.639547209244;11697.941510292394;13731.519396821262;13871.375788089561;13880.4447822088;13962.930185349009;19369.32207372735;19454.319098831475;19629.50926226827;19651.901740491205;19676.50808729793;7136.607486588184;7287.376544443996;8378.748637540884;8400.789980250544;8459.70391036323;936.3632729743839;1028.7685270814006;1059.142094903131;1099.1811100729847;1099.9670009899717;31425;31519.36961260762;31559.684403155676;31571;31915.202119947186;928.661038720862;1108.8558487396588;1115.3976852499559;1167.7022359298494;1180.7933611617932;13677.423188922628;15883.682326353408;16517.752233716503;16542.503724888273;16581;714933;716249;738839;738917;742307;60703.69648151731;61085.69457152686;61289.38710612926;61392.07911881326;61434;1291.4963164365904;1387.5629176809273;1438.992805035989;1440.7334643091062;1443.1846007006009;29998.85000574983;30743.53884691687;31171.688283116877;31245.687543124277;31580.052598422084;51937.48062519327;52038.73980630073;52138.21792673037;52259.47740522698;52262.47737522576;596823;597619;597934;598235;600716;27806;27826.5826012614;28189.57715634226;28226;28228.71771282261;49182;49224.261636076204;49817.75091124521;50289.74855125701;50292.74853625709;39935.80032099821;41014.79492602518;41115.588844111175;41833;41991.7900410496;40656.186876261716;40799.38800918048;41095.1780964385;41493.170136597706;41600;33993.83003084969;34356.96929092131;38717.806410967765;39648.80175599104;39908;33376;35853.75114912633;36051.098722532144;36407.27185456329;36467.63532364643;26886.865565672048;26890.32774180661;27027.86486067557;27040;27130 10:16:49 INFO - PROCESS | 1632 | |2;jquery.html;375.51746006381796;385.5720150632799;396.4964495091236;398.7029662901139;417.63039709856787;19678.311259105918;21306.57386852262;21847.672284915738;21946.45133871652;22096.558068838614;18712.345067922626;20764.065617047232;21288.36134915951;21298.148074077017;21468.785312146872;5936.940630593682;6224.937750622481;6229;6309.274433440167;6310.873782524347;4464.6874718769695;6107.3587273336325;6138.079288106797;6259.155014073111;6273.090401891723;6994.195667498252;7035.4019908307855;7042.40139588133;7053.929460705404;7084.9291507085045;6785.287544807798;6954.895676564881;7001.649917504104;7002.439804815603;7032.15614126303;6016.759329626853;6025.698715064229;6073;6082.239720034996;6138.17134686816;26301.473970520674;26349.604755928678;26351.94592216309;26354.86822565894;26754;2343.8593684378993;2403.8557686538866;2501.4496810701617;2516.5596020696303;2558.424354520218;15643.843561564352;16001.919990399974;16006.759898601531;16309.429169979112;16673.49979500617;1840.374272747259;1912.7704675439036;1929.37295379001;1951.0829909942447;1987.1455274232073;125796;126563;127587;130259.34870325588;131428.34285828605;10947.014768670859;11091.389973551532;11160.386178760245;11222.270552414067;11278.718032049264;13905.860941390456;13957.441702331997;14058.297085145701;14115.50595729165;14121.717565648629;8796.252318552866;8933.821323573622;8945.73162805117;8947.150020748019;9046.819063618823;9053.094690530894;9072.90927090734;9135.497547634812;9208.585613647268;9226.35415520907;6617.139771829631;6690;6711.798646040626;6716.093327400836;6804.251532331538;1601.119384338609;1602.8877978541623;1634.5586691593442;1710.8545773609135;1955.9413217603494;811.8254575266346;813.2274339377615;918.9127032931995;961.6345788600287;986.5659109991581;21075.84082875426;21207;21283.78716212818;21320.893395532923;21475.785242147693;919.3702313914989;942.6936245720168;946.5078159357233;957.7366224288237;1026.7227848481018;9618.951905240428;10970.561177552969;11156.665300041012;11277.887221127849;11278.661640150809;632084;642780;646769;651176;653447;98982.52543686322;127915.36042319729;128382.35808821084;129257;130144.34927825301;979.7991411760572;980.9509524523745;999.3853779925294;1003.4280460137652;1003.5032658833924;18190.181441834884;18514.44456666302;18697.90651046736;18853.811461885205;19011.239550417828;38307.23385532218;45205.41781037648;55624.72187639198;56584.71707641435;57456;85134.57432712796;88090.55954720185;88663;88945.66581501412;89672.551637244;7277.781666550012;7549.849003020019;7629.3133617974645;7960.4825686330205;8339.95830020846;9231.676891308773;11243.381614011309;12654.746905062031;13120.540781072617;13256.469741210243;11314.773704526027;11352.489137988645;11676.474558644712;11735.941320293345;11764.882351176379;11097.38964356968;11101.0564102049;11306.604268850551;11333.829992549954;11399.772004560029;9316.673916412892;9648.517574121406;11489.310641361544;11642.76714465689;11999.980001699952;7139.500234983501;7363.153237377556;7426.628668566442;7572.924270757222;7654.196309387434;8169.387295952709;10151.54318055704;11404;11525.538978440769;11718.472668729757 10:16:49 INFO - PROCESS | 1632 | |3;mootools.html;1544.9845501544985;1596.608830836445;1815.6731788278114;1873.6627407066724;1927.1905799564172;8317.12670169631;8583.613737381816;8941.329400294979;9343.439393636387;9481.241500679938;8855.291576673866;9219;9231.446113233194;9255.074492550742;9374.625014999392;2368.9289321320343;2406.9037238510437;2417.697787776528;2425.38152771044;2436.2204094689705;2387.5821731197057;2405.4707964247837;2413.3122060212845;2421.9394515137174;2426.5510880487077;1941.6602094633454;2069.2343832781817;2272.7045484087043;2439.4755127647554;2441.340837973746;2088.467440802601;2338.240071976614;2399.3161948844495;2400.9159679411136;2420;2394.174009966559;2408.903643854261;2410.337157281744;2417.7944874685672;2420.576399130145;9123.133302336268;9149.588268527932;9231;9275.489848058354;9308.534573271378;5541.418151094117;5581.944180558224;5630.915536266959;5665.886682266331;5728.656280623176;3136.294333774905;3600.1539638185004;3648.762830416041;3699.1676872703697;3718.2563487302646;1123.5449642894641;1124.1568823382463;1129.2151954391702;1131.9717007074807;1136.7840110379002;12304.876951230463;12425.130240883142;12457.813132803016;12508;12515.624531263986;4844.709317440965;4922.212446008693;4932.112219800399;5027.949720502821;5034.647574669812;10581.947090264654;10632.149428045737;10695.465226738632;10741.409222492837;10743.194260430499;5541.168824676331;5541.307336582927;5551.528120109755;5621.409751976065;5664.745086471119;4600.332951722048;4619.076184763061;5040.218766091261;5112.897742045213;5125.15434953236;3443.4318337474538;4161.271777438936;4247.830086796494;4299.914001719948;4306.784660766949;1301.1087405127519;1303.452549929032;1325.6553296143072;1341.8121462995189;1353.1813252981804;820.9876851847227;912.748994026648;924.1128516624116;927.534495497113;928.3826255540125;5771.30744310677;5865.090910908816;5889.528837692974;6031.517478601701;6109.541784366102;390.78897395406733;458.3468557305826;467.1777671298539;471.09314569454347;473.94075740532435;3944.9211015779524;3951.328274193394;3965.722399432012;3976.065624578222;4056.8782936511952;10905.563777448813;11167.441627918572;11370.545178192946;11378.374189419495;11441.656750297505;9530;11346.432678366215;11350.3757293348;11354.602588909349;11369.772604547863;8162.306203972729;8441.620127094418;8599.183077607742;8609.827803443895;8637.136286371438;6002.399760023963;6003.759849606142;6037.818865434044;6066.696665166813;6094.329623741473;10232.130268926927;10329.690109296733;10331.225158113322;10461.843072353768;10579.047885690325;10174.389536627827;10233.74415639615;10425.322354046963;10603.310784798963;10769;7108.964455177691;7342.008828808042;7679.808004799701;7785.844283114419;7796.610169491616;6954.339337763106;8605.612747426507;8800.635901435287;8903.910960890567;8920.821583568422;7830.843383132419;7975.601219939096;7975.960120199362;8036.919630803617;8152.103268640563;7845.176256492986;7907.051153861574;7938.682452701827;7939.444238903221;7970.043594768665;7250.673719682522;7264.963675181802;7299.270072992658;7312.853742925218;7368.300011498899;4948.802047918043;5040.117979353672;5116.437191908813;5151.1243088675765;5196.2465442509865;4745.2882067690125;4806.735629540409;5065.417476990193;5092.898142037213;5151.6393852431465 10:16:49 INFO - PROCESS | 1632 | |4;prototype.html;284.462366128018;296.39091666625075;307.22425874666453;309.5047923322683;311.59492659542605;4761.50004249554;5327.813526526573;5360.195970604412;5540.3628582713;5613.747381367838;5391.32608423947;5529.585281103913;5533.861653458665;5535.142052981794;5616.269884914956;3489.092835862681;4221.831126754926;4232.746035237888;4242.236397448458;4252.000779816741;4101.589841015904;4232.259354612946;4237.453329534728;4248.936265956013;4251.638610718092;4184.205001049806;4188.329867221245;4194.433751443562;4198.244316023115;4222.894427639319;4152.294110001292;4187.853425130106;4200.243956087903;4201.495820501529;4230.830766769325;3657.9817100914593;3665.486831843544;3668.192997540537;3676.8529258829612;3679.3193259247123;5065.645404821664;5380;5429;5454.236406903036;5458.61789674723;4799.424069111694;4800.135975524404;4808.134535783557;4809.014152098812;4811.59101476375;5250.737463126867;5689.715514224272;5886.529077673818;5931.762729490858;5948.553858460633;3619.366610843092;3689.8708545201057;3937.015746063484;3946.8223929922933;3961.445397644332;5443.822471011627;6172.7530898764;6228.252609686821;6275.780347687854;6287.748490060392;3859.221360620349;3985.5217373914734;4001.919961600752;4013.69897257701;4014.3541148129125;3447.6554143883905;3930.253251882133;4052.675785937118;4057.26134858969;4071.572484889103;3782.735208535431;4197.727147735387;4703.471371804178;4725.8345957892;4806.029527893547;5223.216517522402;5375.354957405137;5854.297484301911;5885.734567068101;6062.666553339609;1218.6039537150461;1350.7568637645122;1354.4785257675865;1374.9893828036386;1384.2663388404162;808.454293351985;834.1783343406739;888.9155530224618;891.9063498332712;893.7532142660951;5597.440255974451;5612.550995920316;5626.774929002876;5628.746706398222;5676.176954341598;5615.4946054854445;5861.443162899518;5948.018576934844;6068.6358818471035;6118.877622447526;5315.229291752674;5578.41426650204;5594.748236329375;5634.85912852182;5659.6321239119325;2298.2990187992486;2327.418145463634;2338.8596684199;2441.914532991372;2662.9600555991674;4619.745913974763;4976.328195693607;5051.9390927904815;5277.358622550428;5334.093204155225;4767.547083027107;4892.535209155125;5003.699778013331;5085.74571271435;5135.922961155511;4330.783460826883;4693.22561777303;4994.875128121826;5325;5341.465853414627;4949.529794669645;5005.699658020385;5043.343575907437;5100.781160195327;5122.231665250242;3985.4456761862316;4908.656394052525;4924.532169443897;4927.201571426475;4960.206366981266;4346.782660866881;4524.276115821453;5031.446540880574;5221.381371774762;5281.445448227881;2879.308965848223;3116;3340.799552026789;3491.476278558135;3496.877609283663;4750.263709125091;4824.589909857701;4922.926156107733;4964.578010869117;5071.77177027042;4119.608637179464;4380.890477738082;4602.895305126813;4735.976320118515;4909.26361045846;4805.924208506489;4822.577339684732;4835.226363781778;4918;4942.332785073969;4763.73799441034;4777.808887644455;4828.975855120842;5108.29648504831;5111.7731744380335;5987.790427335197;5993.550483713651;6014.969925150346;6026.879462410815;6049.758009679564;5428.430014848384;5832.745959618703;5900;5912.497437717842;5912.822615321547 10:16:49 INFO - PROCESS | 1632 | |5;yui.html;708.3093983366215;761.375671949002;768.4275214964852;799.8760192170212;829.2039641943735;15189;16352.509424717247;16484.093374864377;16494.83505164948;16508.422205222818;14811.703765924674;14881.404743810263;14892.478763243289;14897.255137243148;14930.701385972301;716.8207948012997;734.3537686835604;870.2820173356974;881.6825942660637;893.1515060692336;875.1205038935892;878.714417814213;879.846026945282;882.7219425880859;886.3396769406801;861.6036623153326;885.9645614175425;916.2395211974045;917.1058218237232;919.3380765848611;854.3976496569903;876.0626130040858;903.2818908967387;906.7370462565848;910.7358865928873;645.7739791073087;668.6623255256113;689.3451221339748;690.2855544511457;692.2489099327236;11058.281211721292;12068.698282543006;14856.18290993995;14870.628234294121;14940.925295373563;13565.98255130869;13764.793528097087;15164.469243576532;15241.466548670744;15470.767938480933;11854.644360669194;12158.5744498943;12193.695157621041;12201.93899030508;12584.874151258462;3279.6064472263242;3360.781549199294;3739.4951681522916;3894.1432884765304;3921.372580387153;104133;105723.88552228989;106412;107284;107395.46302268517;10962.780744385067;11695.239809412362;11722.648320550397;11750.177487575787;11969.22313229089;23788;23851;24259.636105458434;24328.75671243265;24634.384140396633;8253.13342099083;8295.419320647617;8297.875531867026;8372.288355489729;8458.534780587126;3764.4729737836724;4282;4432.867013989586;4523.457185137739;4745.477997420281;3677.852885884588;3755.6244375562223;3786.6970642348547;3809.447630093621;3824.8852534424013;663.7942237906265;666.9366410191024;677.2753154125137;684.7979845945458;688.7658196213212;566.7562947932346;569.7236840132532;633.832034510855;661.381608196338;703.5110598134247;9316.20812230968;9462.337636365388;9526.333156678966;9676.70969870905;9784.706458806248;549.6674511920231;619.575590720358;623.6756886419037;666.540087339734;692.9064576282238;4456.977715111469;4645.674802763841;4663.347131401607;4710.128626204163;4731.574158325699;87496.6875496868;126202.3689881563;133279;145632;165347;123177.38411307886;128351.35824320819;129120;129206;130202.34898825445;79517;92752.0724792757;100984;113653.86346136598;122753.38623307005;9512.1439070484;9758.902410976083;9998.100170984646;10036.733145674802;10084.949575252076;45470;58987.41012589819;62553.68723156355;62644.686776565824;63064;80106;87602.56198718966;89610.55194724245;91854.622180666;91967;13166;13203.537876174672;13545.458181672622;13549.59351219465;13809.585712428643;12015.879841201477;14040.666136717404;14445.638859028608;14775.482858099915;14896.478623248135;10159;13022.674433139247;13383.598492045254;13548.79676804829;14416.279186040865;12790.68023299425;14418.495352662607;14943.178125203218;15300.234988250766;15745.291461884013;13868.86131138716;14990.400383984519;15043.398264069752;15431.922840385727;15692.215389230265;10350.585976560853;10955.17836162307;11176;11339.149563782585;11669.599266437082;8942.68700595502;10271.589136434459;10886.23796334249;11560.6531804046;12886.355682216039 10:16:49 INFO - PROCESS | 1632 | __end_tp_report 10:16:49 INFO - PROCESS | 1632 | __start_cc_report 10:16:49 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,358 10:16:49 INFO - PROCESS | 1632 | __end_cc_report 10:16:49 INFO - PROCESS | 1632 | __startTimestamp1483726609068__endTimestamp 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | ------- Summary: start ------- 10:16:49 INFO - PROCESS | 1632 | Number of tests: 6 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5962.41 Median:6215.10 stddev:626.23 (10.1%) stddev-sans-first:600.44 10:16:49 INFO - PROCESS | 1632 | Values: 3614.0 3616.1 3622.7 3638.6 3670.3 4645.6 5980.9 6053.4 6064.5 6200.6 6084.0 6138.4 6142.0 6149.3 6169.3 5441.3 5496.7 5524.7 5534.2 5586.8 5568.2 5580.9 5583.4 5587.0 5639.3 5415.7 5434.1 5547.8 5551.1 5558.9 5471.3 5497.0 5500.9 5510.3 5531.6 5356.8 5461.5 5465.9 5483.4 5494.7 6100.2 6106.0 6125.9 6130.9 6143.6 5520.2 5597.8 6255.4 6297.3 6324.2 6385.9 6390.9 6394.1 6395.5 6425.2 4934.9 6085.6 6094.3 6132.7 6150.8 6420.4 6421.7 6451.5 6455.2 6461.8 5941.4 6228.5 6281.2 6282.2 6295.0 6352.2 6380.4 6384.3 6393.8 6396.2 6169.9 6214.4 6267.4 6287.3 6292.5 6288.4 6293.5 6294.5 6302.7 6304.4 5168.7 5173.8 5187.0 5197.5 5216.7 4552.6 4565.3 4577.9 4602.0 4631.3 6215.1 6238.6 6277.7 6278.8 6290.0 6387.6 6437.6 6443.6 6450.0 6489.2 6121.8 6160.9 6173.7 6197.2 6255.9 5605.3 5660.4 5663.0 5672.7 5715.5 6615.0 6619.4 6656.5 6697.0 6714.5 5823.9 5838.6 6250.9 6297.1 6309.4 6660.4 6692.6 6703.7 6706.0 6729.4 6323.3 6344.7 6350.8 6373.6 6393.3 6149.4 6252.3 6312.4 6444.7 6449.3 6104.3 6204.2 6248.5 6257.4 6293.7 6267.5 6271.5 6271.9 6292.4 6295.9 6111.8 6209.7 6240.2 6242.9 6247.4 6173.4 6215.8 6237.2 6246.1 6266.2 6232.5 6253.8 6263.7 6268.9 6299.5 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:73748.79 Median:3480.92 stddev:164777.82 (4733.7%) stddev-sans-first:165148.21 10:16:49 INFO - PROCESS | 1632 | Values: 468.3 499.6 520.9 539.1 551.8 41444.2 43565.0 43793.8 43829.8 43861.6 44490.1 44815.0 45153.5 45411.3 45484.5 9915.6 10140.8 10161.2 10166.8 10208.2 10128.2 10150.2 10165.1 10196.0 10229.0 10166.1 10198.5 10215.9 10220.4 10228.0 8550.4 9261.4 10115.9 10142.9 10156.3 9930.3 10007.6 10013.3 10043.1 10057.6 34403.7 41886.6 42378.8 42637.6 43139.4 3327.8 3442.1 3459.0 3490.3 4313.5 31122.5 31171.5 31497.0 31647.2 33354.8 3370.5 3375.8 3419.0 3421.6 3471.5 469155.0 493925.0 499453.0 503411.0 505188.0 58025.0 62552.7 63522.4 64029.4 64205.0 35749.5 36166.5 36239.8 37423.0 38668.8 17783.2 17972.4 18013.3 18013.5 18022.6 11697.9 13731.5 13871.4 13880.4 13962.9 19369.3 19454.3 19629.5 19651.9 19676.5 7136.6 7287.4 8378.7 8400.8 8459.7 936.4 1028.8 1059.1 1099.2 1100.0 31425.0 31519.4 31559.7 31571.0 31915.2 928.7 1108.9 1115.4 1167.7 1180.8 13677.4 15883.7 16517.8 16542.5 16581.0 714933.0 716249.0 738839.0 738917.0 742307.0 60703.7 61085.7 61289.4 61392.1 61434.0 1291.5 1387.6 1439.0 1440.7 1443.2 29998.9 30743.5 31171.7 31245.7 31580.1 51937.5 52038.7 52138.2 52259.5 52262.5 596823.0 597619.0 597934.0 598235.0 600716.0 27806.0 27826.6 28189.6 28226.0 28228.7 49182.0 49224.3 49817.8 50289.7 50292.7 39935.8 41014.8 41115.6 41833.0 41991.8 40656.2 40799.4 41095.2 41493.2 41600.0 33993.8 34357.0 38717.8 39648.8 39908.0 33376.0 35853.8 36051.1 36407.3 36467.6 26886.9 26890.3 27027.9 27040.0 27130.0 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:37038.51 Median:26554.43 stddev:107459.85 (404.7%) stddev-sans-first:107726.04 10:16:49 INFO - PROCESS | 1632 | Values: 375.5 385.6 396.5 398.7 417.6 19678.3 21306.6 21847.7 21946.5 22096.6 18712.3 20764.1 21288.4 21298.1 21468.8 5936.9 6224.9 6229.0 6309.3 6310.9 4464.7 6107.4 6138.1 6259.2 6273.1 6994.2 7035.4 7042.4 7053.9 7084.9 6785.3 6954.9 7001.6 7002.4 7032.2 6016.8 6025.7 6073.0 6082.2 6138.2 26301.5 26349.6 26351.9 26354.9 26754.0 2343.9 2403.9 2501.4 2516.6 2558.4 15643.8 16001.9 16006.8 16309.4 16673.5 1840.4 1912.8 1929.4 1951.1 1987.1 125796.0 126563.0 127587.0 130259.3 131428.3 10947.0 11091.4 11160.4 11222.3 11278.7 13905.9 13957.4 14058.3 14115.5 14121.7 8796.3 8933.8 8945.7 8947.2 9046.8 9053.1 9072.9 9135.5 9208.6 9226.4 6617.1 6690.0 6711.8 6716.1 6804.3 1601.1 1602.9 1634.6 1710.9 1955.9 811.8 813.2 918.9 961.6 986.6 21075.8 21207.0 21283.8 21320.9 21475.8 919.4 942.7 946.5 957.7 1026.7 9619.0 10970.6 11156.7 11277.9 11278.7 632084.0 642780.0 646769.0 651176.0 653447.0 98982.5 127915.4 128382.4 129257.0 130144.3 979.8 981.0 999.4 1003.4 1003.5 18190.2 18514.4 18697.9 18853.8 19011.2 38307.2 45205.4 55624.7 56584.7 57456.0 85134.6 88090.6 88663.0 88945.7 89672.6 7277.8 7549.8 7629.3 7960.5 8340.0 9231.7 11243.4 12654.7 13120.5 13256.5 11314.8 11352.5 11676.5 11735.9 11764.9 11097.4 11101.1 11306.6 11333.8 11399.8 9316.7 9648.5 11489.3 11642.8 12000.0 7139.5 7363.2 7426.6 7572.9 7654.2 8169.4 10151.5 11404.0 11525.5 11718.5 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:5925.09 Median:2609.61 stddev:3402.43 (130.4%) stddev-sans-first:3396.05 10:16:49 INFO - PROCESS | 1632 | Values: 1545.0 1596.6 1815.7 1873.7 1927.2 8317.1 8583.6 8941.3 9343.4 9481.2 8855.3 9219.0 9231.4 9255.1 9374.6 2368.9 2406.9 2417.7 2425.4 2436.2 2387.6 2405.5 2413.3 2421.9 2426.6 1941.7 2069.2 2272.7 2439.5 2441.3 2088.5 2338.2 2399.3 2400.9 2420.0 2394.2 2408.9 2410.3 2417.8 2420.6 9123.1 9149.6 9231.0 9275.5 9308.5 5541.4 5581.9 5630.9 5665.9 5728.7 3136.3 3600.2 3648.8 3699.2 3718.3 1123.5 1124.2 1129.2 1132.0 1136.8 12304.9 12425.1 12457.8 12508.0 12515.6 4844.7 4922.2 4932.1 5027.9 5034.6 10581.9 10632.1 10695.5 10741.4 10743.2 5541.2 5541.3 5551.5 5621.4 5664.7 4600.3 4619.1 5040.2 5112.9 5125.2 3443.4 4161.3 4247.8 4299.9 4306.8 1301.1 1303.5 1325.7 1341.8 1353.2 821.0 912.7 924.1 927.5 928.4 5771.3 5865.1 5889.5 6031.5 6109.5 390.8 458.3 467.2 471.1 473.9 3944.9 3951.3 3965.7 3976.1 4056.9 10905.6 11167.4 11370.5 11378.4 11441.7 9530.0 11346.4 11350.4 11354.6 11369.8 8162.3 8441.6 8599.2 8609.8 8637.1 6002.4 6003.8 6037.8 6066.7 6094.3 10232.1 10329.7 10331.2 10461.8 10579.0 10174.4 10233.7 10425.3 10603.3 10769.0 7109.0 7342.0 7679.8 7785.8 7796.6 6954.3 8605.6 8800.6 8903.9 8920.8 7830.8 7975.6 7976.0 8036.9 8152.1 7845.2 7907.1 7938.7 7939.4 7970.0 7250.7 7265.0 7299.3 7312.9 7368.3 4948.8 5040.1 5116.4 5151.1 5196.2 4745.3 4806.7 5065.4 5092.9 5151.6 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4472.37 Median:4900.60 stddev:1383.23 (28.2%) stddev-sans-first:1350.92 10:16:49 INFO - PROCESS | 1632 | Values: 284.5 296.4 307.2 309.5 311.6 4761.5 5327.8 5360.2 5540.4 5613.7 5391.3 5529.6 5533.9 5535.1 5616.3 3489.1 4221.8 4232.7 4242.2 4252.0 4101.6 4232.3 4237.5 4248.9 4251.6 4184.2 4188.3 4194.4 4198.2 4222.9 4152.3 4187.9 4200.2 4201.5 4230.8 3658.0 3665.5 3668.2 3676.9 3679.3 5065.6 5380.0 5429.0 5454.2 5458.6 4799.4 4800.1 4808.1 4809.0 4811.6 5250.7 5689.7 5886.5 5931.8 5948.6 3619.4 3689.9 3937.0 3946.8 3961.4 5443.8 6172.8 6228.3 6275.8 6287.7 3859.2 3985.5 4001.9 4013.7 4014.4 3447.7 3930.3 4052.7 4057.3 4071.6 3782.7 4197.7 4703.5 4725.8 4806.0 5223.2 5375.4 5854.3 5885.7 6062.7 1218.6 1350.8 1354.5 1375.0 1384.3 808.5 834.2 888.9 891.9 893.8 5597.4 5612.6 5626.8 5628.7 5676.2 5615.5 5861.4 5948.0 6068.6 6118.9 5315.2 5578.4 5594.7 5634.9 5659.6 2298.3 2327.4 2338.9 2441.9 2663.0 4619.7 4976.3 5051.9 5277.4 5334.1 4767.5 4892.5 5003.7 5085.7 5135.9 4330.8 4693.2 4994.9 5325.0 5341.5 4949.5 5005.7 5043.3 5100.8 5122.2 3985.4 4908.7 4924.5 4927.2 4960.2 4346.8 4524.3 5031.4 5221.4 5281.4 2879.3 3116.0 3340.8 3491.5 3496.9 4750.3 4824.6 4922.9 4964.6 5071.8 4119.6 4380.9 4602.9 4736.0 4909.3 4805.9 4822.6 4835.2 4918.0 4942.3 4763.7 4777.8 4829.0 5108.3 5111.8 5987.8 5993.6 6015.0 6026.9 6049.8 5428.4 5832.7 5900.0 5912.5 5912.8 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:24024.10 Median:3708.67 stddev:37404.84 (1008.6%) stddev-sans-first:37468.80 10:16:49 INFO - PROCESS | 1632 | Values: 708.3 761.4 768.4 799.9 829.2 15189.0 16352.5 16484.1 16494.8 16508.4 14811.7 14881.4 14892.5 14897.3 14930.7 716.8 734.4 870.3 881.7 893.2 875.1 878.7 879.8 882.7 886.3 861.6 886.0 916.2 917.1 919.3 854.4 876.1 903.3 906.7 910.7 645.8 668.7 689.3 690.3 692.2 11058.3 12068.7 14856.2 14870.6 14940.9 13566.0 13764.8 15164.5 15241.5 15470.8 11854.6 12158.6 12193.7 12201.9 12584.9 3279.6 3360.8 3739.5 3894.1 3921.4 104133.0 105723.9 106412.0 107284.0 107395.5 10962.8 11695.2 11722.6 11750.2 11969.2 23788.0 23851.0 24259.6 24328.8 24634.4 8253.1 8295.4 8297.9 8372.3 8458.5 3764.5 4282.0 4432.9 4523.5 4745.5 3677.9 3755.6 3786.7 3809.4 3824.9 663.8 666.9 677.3 684.8 688.8 566.8 569.7 633.8 661.4 703.5 9316.2 9462.3 9526.3 9676.7 9784.7 549.7 619.6 623.7 666.5 692.9 4457.0 4645.7 4663.3 4710.1 4731.6 87496.7 126202.4 133279.0 145632.0 165347.0 123177.4 128351.4 129120.0 129206.0 130202.3 79517.0 92752.1 100984.0 113653.9 122753.4 9512.1 9758.9 9998.1 10036.7 10084.9 45470.0 58987.4 62553.7 62644.7 63064.0 80106.0 87602.6 89610.6 91854.6 91967.0 13166.0 13203.5 13545.5 13549.6 13809.6 12015.9 14040.7 14445.6 14775.5 14896.5 10159.0 13022.7 13383.6 13548.8 14416.3 12790.7 14418.5 14943.2 15300.2 15745.3 13868.9 14990.4 15043.4 15431.9 15692.2 10350.6 10955.2 11176.0 11339.1 11669.6 8942.7 10271.6 10886.2 11560.7 12886.4 10:16:49 INFO - PROCESS | 1632 | -------- Summary: end -------- 10:16:49 INFO - PROCESS | 1632 | 10:16:49 INFO - TEST-INFO | 1632: exit 0 10:16:49 INFO - TEST-OK | dromaeo_css | took 1112133ms 10:16:49 INFO - TEST-START | kraken 10:16:49 INFO - operating with platform_type : mac_ 10:16:49 INFO - Initialising browser for kraken test... 10:16:49 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpo46rGM/profile http://localhost:49248/getInfo.html) 10:16:52 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 10:16:52 INFO - PROCESS | 1640 | colorDepth:24 10:16:52 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 10:16:52 INFO - PROCESS | 1640 | __metrics 10:16:52 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 10:16:52 INFO - TEST-INFO | 1640: exit 0 10:16:52 INFO - Browser initialized. 10:16:52 INFO - Running cycle 1/1 for kraken test... 10:16:52 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpo46rGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:04 INFO - PROCESS | 1643 | RSS: Main: 174718976 10:17:04 INFO - PROCESS | 1643 | 10:17:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:08 INFO - PROCESS | 1643 | RSS: Main: 186834944 10:17:08 INFO - PROCESS | 1643 | 10:17:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:17:11 INFO - PROCESS | 1643 | RSS: Main: 194916352 10:17:11 INFO - PROCESS | 1643 | 10:17:14 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:17:15 INFO - PROCESS | 1643 | RSS: Main: 198160384 10:17:15 INFO - PROCESS | 1643 | 10:17:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:17:18 INFO - PROCESS | 1643 | RSS: Main: 198443008 10:17:18 INFO - PROCESS | 1643 | 10:17:20 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:20 INFO - PROCESS | 1643 | RSS: Main: 198533120 10:17:20 INFO - PROCESS | 1643 | 10:17:23 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:24 INFO - PROCESS | 1643 | RSS: Main: 200683520 10:17:24 INFO - PROCESS | 1643 | 10:17:27 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:27 INFO - PROCESS | 1643 | RSS: Main: 200515584 10:17:27 INFO - PROCESS | 1643 | 10:17:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:17:31 INFO - PROCESS | 1643 | RSS: Main: 201080832 10:17:31 INFO - PROCESS | 1643 | 10:17:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:33 INFO - PROCESS | 1643 | RSS: Main: 200523776 10:17:33 INFO - PROCESS | 1643 | 10:17:35 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:35 INFO - PROCESS | 1643 | RSS: Main: 200613888 10:17:35 INFO - PROCESS | 1643 | 10:17:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:38 INFO - PROCESS | 1643 | RSS: Main: 200622080 10:17:38 INFO - PROCESS | 1643 | 10:17:41 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:42 INFO - PROCESS | 1643 | RSS: Main: 200634368 10:17:42 INFO - PROCESS | 1643 | 10:17:45 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:45 INFO - PROCESS | 1643 | RSS: Main: 201039872 10:17:45 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:17:47 INFO - PROCESS | 1643 | RSS: Main: 202788864 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | __start_tp_report 10:17:47 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 10:17:47 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 10:17:47 INFO - PROCESS | 1643 | |i|pagename|runs| 10:17:47 INFO - PROCESS | 1643 | |0;ai-astar;106;119;119;116;117;118;118;117;141;172 10:17:47 INFO - PROCESS | 1643 | |1;audio-beat-detection;143;109;114;177;143;144;113;139;175;112 10:17:47 INFO - PROCESS | 1643 | |2;audio-dft;191;198;195;196;195;194;221;276;242;193 10:17:47 INFO - PROCESS | 1643 | |3;audio-fft;85;65;84;78;83;83;85;83;75;58 10:17:47 INFO - PROCESS | 1643 | |4;audio-oscillator;85;64;87;69;69;70;86;69;82;101 10:17:47 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;90;129;88;85;89;85;88;87;126;76 10:17:47 INFO - PROCESS | 1643 | |6;imaging-darkroom;136;140;94;115;126;94;96;95;95;94 10:17:47 INFO - PROCESS | 1643 | |7;imaging-desaturate;91;91;94;90;91;131;145;91;87;90 10:17:47 INFO - PROCESS | 1643 | |8;json-parse-financial;53;55;55;54;57;63;78;78;56;56 10:17:47 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;67;71;71;81;71;69;72;68;68;69 10:17:47 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;83;82;83;85;85;88;79;84;87;87 10:17:47 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;140;135;155;138;150;152;155;140;195;160 10:17:47 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;152;161;172;226;193;163;162;162;161;160 10:17:47 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;66;65;67;66;63;76;86;73;57;81 10:17:47 INFO - PROCESS | 1643 | __end_tp_report 10:17:47 INFO - PROCESS | 1643 | __start_cc_report 10:17:47 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,899 10:17:47 INFO - PROCESS | 1643 | __end_cc_report 10:17:47 INFO - PROCESS | 1643 | __startTimestamp1483726667701__endTimestamp 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | ------- Summary: start ------- 10:17:47 INFO - PROCESS | 1643 | Number of tests: 14 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:124.30 Median:118.50 stddev:18.86 (15.9%) stddev-sans-first:18.80 10:17:47 INFO - PROCESS | 1643 | Values: 106.0 119.0 119.0 116.0 117.0 118.0 118.0 117.0 141.0 172.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:143.00 stddev:25.13 (17.6%) stddev-sans-first:26.56 10:17:47 INFO - PROCESS | 1643 | Values: 143.0 109.0 114.0 177.0 143.0 144.0 113.0 139.0 175.0 112.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:210.10 Median:197.00 stddev:28.28 (14.4%) stddev-sans-first:29.14 10:17:47 INFO - PROCESS | 1643 | Values: 191.0 198.0 195.0 196.0 195.0 194.0 221.0 276.0 242.0 193.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:77.90 Median:83.00 stddev:9.35 (11.3%) stddev-sans-first:9.56 10:17:47 INFO - PROCESS | 1643 | Values: 85.0 65.0 84.0 78.0 83.0 83.0 85.0 83.0 75.0 58.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:76.00 stddev:11.75 (15.5%) stddev-sans-first:12.20 10:17:47 INFO - PROCESS | 1643 | Values: 85.0 64.0 87.0 69.0 69.0 70.0 86.0 69.0 82.0 101.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:87.50 stddev:17.94 (20.5%) stddev-sans-first:18.96 10:17:47 INFO - PROCESS | 1643 | Values: 90.0 129.0 88.0 85.0 89.0 85.0 88.0 87.0 126.0 76.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.00 stddev:19.00 (20.2%) stddev-sans-first:17.35 10:17:47 INFO - PROCESS | 1643 | Values: 136.0 140.0 94.0 115.0 126.0 94.0 96.0 95.0 95.0 94.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:100.10 Median:91.00 stddev:20.32 (22.3%) stddev-sans-first:21.28 10:17:47 INFO - PROCESS | 1643 | Values: 91.0 91.0 94.0 90.0 91.0 131.0 145.0 91.0 87.0 90.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:56.50 stddev:9.61 (17.0%) stddev-sans-first:9.80 10:17:47 INFO - PROCESS | 1643 | Values: 53.0 55.0 55.0 54.0 57.0 63.0 78.0 78.0 56.0 56.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:3.97 (5.6%) stddev-sans-first:3.98 10:17:47 INFO - PROCESS | 1643 | Values: 67.0 71.0 71.0 81.0 71.0 69.0 72.0 68.0 68.0 69.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:2.71 (3.2%) stddev-sans-first:2.83 10:17:47 INFO - PROCESS | 1643 | Values: 83.0 82.0 83.0 85.0 85.0 88.0 79.0 84.0 87.0 87.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:153.50 stddev:17.35 (11.3%) stddev-sans-first:17.85 10:17:47 INFO - PROCESS | 1643 | Values: 140.0 135.0 155.0 138.0 150.0 152.0 155.0 140.0 195.0 160.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:162.50 stddev:22.16 (13.6%) stddev-sans-first:22.38 10:17:47 INFO - PROCESS | 1643 | Values: 152.0 161.0 172.0 226.0 193.0 163.0 162.0 162.0 161.0 160.0 10:17:47 INFO - PROCESS | 1643 | 10:17:47 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:8.86 (12.7%) stddev-sans-first:9.28 10:17:47 INFO - PROCESS | 1643 | Values: 66.0 65.0 67.0 66.0 63.0 76.0 86.0 73.0 57.0 81.0 10:17:47 INFO - PROCESS | 1643 | -------- Summary: end -------- 10:17:47 INFO - PROCESS | 1643 | 10:17:48 INFO - TEST-INFO | 1643: exit 0 10:17:48 INFO - TEST-OK | kraken | took 58829ms 10:17:48 INFO - SUITE-END | took 1170s 10:17:48 INFO - Completed test suite (00:19:31) 10:17:48 INFO - javascript benchmark 10:17:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7512.884535663045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3613.988083336665, 3616.114052057246, 3622.7101831853456, 3638.5997540270564, 3670.3393389189937, 4645.605123564501, 5980.910286345703, 6053.39466053395, 6064.5148388128955, 6200.565960382775, 6084.0, 6138.386161383859, 6142.04798256271, 6149.262088549369, 6169.290531588868, 5441.2654291670615, 5496.697681627509, 5524.668519888799, 5534.225208470817, 5586.832395028136, 5568.220449137124, 5580.883823235369, 5583.413741557119, 5586.972065139668, 5639.2668953036255, 5415.729213539327, 5434.103372943459, 5547.833564993057, 5551.084071128259, 5558.888822223553, 5471.261379713727, 5496.972515137439, 5500.944990550083, 5510.256115424407, 5531.612787104904, 5356.758945847408, 5461.453854614547, 5465.945340546623, 5483.424240454775, 5494.670319780786, 6100.206973093514, 6105.9753317007, 6125.938740612626, 6130.917941863022, 6143.631382117087, 5520.199571062214, 5597.824456864063, 6255.437010669016, 6297.307296197415, 6324.209473815773, 6385.872282554323, 6390.872182556369, 6394.104825324458, 6395.488360931115, 6425.164728585254, 4934.8766280843265, 6085.604435711664, 6094.329623741385, 6132.662703551303, 6150.7539698411565, 6420.390062944013, 6421.711023003976, 6451.516136289703, 6455.225372955276, 6461.8061458156335, 5941.405859414024, 6228.532860035515, 6281.152044474029, 6282.246130464374, 6294.9685251574365, 6352.205974253218, 6380.361963803675, 6384.32964538726, 6393.808185754435, 6396.200474940632, 6169.876602467925, 6214.37856214384, 6267.373262673696, 6287.308396076428, 6292.4966002719675, 6288.402601752826, 6293.465055470337, 6294.464970477561, 6302.684865756693, 6304.369563043659, 5168.664036837594, 5173.818916337986, 5187.0, 5197.454267301954, 5216.66091704038, 4552.6130278926, 4565.315202719552, 4577.862664120082, 4601.976990115095, 4631.305304204397, 6215.098810672427, 6238.594491358047, 6277.654728989949, 6278.843028924222, 6289.96855015722, 6387.584806987531, 6437.613743175424, 6443.581167224115, 6450.0, 6489.1888513935755, 6121.81881567809, 6160.9383906160365, 6173.722182501709, 6197.163382943245, 6255.937440625627, 5605.299337582802, 5660.433956604306, 5663.008973429633, 5672.688002159838, 5715.457031581993, 6615.0, 6619.437347825488, 6656.5340426169705, 6697.028930805006, 6714.496412769062, 5823.8835223294445, 5838.5621078418435, 6250.874982500233, 6297.118403423616, 6309.400606942333, 6660.433863121689, 6692.598444093175, 6703.664816759045, 6705.966470167618, 6729.394354508117, 6323.272823625342, 6344.68276586178, 6350.809475715736, 6373.6175829450385, 6393.328700486568, 6149.41580549847, 6252.280987686292, 6312.400321969406, 6444.677766111769, 6449.322821103717, 6104.26748790148, 6204.162438070803, 6248.5313601479165, 6257.405546473078, 6293.748250069946, 6267.529935254783, 6271.529635277464, 6271.905921411274, 6292.370762923671, 6295.937040629535, 6111.786087487095, 6209.689515524115, 6240.219972503437, 6242.875142497215, 6247.437730604086, 6173.444390004921, 6215.844603884939, 6237.1891654084675, 6246.063090536456, 6266.185395898504, 6232.532560057924, 6253.843653908689, 6263.655498947602, 6268.874622507433, 6299.464545513682], "value": 5925.921515308682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.25547379666324, 499.5878400319737, 520.9400918894327, 539.0889396919207, 551.8289330307603, 41444.17111657769, 43565.0, 43793.7810310948, 43829.7808510957, 43861.56138438615, 44490.11019779611, 44815.0, 45153.54846451535, 45411.31883021749, 45484.54515454845, 9915.603375864957, 10140.797184056315, 10161.237907156956, 10166.84749728751, 10208.183345332392, 10128.189744820396, 10150.187984961221, 10165.135963443116, 10196.031377019171, 10228.977102289786, 10166.13587845034, 10198.541065652027, 10215.897841021606, 10220.386776793417, 10228.028337307944, 8550.401471897001, 9261.351705380626, 10115.949420252888, 10142.898571014342, 10156.289059765819, 9930.304878658497, 10007.59969601215, 10013.299069065168, 10043.096121349114, 10057.647982320657, 34403.655963440295, 41886.58113418857, 42378.78810605958, 42637.57362426367, 43139.35290970607, 3327.7836940599027, 3442.122258823984, 3458.9827050864837, 3490.3019396120876, 4313.503947046099, 31122.533162002586, 31171.53242701361, 31497.0, 31647.20881977969, 33354.83322583396, 3370.4944258361197, 3375.8480868360984, 3419.0, 3421.5894092708786, 3471.531343268677, 469155.0, 493925.0, 499453.0, 503411.0, 505187.99999999633, 58025.0, 62552.748945020845, 63522.364776352566, 64029.35970640234, 64205.0, 35749.46375804365, 36166.45750313748, 36239.81880090635, 37423.0, 38668.806655967106, 17783.19975601101, 17972.37096701635, 18013.2794688211, 18013.459596212135, 18022.639547209244, 11697.941510292394, 13731.519396821262, 13871.375788089561, 13880.4447822088, 13962.930185349009, 19369.32207372735, 19454.319098831475, 19629.50926226827, 19651.901740491205, 19676.50808729793, 7136.607486588184, 7287.376544443996, 8378.748637540884, 8400.789980250544, 8459.70391036323, 936.3632729743839, 1028.7685270814006, 1059.142094903131, 1099.1811100729847, 1099.9670009899717, 31425.0, 31519.36961260762, 31559.684403155676, 31571.0, 31915.202119947186, 928.661038720862, 1108.8558487396588, 1115.3976852499559, 1167.7022359298494, 1180.7933611617932, 13677.423188922628, 15883.682326353408, 16517.752233716503, 16542.503724888273, 16581.0, 714933.0, 716249.0, 738839.0, 738917.0, 742307.0, 60703.69648151731, 61085.69457152686, 61289.38710612926, 61392.07911881326, 61434.0, 1291.4963164365904, 1387.5629176809273, 1438.992805035989, 1440.7334643091062, 1443.1846007006009, 29998.85000574983, 30743.53884691687, 31171.688283116877, 31245.687543124277, 31580.052598422084, 51937.48062519327, 52038.73980630073, 52138.21792673037, 52259.47740522698, 52262.47737522576, 596823.0, 597619.0, 597934.0, 598235.0, 600716.0, 27806.0, 27826.5826012614, 28189.57715634226, 28226.0, 28228.71771282261, 49182.0, 49224.261636076204, 49817.75091124521, 50289.74855125701, 50292.74853625709, 39935.80032099821, 41014.79492602518, 41115.588844111175, 41833.0, 41991.7900410496, 40656.186876261716, 40799.38800918048, 41095.1780964385, 41493.170136597706, 41600.0, 33993.83003084969, 34356.96929092131, 38717.806410967765, 39648.80175599104, 39908.0, 33376.0, 35853.75114912633, 36051.098722532144, 36407.27185456329, 36467.63532364643, 26886.865565672048, 26890.32774180661, 27027.86486067557, 27040.0, 27130.0], "value": 20618.82471187364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.51746006381796, 385.5720150632799, 396.4964495091236, 398.7029662901139, 417.63039709856787, 19678.311259105918, 21306.57386852262, 21847.672284915738, 21946.45133871652, 22096.558068838614, 18712.345067922626, 20764.065617047232, 21288.36134915951, 21298.148074077017, 21468.785312146872, 5936.940630593682, 6224.937750622481, 6229.0, 6309.274433440167, 6310.873782524347, 4464.6874718769695, 6107.3587273336325, 6138.079288106797, 6259.155014073111, 6273.090401891723, 6994.195667498252, 7035.4019908307855, 7042.40139588133, 7053.929460705404, 7084.9291507085045, 6785.287544807798, 6954.895676564881, 7001.649917504104, 7002.439804815603, 7032.15614126303, 6016.759329626853, 6025.698715064229, 6073.0, 6082.239720034996, 6138.17134686816, 26301.473970520674, 26349.604755928678, 26351.94592216309, 26354.86822565894, 26754.0, 2343.8593684378993, 2403.8557686538866, 2501.4496810701617, 2516.5596020696303, 2558.424354520218, 15643.843561564352, 16001.919990399974, 16006.759898601531, 16309.429169979112, 16673.49979500617, 1840.374272747259, 1912.7704675439036, 1929.37295379001, 1951.0829909942447, 1987.1455274232073, 125796.0, 126563.0, 127587.0, 130259.34870325588, 131428.34285828605, 10947.014768670859, 11091.389973551532, 11160.386178760245, 11222.270552414067, 11278.718032049264, 13905.860941390456, 13957.441702331997, 14058.297085145701, 14115.50595729165, 14121.717565648629, 8796.252318552866, 8933.821323573622, 8945.73162805117, 8947.150020748019, 9046.819063618823, 9053.094690530894, 9072.90927090734, 9135.497547634812, 9208.585613647268, 9226.35415520907, 6617.139771829631, 6690.0, 6711.798646040626, 6716.093327400836, 6804.251532331538, 1601.119384338609, 1602.8877978541623, 1634.5586691593442, 1710.8545773609135, 1955.9413217603494, 811.8254575266346, 813.2274339377615, 918.9127032931995, 961.6345788600287, 986.5659109991581, 21075.84082875426, 21207.0, 21283.78716212818, 21320.893395532923, 21475.785242147693, 919.3702313914989, 942.6936245720168, 946.5078159357233, 957.7366224288237, 1026.7227848481018, 9618.951905240428, 10970.561177552969, 11156.665300041012, 11277.887221127849, 11278.661640150809, 632084.0, 642780.0, 646769.0, 651176.0, 653447.0, 98982.52543686322, 127915.36042319729, 128382.35808821084, 129257.0, 130144.34927825301, 979.7991411760572, 980.9509524523745, 999.3853779925294, 1003.4280460137652, 1003.5032658833924, 18190.181441834884, 18514.44456666302, 18697.90651046736, 18853.811461885205, 19011.239550417828, 38307.23385532218, 45205.41781037648, 55624.72187639198, 56584.71707641435, 57456.0, 85134.57432712796, 88090.55954720185, 88663.0, 88945.66581501412, 89672.551637244, 7277.781666550012, 7549.849003020019, 7629.3133617974645, 7960.4825686330205, 8339.95830020846, 9231.676891308773, 11243.381614011309, 12654.746905062031, 13120.540781072617, 13256.469741210243, 11314.773704526027, 11352.489137988645, 11676.474558644712, 11735.941320293345, 11764.882351176379, 11097.38964356968, 11101.0564102049, 11306.604268850551, 11333.829992549954, 11399.772004560029, 9316.673916412892, 9648.517574121406, 11489.310641361544, 11642.76714465689, 11999.980001699952, 7139.500234983501, 7363.153237377556, 7426.628668566442, 7572.924270757222, 7654.196309387434, 8169.387295952709, 10151.54318055704, 11404.0, 11525.538978440769, 11718.472668729757], "value": 9987.16814974036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.9845501544985, 1596.608830836445, 1815.6731788278114, 1873.6627407066724, 1927.1905799564172, 8317.12670169631, 8583.613737381816, 8941.329400294979, 9343.439393636387, 9481.241500679938, 8855.291576673866, 9219.0, 9231.446113233194, 9255.074492550742, 9374.625014999392, 2368.9289321320343, 2406.9037238510437, 2417.697787776528, 2425.38152771044, 2436.2204094689705, 2387.5821731197057, 2405.4707964247837, 2413.3122060212845, 2421.9394515137174, 2426.5510880487077, 1941.6602094633454, 2069.2343832781817, 2272.7045484087043, 2439.4755127647554, 2441.340837973746, 2088.467440802601, 2338.240071976614, 2399.3161948844495, 2400.9159679411136, 2420.0, 2394.174009966559, 2408.903643854261, 2410.337157281744, 2417.7944874685672, 2420.576399130145, 9123.133302336268, 9149.588268527932, 9231.0, 9275.489848058354, 9308.534573271378, 5541.418151094117, 5581.944180558224, 5630.915536266959, 5665.886682266331, 5728.656280623176, 3136.294333774905, 3600.1539638185004, 3648.762830416041, 3699.1676872703697, 3718.2563487302646, 1123.5449642894641, 1124.1568823382463, 1129.2151954391702, 1131.9717007074807, 1136.7840110379002, 12304.876951230463, 12425.130240883142, 12457.813132803016, 12508.0, 12515.624531263986, 4844.709317440965, 4922.212446008693, 4932.112219800399, 5027.949720502821, 5034.647574669812, 10581.947090264654, 10632.149428045737, 10695.465226738632, 10741.409222492837, 10743.194260430499, 5541.168824676331, 5541.307336582927, 5551.528120109755, 5621.409751976065, 5664.745086471119, 4600.332951722048, 4619.076184763061, 5040.218766091261, 5112.897742045213, 5125.15434953236, 3443.4318337474538, 4161.271777438936, 4247.830086796494, 4299.914001719948, 4306.784660766949, 1301.1087405127519, 1303.452549929032, 1325.6553296143072, 1341.8121462995189, 1353.1813252981804, 820.9876851847227, 912.748994026648, 924.1128516624116, 927.534495497113, 928.3826255540125, 5771.30744310677, 5865.090910908816, 5889.528837692974, 6031.517478601701, 6109.541784366102, 390.78897395406733, 458.3468557305826, 467.1777671298539, 471.09314569454347, 473.94075740532435, 3944.9211015779524, 3951.328274193394, 3965.722399432012, 3976.065624578222, 4056.8782936511952, 10905.563777448813, 11167.441627918572, 11370.545178192946, 11378.374189419495, 11441.656750297505, 9530.0, 11346.432678366215, 11350.3757293348, 11354.602588909349, 11369.772604547863, 8162.306203972729, 8441.620127094418, 8599.183077607742, 8609.827803443895, 8637.136286371438, 6002.399760023963, 6003.759849606142, 6037.818865434044, 6066.696665166813, 6094.329623741473, 10232.130268926927, 10329.690109296733, 10331.225158113322, 10461.843072353768, 10579.047885690325, 10174.389536627827, 10233.74415639615, 10425.322354046963, 10603.310784798963, 10769.0, 7108.964455177691, 7342.008828808042, 7679.808004799701, 7785.844283114419, 7796.610169491616, 6954.339337763106, 8605.612747426507, 8800.635901435287, 8903.910960890567, 8920.821583568422, 7830.843383132419, 7975.601219939096, 7975.960120199362, 8036.919630803617, 8152.103268640563, 7845.176256492986, 7907.051153861574, 7938.682452701827, 7939.444238903221, 7970.043594768665, 7250.673719682522, 7264.963675181802, 7299.270072992658, 7312.853742925218, 7368.300011498899, 4948.802047918043, 5040.117979353672, 5116.437191908813, 5151.1243088675765, 5196.2465442509865, 4745.2882067690125, 4806.735629540409, 5065.417476990193, 5092.898142037213, 5151.6393852431465], "value": 4648.750400049542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.462366128018, 296.39091666625075, 307.22425874666453, 309.5047923322683, 311.59492659542605, 4761.50004249554, 5327.813526526573, 5360.195970604412, 5540.3628582713, 5613.747381367838, 5391.32608423947, 5529.585281103913, 5533.861653458665, 5535.142052981794, 5616.269884914956, 3489.092835862681, 4221.831126754926, 4232.746035237888, 4242.236397448458, 4252.000779816741, 4101.589841015904, 4232.259354612946, 4237.453329534728, 4248.936265956013, 4251.638610718092, 4184.205001049806, 4188.329867221245, 4194.433751443562, 4198.244316023115, 4222.894427639319, 4152.294110001292, 4187.853425130106, 4200.243956087903, 4201.495820501529, 4230.830766769325, 3657.9817100914593, 3665.486831843544, 3668.192997540537, 3676.8529258829612, 3679.3193259247123, 5065.645404821664, 5380.0, 5429.0, 5454.236406903036, 5458.61789674723, 4799.424069111694, 4800.135975524404, 4808.134535783557, 4809.014152098812, 4811.59101476375, 5250.737463126867, 5689.715514224272, 5886.529077673818, 5931.762729490858, 5948.553858460633, 3619.366610843092, 3689.8708545201057, 3937.015746063484, 3946.8223929922933, 3961.445397644332, 5443.822471011627, 6172.7530898764, 6228.252609686821, 6275.780347687854, 6287.748490060392, 3859.221360620349, 3985.5217373914734, 4001.919961600752, 4013.69897257701, 4014.3541148129125, 3447.6554143883905, 3930.253251882133, 4052.675785937118, 4057.26134858969, 4071.572484889103, 3782.735208535431, 4197.727147735387, 4703.471371804178, 4725.8345957892, 4806.029527893547, 5223.216517522402, 5375.354957405137, 5854.297484301911, 5885.734567068101, 6062.666553339609, 1218.6039537150461, 1350.7568637645122, 1354.4785257675865, 1374.9893828036386, 1384.2663388404162, 808.454293351985, 834.1783343406739, 888.9155530224618, 891.9063498332712, 893.7532142660951, 5597.440255974451, 5612.550995920316, 5626.774929002876, 5628.746706398222, 5676.176954341598, 5615.4946054854445, 5861.443162899518, 5948.018576934844, 6068.6358818471035, 6118.877622447526, 5315.229291752674, 5578.41426650204, 5594.748236329375, 5634.85912852182, 5659.6321239119325, 2298.2990187992486, 2327.418145463634, 2338.8596684199, 2441.914532991372, 2662.9600555991674, 4619.745913974763, 4976.328195693607, 5051.9390927904815, 5277.358622550428, 5334.093204155225, 4767.547083027107, 4892.535209155125, 5003.699778013331, 5085.74571271435, 5135.922961155511, 4330.783460826883, 4693.22561777303, 4994.875128121826, 5325.0, 5341.465853414627, 4949.529794669645, 5005.699658020385, 5043.343575907437, 5100.781160195327, 5122.231665250242, 3985.4456761862316, 4908.656394052525, 4924.532169443897, 4927.201571426475, 4960.206366981266, 4346.782660866881, 4524.276115821453, 5031.446540880574, 5221.381371774762, 5281.445448227881, 2879.308965848223, 3116.0, 3340.799552026789, 3491.476278558135, 3496.877609283663, 4750.263709125091, 4824.589909857701, 4922.926156107733, 4964.578010869117, 5071.77177027042, 4119.608637179464, 4380.890477738082, 4602.895305126813, 4735.976320118515, 4909.26361045846, 4805.924208506489, 4822.577339684732, 4835.226363781778, 4918.0, 4942.332785073969, 4763.73799441034, 4777.808887644455, 4828.975855120842, 5108.29648504831, 5111.7731744380335, 5987.790427335197, 5993.550483713651, 6014.969925150346, 6026.879462410815, 6049.758009679564, 5428.430014848384, 5832.745959618703, 5900.0, 5912.497437717842, 5912.822615321547], "value": 4028.279966881946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.3093983366215, 761.375671949002, 768.4275214964852, 799.8760192170212, 829.2039641943735, 15189.0, 16352.509424717247, 16484.093374864377, 16494.83505164948, 16508.422205222818, 14811.703765924674, 14881.404743810263, 14892.478763243289, 14897.255137243148, 14930.701385972301, 716.8207948012997, 734.3537686835604, 870.2820173356974, 881.6825942660637, 893.1515060692336, 875.1205038935892, 878.714417814213, 879.846026945282, 882.7219425880859, 886.3396769406801, 861.6036623153326, 885.9645614175425, 916.2395211974045, 917.1058218237232, 919.3380765848611, 854.3976496569903, 876.0626130040858, 903.2818908967387, 906.7370462565848, 910.7358865928873, 645.7739791073087, 668.6623255256113, 689.3451221339748, 690.2855544511457, 692.2489099327236, 11058.281211721292, 12068.698282543006, 14856.18290993995, 14870.628234294121, 14940.925295373563, 13565.98255130869, 13764.793528097087, 15164.469243576532, 15241.466548670744, 15470.767938480933, 11854.644360669194, 12158.5744498943, 12193.695157621041, 12201.93899030508, 12584.874151258462, 3279.6064472263242, 3360.781549199294, 3739.4951681522916, 3894.1432884765304, 3921.372580387153, 104133.0, 105723.88552228989, 106412.0, 107284.0, 107395.46302268517, 10962.780744385067, 11695.239809412362, 11722.648320550397, 11750.177487575787, 11969.22313229089, 23788.0, 23851.0, 24259.636105458434, 24328.75671243265, 24634.384140396633, 8253.13342099083, 8295.419320647617, 8297.875531867026, 8372.288355489729, 8458.534780587126, 3764.4729737836724, 4282.0, 4432.867013989586, 4523.457185137739, 4745.477997420281, 3677.852885884588, 3755.6244375562223, 3786.6970642348547, 3809.447630093621, 3824.8852534424013, 663.7942237906265, 666.9366410191024, 677.2753154125137, 684.7979845945458, 688.7658196213212, 566.7562947932346, 569.7236840132532, 633.832034510855, 661.381608196338, 703.5110598134247, 9316.20812230968, 9462.337636365388, 9526.333156678966, 9676.70969870905, 9784.706458806248, 549.6674511920231, 619.575590720358, 623.6756886419037, 666.540087339734, 692.9064576282238, 4456.977715111469, 4645.674802763841, 4663.347131401607, 4710.128626204163, 4731.574158325699, 87496.6875496868, 126202.3689881563, 133279.0, 145632.0, 165347.0, 123177.38411307886, 128351.35824320819, 129120.0, 129206.0, 130202.34898825445, 79517.0, 92752.0724792757, 100984.0, 113653.86346136598, 122753.38623307005, 9512.1439070484, 9758.902410976083, 9998.100170984646, 10036.733145674802, 10084.949575252076, 45470.0, 58987.41012589819, 62553.68723156355, 62644.686776565824, 63064.0, 80106.0, 87602.56198718966, 89610.55194724245, 91854.622180666, 91967.0, 13166.0, 13203.537876174672, 13545.458181672622, 13549.59351219465, 13809.585712428643, 12015.879841201477, 14040.666136717404, 14445.638859028608, 14775.482858099915, 14896.478623248135, 10159.0, 13022.674433139247, 13383.598492045254, 13548.79676804829, 14416.279186040865, 12790.68023299425, 14418.495352662607, 14943.178125203218, 15300.234988250766, 15745.291461884013, 13868.86131138716, 14990.400383984519, 15043.398264069752, 15431.922840385727, 15692.215389230265, 10350.585976560853, 10955.17836162307, 11176.0, 11339.149563782585, 11669.599266437082, 8942.68700595502, 10271.589136434459, 10886.23796334249, 11560.6531804046, 12886.355682216039], "value": 7868.1899194682555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 119.0, 116.0, 117.0, 118.0, 118.0, 117.0, 141.0, 172.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 114.0, 177.0, 143.0, 144.0, 113.0, 139.0, 175.0, 112.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 198.0, 195.0, 196.0, 195.0, 194.0, 221.0, 276.0, 242.0, 193.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 65.0, 84.0, 78.0, 83.0, 83.0, 85.0, 83.0, 75.0, 58.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 87.0, 69.0, 69.0, 70.0, 86.0, 69.0, 82.0, 101.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 129.0, 88.0, 85.0, 89.0, 85.0, 88.0, 87.0, 126.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 94.0, 115.0, 126.0, 94.0, 96.0, 95.0, 95.0, 94.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 94.0, 90.0, 91.0, 131.0, 145.0, 91.0, 87.0, 90.0], "value": 100.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 57.0, 63.0, 78.0, 78.0, 56.0, 56.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 71.0, 81.0, 71.0, 69.0, 72.0, 68.0, 68.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 85.0, 85.0, 88.0, 79.0, 84.0, 87.0, 87.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 155.0, 138.0, 150.0, 152.0, 155.0, 140.0, 195.0, 160.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 161.0, 172.0, 226.0, 193.0, 163.0, 162.0, 162.0, 161.0, 160.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 63.0, 76.0, 86.0, 73.0, 57.0, 81.0], "value": 70.0, "unit": "score"}]}]} 10:17:48 INFO - Return code: 0 10:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:48 ERROR - # TBPL SUCCESS # 10:17:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:49 INFO - 2017-01-06 10:17:49.012 screenresolution[1648:10443] starting screenresolution argv=screenresolution get 10:17:49 INFO - 2017-01-06 10:17:49.015 screenresolution[1648:10443] Display 0: 1600x1200x32@60 10:17:49 INFO - 2017-01-06 10:17:49.021 screenresolution[1649:10446] starting screenresolution argv=screenresolution list 10:17:49 INFO - Available Modes on Display 0 10:17:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:49 INFO - Intel Iris: 10:17:49 INFO - Chipset Model: Intel Iris 10:17:49 INFO - Type: GPU 10:17:49 INFO - Bus: Built-In 10:17:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:49 INFO - Vendor: Intel (0x8086) 10:17:49 INFO - Device ID: 0x0a2e 10:17:49 INFO - Revision ID: 0x0009 10:17:49 INFO - Displays: 10:17:49 INFO - Display: 10:17:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:49 INFO - Display Serial Number: 1600x1200 60 10:17:49 INFO - Main Display: Yes 10:17:49 INFO - Mirror: Off 10:17:49 INFO - Online: Yes 10:17:49 INFO - Rotation: Supported 10:17:49 INFO - Return code: 0 10:17:49 INFO - Running post-action listener: _resource_record_post_action 10:17:49 INFO - [mozharness: 2017-01-06 18:17:49.265943Z] Finished run-tests step (success) 10:17:49 INFO - Running post-run listener: _resource_record_post_run 10:17:49 INFO - Total resource usage - Wall time: 1194s; CPU: 55.0%; Read bytes: 33405952; Write bytes: 496524288; Read time: 316; Write time: 2099 10:17:49 INFO - TinderboxPrint: CPU usage
54.7% 10:17:49 INFO - TinderboxPrint: I/O read bytes / time
33,405,952 / 316 10:17:49 INFO - TinderboxPrint: I/O write bytes / time
496,524,288 / 2,099 10:17:49 INFO - TinderboxPrint: CPU idle
2,165.3 (45.3%) 10:17:49 INFO - TinderboxPrint: CPU system
972.5 (20.4%) 10:17:49 INFO - TinderboxPrint: CPU user
1,639.9 (34.3%) 10:17:49 INFO - TinderboxPrint: Swap in / out
224,665,600 / 0 10:17:49 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192741888; Write bytes: 186130432; Read time: 17977; Write time: 336 10:17:49 INFO - run-tests - Wall time: 1172s; CPU: 55.0%; Read bytes: 31333376; Write bytes: 299146240; Read time: 290; Write time: 1723 10:17:49 INFO - Running post-run listener: _upload_blobber_files 10:17:49 INFO - Blob upload gear active. 10:17:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:17:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:51 INFO - (blobuploader) - INFO - Done attempting. 10:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:52 INFO - (blobuploader) - INFO - Done attempting. 10:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:55 INFO - (blobuploader) - INFO - Done attempting. 10:17:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:55 INFO - Return code: 0 10:17:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2573745f647da376e4d84582916c429f468229cd846e0afd58f168377cafaab7abe8998efff9444f8f6e89d10e66427e80929d3d7c69aaf8b213cabef18fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adf3009e899ae7c519b90f53b1c1b9aa716ea557d2cc1241d5bff65f69ce45c16e5f209a4b66d41c5046ce2853a6b760417a580ed8c9e468f8860b1de7125397", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6fbd9d633d382948e31830ce0be74c29e74cd1e53f74dcebd4aaaaebff2c19f6cd1406276c70e76be2fe96d432ddb0f997f92924058ed3152dc027e916757e"} 10:17:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:55 INFO - Contents: 10:17:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2573745f647da376e4d84582916c429f468229cd846e0afd58f168377cafaab7abe8998efff9444f8f6e89d10e66427e80929d3d7c69aaf8b213cabef18fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adf3009e899ae7c519b90f53b1c1b9aa716ea557d2cc1241d5bff65f69ce45c16e5f209a4b66d41c5046ce2853a6b760417a580ed8c9e468f8860b1de7125397", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6fbd9d633d382948e31830ce0be74c29e74cd1e53f74dcebd4aaaaebff2c19f6cd1406276c70e76be2fe96d432ddb0f997f92924058ed3152dc027e916757e"} 10:17:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:55 INFO - Copying logs to upload dir... 10:17:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.875605 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-06 10:17:55.256251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 10:17:55.259944) ========= 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.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2573745f647da376e4d84582916c429f468229cd846e0afd58f168377cafaab7abe8998efff9444f8f6e89d10e66427e80929d3d7c69aaf8b213cabef18fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adf3009e899ae7c519b90f53b1c1b9aa716ea557d2cc1241d5bff65f69ce45c16e5f209a4b66d41c5046ce2853a6b760417a580ed8c9e468f8860b1de7125397", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6fbd9d633d382948e31830ce0be74c29e74cd1e53f74dcebd4aaaaebff2c19f6cd1406276c70e76be2fe96d432ddb0f997f92924058ed3152dc027e916757e"} build_url:https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/GtkMPsTGRMKgsih1LV89fw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2573745f647da376e4d84582916c429f468229cd846e0afd58f168377cafaab7abe8998efff9444f8f6e89d10e66427e80929d3d7c69aaf8b213cabef18fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adf3009e899ae7c519b90f53b1c1b9aa716ea557d2cc1241d5bff65f69ce45c16e5f209a4b66d41c5046ce2853a6b760417a580ed8c9e468f8860b1de7125397", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6fbd9d633d382948e31830ce0be74c29e74cd1e53f74dcebd4aaaaebff2c19f6cd1406276c70e76be2fe96d432ddb0f997f92924058ed3152dc027e916757e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 10:17:55.294964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 10:17:55.295314) ========= 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.NorsrSyitQ/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.f1sBpovloW/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005269 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 10:17:55.344489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 10:17:55.344886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 10:17:55.345210) ========= ========= Total master_lag: 0.18 =========