builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0160 starttime: 1476608400.94 results: success (0) buildid: 20161016004034 builduid: 379722e4d4cf460cab1dcee7798e1189 revision: df83c59042d9b82f1d27b4afb9066744da22cd98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:00.941413) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:00.941907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:00.942217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:00.965941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:00.966389) ========= 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.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-16 02:00:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.60M=0.002s 2016-10-16 02:00:01 (7.60 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:01.108963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:01.109290) ========= 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.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.020129 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:01.182582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 02:00:01.182996) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev df83c59042d9b82f1d27b4afb9066744da22cd98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev df83c59042d9b82f1d27b4afb9066744da22cd98 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-16 02:00:01,257 truncating revision to first 12 chars 2016-10-16 02:00:01,257 Setting DEBUG logging. 2016-10-16 02:00:01,257 attempt 1/10 2016-10-16 02:00:01,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/df83c59042d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 02:00:02,658 unpacking tar archive at: mozilla-aurora-df83c59042d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677512 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 02:00:02.887752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.888320) ========= script_repo_revision: df83c59042d9b82f1d27b4afb9066744da22cd98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.888938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.892568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.915660) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-16 02:00:02.916146) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:03 INFO - MultiFileLogger online at 20161016 02:00:03 in /builds/slave/test 02:00:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:00:03 INFO - {'append_to_log': False, 02:00:03 INFO - 'base_work_dir': '/builds/slave/test', 02:00:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:00:03 INFO - 'branch': 'Mozilla-Aurora', 02:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 02:00:03 INFO - 'config_files': ('talos/mac_config.py',), 02:00:03 INFO - 'default_actions': ('clobber', 02:00:03 INFO - 'read-buildbot-config', 02:00:03 INFO - 'download-and-extract', 02:00:03 INFO - 'populate-webroot', 02:00:03 INFO - 'create-virtualenv', 02:00:03 INFO - 'install', 02:00:03 INFO - 'run-tests'), 02:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:00:03 INFO - 'download_minidump_stackwalk': True, 02:00:03 INFO - 'download_symbols': 'ondemand', 02:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 02:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 02:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:00:03 INFO - 'installer_path': 'installer.exe', 02:00:03 INFO - 'log_level': 'info', 02:00:03 INFO - 'log_name': 'talos', 02:00:03 INFO - 'log_to_console': True, 02:00:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:00:03 INFO - 'opt_config_files': (), 02:00:03 INFO - 'pip_index': False, 02:00:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:00:03 INFO - 'cmd': ('bash', 02:00:03 INFO - '-c', 02:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:00:03 INFO - 'enabled': True, 02:00:03 INFO - 'halt_on_failure': False, 02:00:03 INFO - 'name': 'check_screen_resolution'},), 02:00:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:00:03 INFO - 'cmd': ('bash', 02:00:03 INFO - '-c', 02:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:00:03 INFO - 'enabled': True, 02:00:03 INFO - 'halt_on_failure': False, 02:00:03 INFO - 'name': 'check_screen_resolution'},), 02:00:03 INFO - 'run_cmd_checks_enabled': True, 02:00:03 INFO - 'sps_profile': False, 02:00:03 INFO - 'sps_profile_interval': 0, 02:00:03 INFO - 'suite': 'dromaeojs-e10s', 02:00:03 INFO - 'system_bits': '32', 02:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:03 INFO - 'title': 't-yosemite-r7-0160', 02:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:00:03 INFO - 'use_talos_json': True, 02:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:00:03 INFO - 'work_dir': 'build'} 02:00:03 INFO - [mozharness: 2016-10-16 09:00:03.114847Z] Running clobber step. 02:00:03 INFO - Running pre-action listener: _resource_record_pre_action 02:00:03 INFO - Running main action method: clobber 02:00:03 INFO - rmtree: /builds/slave/test/build 02:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:00:04 INFO - Running post-action listener: _resource_record_post_action 02:00:04 INFO - [mozharness: 2016-10-16 09:00:04.045403Z] Finished clobber step (success) 02:00:04 INFO - [mozharness: 2016-10-16 09:00:04.045574Z] Running read-buildbot-config step. 02:00:04 INFO - Running pre-action listener: _resource_record_pre_action 02:00:04 INFO - Running main action method: read_buildbot_config 02:00:04 INFO - Using buildbot properties: 02:00:04 INFO - { 02:00:04 INFO - "project": "", 02:00:04 INFO - "product": "firefox", 02:00:04 INFO - "script_repo_revision": "production", 02:00:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:00:04 INFO - "repository": "", 02:00:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:00:04 INFO - "buildid": "20161016004034", 02:00:04 INFO - "stage_platform": "macosx64", 02:00:04 INFO - "basedir": "/builds/slave/test", 02:00:04 INFO - "nightly_build": "True", 02:00:04 INFO - "buildnumber": 425, 02:00:04 INFO - "slavename": "t-yosemite-r7-0160", 02:00:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:00:04 INFO - "platform": "yosemite_r7", 02:00:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:00:04 INFO - "branch": "mozilla-aurora", 02:00:04 INFO - "repo_path": "releases/mozilla-aurora", 02:00:04 INFO - "revision": "df83c59042d9b82f1d27b4afb9066744da22cd98", 02:00:04 INFO - "pgo_build": "False", 02:00:04 INFO - "builduid": "379722e4d4cf460cab1dcee7798e1189", 02:00:04 INFO - "slavebuilddir": "test" 02:00:04 INFO - } 02:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:00:04 INFO - Running post-action listener: _resource_record_post_action 02:00:04 INFO - [mozharness: 2016-10-16 09:00:04.049246Z] Finished read-buildbot-config step (success) 02:00:04 INFO - [mozharness: 2016-10-16 09:00:04.049363Z] Running download-and-extract step. 02:00:04 INFO - Running pre-action listener: _resource_record_pre_action 02:00:04 INFO - Running main action method: download_and_extract 02:00:04 INFO - mkdir: /builds/slave/test/build/tests 02:00:04 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')]} 02:00:04 INFO - trying https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:00:05 INFO - Downloaded 1199 bytes. 02:00:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:00:05 INFO - Using the following test package requirements: 02:00:05 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:00:05 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:00:05 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:00:05 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'jsshell-mac.zip'], 02:00:05 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:00:05 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:00:05 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:00:05 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:00:05 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:00:05 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:05 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:00:05 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:00:06 INFO - Expected file size: 16435251 02:00:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:00:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:00:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:00:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:00:13 INFO - Expected file size: 16435251 02:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:00:21 INFO - Expected file size: 14414081 02:00:21 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')]} 02:00:21 INFO - trying https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:00:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:00:25 INFO - Downloaded 115573009 bytes. 02:00:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:00:25 INFO - mkdir: /builds/slave/test/properties 02:00:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:25 INFO - Contents: 02:00:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:00:25 INFO - Running post-action listener: _resource_record_post_action 02:00:25 INFO - Running post-action listener: set_extra_try_arguments 02:00:25 INFO - [mozharness: 2016-10-16 09:00:25.764289Z] Finished download-and-extract step (success) 02:00:25 INFO - [mozharness: 2016-10-16 09:00:25.764390Z] Running populate-webroot step. 02:00:25 INFO - Running pre-action listener: _resource_record_pre_action 02:00:25 INFO - Running main action method: populate_webroot 02:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:25 INFO - '--tppagecycles', 02:00:25 INFO - '7'], 02:00:25 INFO - 'tests': ['tsvgm']}}, 02:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['damp', 'tps']}, 02:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'tests': ['damp', 'tps']}, 02:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['dromaeo_dom']}, 02:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['basic_compositor_video']}, 02:00:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['a11yr', 02:00:25 INFO - 'ts_paint', 02:00:25 INFO - 'tpaint', 02:00:25 INFO - 'sessionrestore', 02:00:25 INFO - 'sessionrestore_no_auto_restore', 02:00:25 INFO - 'tabpaint']}, 02:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['tsvgx', 02:00:25 INFO - 'tsvgr_opacity', 02:00:25 INFO - 'tart', 02:00:25 INFO - 'tscrollx', 02:00:25 INFO - 'cart']}, 02:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:25 INFO - 'tsvgr_opacity', 02:00:25 INFO - 'tart', 02:00:25 INFO - 'tscrollx', 02:00:25 INFO - 'cart']}, 02:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'talos_options': ['--disable-e10s'], 02:00:25 INFO - 'tests': ['tp5o']}, 02:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'tests': ['tp5o']}, 02:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'talos_options': ['--disable-e10s', 02:00:25 INFO - '--xperf_path', 02:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:25 INFO - 'tests': ['tp5n']}, 02:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:25 INFO - 'talos_options': ['--xperf_path', 02:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:25 INFO - 'tests': ['tp5n']}}, 02:00:25 INFO - 'talos.zip': {'path': '', 02:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:25 INFO - Running post-action listener: _resource_record_post_action 02:00:25 INFO - [mozharness: 2016-10-16 09:00:25.783208Z] Finished populate-webroot step (success) 02:00:25 INFO - [mozharness: 2016-10-16 09:00:25.783343Z] Running create-virtualenv step. 02:00:25 INFO - Running pre-action listener: _resource_record_pre_action 02:00:25 INFO - Running main action method: create_virtualenv 02:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:25 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 02:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:25 INFO - Using real prefix '/tools/python27' 02:00:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:29 INFO - Installing pip.................done. 02:00:29 INFO - Return code: 0 02:00:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:29 INFO - 'HOME': '/Users/cltbld', 02:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:29 INFO - 'LOGNAME': 'cltbld', 02:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:29 INFO - 'MOZ_NO_REMOTE': '1', 02:00:29 INFO - 'NO_EM_RESTART': '1', 02:00:29 INFO - 'PAGER': '/bin/cat', 02:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:29 INFO - 'PWD': '/builds/slave/test', 02:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:29 INFO - 'SHELL': '/bin/bash', 02:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:29 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:29 INFO - 'USER': 'cltbld', 02:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:29 INFO - 'XPC_FLAGS': '0x0', 02:00:29 INFO - 'XPC_SERVICE_NAME': '0', 02:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:29 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 02:00:29 INFO - Cleaning up... 02:00:29 INFO - Return code: 0 02:00:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:29 INFO - 'HOME': '/Users/cltbld', 02:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:29 INFO - 'LOGNAME': 'cltbld', 02:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:29 INFO - 'MOZ_NO_REMOTE': '1', 02:00:29 INFO - 'NO_EM_RESTART': '1', 02:00:29 INFO - 'PAGER': '/bin/cat', 02:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:29 INFO - 'PWD': '/builds/slave/test', 02:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:29 INFO - 'SHELL': '/bin/bash', 02:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:29 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:29 INFO - 'USER': 'cltbld', 02:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:29 INFO - 'XPC_FLAGS': '0x0', 02:00:29 INFO - 'XPC_SERVICE_NAME': '0', 02:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:29 INFO - Downloading/unpacking psutil>=3.1.1 02:00:29 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 02:00:29 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 02:00:29 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 02:00:29 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 02:00:29 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 02:00:29 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 02:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:33 INFO - Installing collected packages: psutil 02:00:33 INFO - Running setup.py install for psutil 02:00:33 INFO - building 'psutil._psutil_osx' extension 02:00:33 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 02:00:33 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 02:00:33 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 02:00:33 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 02:00:33 INFO - building 'psutil._psutil_posix' extension 02:00:33 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 02:00:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:00:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:00:33 INFO - ^ 02:00:33 INFO - 1 warning generated. 02:00:33 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 02:00:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:33 INFO - Successfully installed psutil 02:00:33 INFO - Cleaning up... 02:00:33 INFO - Return code: 0 02:00:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:33 INFO - 'HOME': '/Users/cltbld', 02:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:33 INFO - 'LOGNAME': 'cltbld', 02:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:33 INFO - 'MOZ_NO_REMOTE': '1', 02:00:33 INFO - 'NO_EM_RESTART': '1', 02:00:33 INFO - 'PAGER': '/bin/cat', 02:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:33 INFO - 'PWD': '/builds/slave/test', 02:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:33 INFO - 'SHELL': '/bin/bash', 02:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:33 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:33 INFO - 'USER': 'cltbld', 02:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:33 INFO - 'XPC_FLAGS': '0x0', 02:00:33 INFO - 'XPC_SERVICE_NAME': '0', 02:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:00:36 INFO - Installing collected packages: mozsystemmonitor 02:00:36 INFO - Running setup.py install for mozsystemmonitor 02:00:36 INFO - Successfully installed mozsystemmonitor 02:00:36 INFO - Cleaning up... 02:00:37 INFO - Return code: 0 02:00:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:37 INFO - 'HOME': '/Users/cltbld', 02:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:37 INFO - 'LOGNAME': 'cltbld', 02:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:37 INFO - 'MOZ_NO_REMOTE': '1', 02:00:37 INFO - 'NO_EM_RESTART': '1', 02:00:37 INFO - 'PAGER': '/bin/cat', 02:00:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:37 INFO - 'PWD': '/builds/slave/test', 02:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:37 INFO - 'SHELL': '/bin/bash', 02:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:37 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:37 INFO - 'USER': 'cltbld', 02:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:37 INFO - 'XPC_FLAGS': '0x0', 02:00:37 INFO - 'XPC_SERVICE_NAME': '0', 02:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:00:39 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 02:00:39 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 02:00:39 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 02:00:39 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 02:00:39 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 02:00:39 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 02:00:40 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:40 INFO - warning: no files found matching '*.txt' 02:00:40 INFO - no previously-included directories found matching 'build' 02:00:40 INFO - no previously-included directories found matching 'dist' 02:00:40 INFO - no previously-included directories found matching '.git*' 02:00:40 INFO - Installing collected packages: jsonschema, functools32 02:00:40 INFO - Running setup.py install for functools32 02:00:40 INFO - warning: no files found matching '*.txt' 02:00:40 INFO - no previously-included directories found matching 'build' 02:00:40 INFO - no previously-included directories found matching 'dist' 02:00:40 INFO - no previously-included directories found matching '.git*' 02:00:40 INFO - Successfully installed jsonschema functools32 02:00:40 INFO - Cleaning up... 02:00:40 INFO - Return code: 0 02:00:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:00:40 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')]} 02:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:40 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')]} 02:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:40 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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:40 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 02:00:40 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 02:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:40 INFO - 'HOME': '/Users/cltbld', 02:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:40 INFO - 'LOGNAME': 'cltbld', 02:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:40 INFO - 'MOZ_NO_REMOTE': '1', 02:00:40 INFO - 'NO_EM_RESTART': '1', 02:00:40 INFO - 'PAGER': '/bin/cat', 02:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:40 INFO - 'PWD': '/builds/slave/test', 02:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:40 INFO - 'SHELL': '/bin/bash', 02:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:40 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:40 INFO - 'USER': 'cltbld', 02:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:40 INFO - 'XPC_FLAGS': '0x0', 02:00:40 INFO - 'XPC_SERVICE_NAME': '0', 02:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:00:40 INFO - Cleaning up... 02:00:40 INFO - Return code: 0 02:00:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00:40 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')]} 02:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:40 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')]} 02:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:40 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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:40 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 02:00:40 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 02:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:40 INFO - 'HOME': '/Users/cltbld', 02:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:40 INFO - 'LOGNAME': 'cltbld', 02:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:40 INFO - 'MOZ_NO_REMOTE': '1', 02:00:40 INFO - 'NO_EM_RESTART': '1', 02:00:40 INFO - 'PAGER': '/bin/cat', 02:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:40 INFO - 'PWD': '/builds/slave/test', 02:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:40 INFO - 'SHELL': '/bin/bash', 02:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:40 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:40 INFO - 'USER': 'cltbld', 02:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:40 INFO - 'XPC_FLAGS': '0x0', 02:00:40 INFO - 'XPC_SERVICE_NAME': '0', 02:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:44 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 02:00:44 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 02:00:44 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 02:00:44 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 02:00:44 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 02:00:44 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 02:00:44 INFO - Downloading docopt-0.6.1.tar.gz 02:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:44 INFO - Running setup.py install for blobuploader 02:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:45 INFO - Running setup.py install for requests 02:00:45 INFO - Running setup.py install for docopt 02:00:45 INFO - Successfully installed blobuploader requests docopt 02:00:45 INFO - Cleaning up... 02:00:45 INFO - Return code: 0 02:00:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:45 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 02:00:45 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 02:00:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:45 INFO - 'HOME': '/Users/cltbld', 02:00:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:45 INFO - 'LOGNAME': 'cltbld', 02:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:45 INFO - 'MOZ_NO_REMOTE': '1', 02:00:45 INFO - 'NO_EM_RESTART': '1', 02:00:45 INFO - 'PAGER': '/bin/cat', 02:00:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:45 INFO - 'PWD': '/builds/slave/test', 02:00:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:45 INFO - 'SHELL': '/bin/bash', 02:00:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:45 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:45 INFO - 'USER': 'cltbld', 02:00:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:45 INFO - 'XPC_FLAGS': '0x0', 02:00:45 INFO - 'XPC_SERVICE_NAME': '0', 02:00:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-aDOX4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-eh5eM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-iiZHGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-zTJXpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-k9Drfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-9_QY_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-GZ3EfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-h6gwQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:46 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ynzQqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-KA3u7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-bFOUle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-RhV_Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-M08cXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-24r1fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MNI6PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1zFx9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:47 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-bRPD9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:47 INFO - Running setup.py install for manifestparser 02:00:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:48 INFO - Running setup.py install for mozcrash 02:00:48 INFO - Running setup.py install for mozdebug 02:00:48 INFO - Running setup.py install for mozdevice 02:00:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:00:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:48 INFO - Running setup.py install for mozfile 02:00:48 INFO - Running setup.py install for mozhttpd 02:00:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:48 INFO - Running setup.py install for mozinfo 02:00:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:48 INFO - Running setup.py install for mozInstall 02:00:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Running setup.py install for mozleak 02:00:49 INFO - Running setup.py install for mozlog 02:00:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Running setup.py install for moznetwork 02:00:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Running setup.py install for mozprocess 02:00:49 INFO - Running setup.py install for mozprofile 02:00:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Running setup.py install for mozrunner 02:00:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Running setup.py install for mozscreenshot 02:00:50 INFO - Running setup.py install for moztest 02:00:50 INFO - Running setup.py install for mozversion 02:00:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:50 INFO - Cleaning up... 02:00:50 INFO - Return code: 0 02:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:50 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 02:00:50 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 02:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:50 INFO - 'HOME': '/Users/cltbld', 02:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:50 INFO - 'LOGNAME': 'cltbld', 02:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:50 INFO - 'MOZ_NO_REMOTE': '1', 02:00:50 INFO - 'NO_EM_RESTART': '1', 02:00:50 INFO - 'PAGER': '/bin/cat', 02:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:50 INFO - 'PWD': '/builds/slave/test', 02:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:50 INFO - 'SHELL': '/bin/bash', 02:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:50 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:50 INFO - 'USER': 'cltbld', 02:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:50 INFO - 'XPC_FLAGS': '0x0', 02:00:50 INFO - 'XPC_SERVICE_NAME': '0', 02:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:50 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XCNn3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:50 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)) 02:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:50 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2NDYl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:50 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)) 02:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:50 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-jbcdbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-SDqPSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-trNknr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-NkCiyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XyiDmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-CpGtYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-AHl6_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-wQ03XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-c2mfhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:51 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)) 02:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:51 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-u3LBKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:52 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)) 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-wstXP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:52 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)) 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-_kYdTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:52 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)) 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-EUJcb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:52 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)) 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Nl_ejh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:52 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)) 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-hd1LON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:52 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)) 02:00:52 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)) 02:00:52 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)) 02:00:52 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)) 02:00:52 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)) 02:00:52 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)) 02:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:55 INFO - Downloading blessings-1.6.tar.gz 02:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:55 INFO - Installing collected packages: blessings 02:00:55 INFO - Running setup.py install for blessings 02:00:55 INFO - Successfully installed blessings 02:00:55 INFO - Cleaning up... 02:00:55 INFO - Return code: 0 02:00:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:55 INFO - Reading from file tmpfile_stdout 02:00:55 INFO - Current package versions: 02:00:55 INFO - blessings == 1.6 02:00:55 INFO - blobuploader == 1.2.4 02:00:55 INFO - docopt == 0.6.1 02:00:55 INFO - functools32 == 3.2.3-2 02:00:55 INFO - jsonschema == 2.5.1 02:00:55 INFO - manifestparser == 1.1 02:00:55 INFO - mozInstall == 1.12 02:00:55 INFO - mozcrash == 0.17 02:00:55 INFO - mozdebug == 0.1 02:00:55 INFO - mozdevice == 0.48 02:00:55 INFO - mozfile == 1.2 02:00:55 INFO - mozhttpd == 0.7 02:00:55 INFO - mozinfo == 0.9 02:00:55 INFO - mozleak == 0.1 02:00:55 INFO - mozlog == 3.4 02:00:55 INFO - moznetwork == 0.27 02:00:55 INFO - mozprocess == 0.23 02:00:55 INFO - mozprofile == 0.28 02:00:55 INFO - mozrunner == 6.12 02:00:55 INFO - mozscreenshot == 0.1 02:00:55 INFO - mozsystemmonitor == 0.3 02:00:55 INFO - moztest == 0.7 02:00:55 INFO - mozversion == 1.4 02:00:55 INFO - psutil == 3.1.1 02:00:55 INFO - requests == 1.2.3 02:00:55 INFO - wsgiref == 0.1.2 02:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:55 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 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:55 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 02:00:55 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 02:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:55 INFO - 'HOME': '/Users/cltbld', 02:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:55 INFO - 'LOGNAME': 'cltbld', 02:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:55 INFO - 'MOZ_NO_REMOTE': '1', 02:00:55 INFO - 'NO_EM_RESTART': '1', 02:00:55 INFO - 'PAGER': '/bin/cat', 02:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:55 INFO - 'PWD': '/builds/slave/test', 02:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:55 INFO - 'SHELL': '/bin/bash', 02:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:55 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:55 INFO - 'USER': 'cltbld', 02:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:55 INFO - 'XPC_FLAGS': '0x0', 02:00:55 INFO - 'XPC_SERVICE_NAME': '0', 02:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 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)) 02:00:55 INFO - Cleaning up... 02:00:56 INFO - Return code: 0 02:00:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101eef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f62d7cbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, '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.WhAeKBZoxT/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.c9JhEkswKN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 02:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:56 INFO - 'HOME': '/Users/cltbld', 02:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:56 INFO - 'LOGNAME': 'cltbld', 02:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:56 INFO - 'MOZ_NO_REMOTE': '1', 02:00:56 INFO - 'NO_EM_RESTART': '1', 02:00:56 INFO - 'PAGER': '/bin/cat', 02:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:56 INFO - 'PWD': '/builds/slave/test', 02:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:56 INFO - 'SHELL': '/bin/bash', 02:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:00:56 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:56 INFO - 'USER': 'cltbld', 02:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:56 INFO - 'XPC_FLAGS': '0x0', 02:00:56 INFO - 'XPC_SERVICE_NAME': '0', 02:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:00:56 INFO - Cleaning up... 02:00:56 INFO - Return code: 0 02:00:56 INFO - Running post-action listener: _resource_record_post_action 02:00:56 INFO - Running post-action listener: _start_resource_monitoring 02:00:56 INFO - Starting resource monitoring. 02:00:56 INFO - [mozharness: 2016-10-16 09:00:56.302149Z] Finished create-virtualenv step (success) 02:00:56 INFO - [mozharness: 2016-10-16 09:00:56.303147Z] Running install step. 02:00:56 INFO - Running pre-action listener: _resource_record_pre_action 02:00:56 INFO - Running main action method: install 02:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:56 INFO - Reading from file tmpfile_stdout 02:00:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:00:56 INFO - Reading from file tmpfile_stdout 02:00:56 INFO - Output received: 02:00:56 INFO - Usage: mozinstall [options] installer 02:00:56 INFO - Options: 02:00:56 INFO - -h, --help show this help message and exit 02:00:56 INFO - -d DEST, --destination=DEST 02:00:56 INFO - Directory to install application into. [default: 02:00:56 INFO - "/builds/slave/test"] 02:00:56 INFO - --app=APP Application being installed. [default: firefox] 02:00:56 INFO - mkdir: /builds/slave/test/build/application 02:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:01:28 INFO - Reading from file tmpfile_stdout 02:01:28 INFO - Output received: 02:01:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:01:28 INFO - Running post-action listener: _resource_record_post_action 02:01:28 INFO - [mozharness: 2016-10-16 09:01:28.815979Z] Finished install step (success) 02:01:28 INFO - [mozharness: 2016-10-16 09:01:28.816182Z] Running run-tests step. 02:01:28 INFO - Running pre-action listener: _resource_record_pre_action 02:01:28 INFO - Running main action method: run_tests 02:01:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:01:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:01:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:01:28 INFO - 2016-10-16 02:01:28.831 screenresolution[1942:20675] starting screenresolution argv=screenresolution get 02:01:28 INFO - 2016-10-16 02:01:28.833 screenresolution[1942:20675] Display 0: 1600x1200x32@60 02:01:28 INFO - 2016-10-16 02:01:28.839 screenresolution[1943:20677] starting screenresolution argv=screenresolution list 02:01:28 INFO - Available Modes on Display 0 02:01:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:01:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:01:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:01:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:01:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:01:29 INFO - Intel Iris: 02:01:29 INFO - Chipset Model: Intel Iris 02:01:29 INFO - Type: GPU 02:01:29 INFO - Bus: Built-In 02:01:29 INFO - VRAM (Dynamic, Max): 1536 MB 02:01:29 INFO - Vendor: Intel (0x8086) 02:01:29 INFO - Device ID: 0x0a2e 02:01:29 INFO - Revision ID: 0x0009 02:01:29 INFO - Displays: 02:01:29 INFO - Display: 02:01:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:01:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:01:29 INFO - Display Serial Number: 1600x1200 60 02:01:29 INFO - Main Display: Yes 02:01:29 INFO - Mirror: Off 02:01:29 INFO - Online: Yes 02:01:29 INFO - Rotation: Supported 02:01:29 INFO - Return code: 0 02:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:29 INFO - Python 2.7.3 02:01:29 INFO - Return code: 0 02:01:29 INFO - grabbing minidump binary from tooltool 02:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:29 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 0x101d8dd30>, '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 0x101bf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d85b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:29 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 02:01:29 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 02:01:29 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 02:01:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:29 INFO - Return code: 0 02:01:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 02:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --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 02:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WhAeKBZoxT/Render', 02:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:29 INFO - 'HOME': '/Users/cltbld', 02:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:29 INFO - 'LOGNAME': 'cltbld', 02:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:29 INFO - 'MOZ_NO_REMOTE': '1', 02:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:29 INFO - 'NO_EM_RESTART': '1', 02:01:29 INFO - 'PAGER': '/bin/cat', 02:01:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:29 INFO - 'PWD': '/builds/slave/test', 02:01:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:29 INFO - 'SHELL': '/bin/bash', 02:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c9JhEkswKN/Listeners', 02:01:29 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 02:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:29 INFO - 'USER': 'cltbld', 02:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:29 INFO - 'XPC_FLAGS': '0x0', 02:01:29 INFO - 'XPC_SERVICE_NAME': '0', 02:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 02:01:29 INFO - mozversion application_buildid: 20161016004034 02:01:29 INFO - mozversion application_changeset: df83c59042d9b82f1d27b4afb9066744da22cd98 02:01:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:01:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:29 INFO - mozversion application_name: Firefox 02:01:29 INFO - mozversion application_remotingname: firefox-dev 02:01:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:29 INFO - mozversion application_vendor: Mozilla 02:01:29 INFO - mozversion application_version: 51.0a2 02:01:29 INFO - mozversion platform_buildid: 20161016004034 02:01:29 INFO - mozversion platform_changeset: df83c59042d9b82f1d27b4afb9066744da22cd98 02:01:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:29 INFO - mozversion platform_version: 51.0a2 02:01:29 INFO - using testdate: 1476608489 02:01:29 INFO - actual date: 1476608489 02:01:29 INFO - starting webserver on 'localhost:49441' 02:01:29 INFO - SUITE-START | Running 2 tests 02:01:29 INFO - TEST-START | dromaeo_css 02:01:29 INFO - operating with platform_type : mac_ 02:01:29 INFO - Initialising browser for dromaeo_css test... 02:01:29 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpEFQPPs/profile http://localhost:49441/getInfo.html) 02:01:32 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 02:01:32 INFO - PROCESS | 1953 | colorDepth:24 02:01:32 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 02:01:32 INFO - PROCESS | 1953 | __metrics 02:01:32 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:01:32 INFO - TEST-INFO | 1953: exit 0 02:01:32 INFO - Browser initialized. 02:01:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:32 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpEFQPPs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:44 INFO - PROCESS | 1957 | RSS: Main: 225067008 02:01:44 INFO - PROCESS | 1957 | 02:02:34 INFO - PROCESS | 1957 | 1476608554337 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] 02:04:46 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49441/tests/dromaeo/cssquery-ext.html) 02:04:47 INFO - PROCESS | 1957 | RSS: Main: 238551040 02:04:47 INFO - PROCESS | 1957 | 02:07:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-ext.html (next: http://localhost:49441/tests/dromaeo/cssquery-jquery.html) 02:07:50 INFO - PROCESS | 1957 | RSS: Main: 248090624 02:07:50 INFO - PROCESS | 1957 | 02:10:52 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49441/tests/dromaeo/cssquery-mootools.html) 02:10:53 INFO - PROCESS | 1957 | RSS: Main: 251285504 02:10:53 INFO - PROCESS | 1957 | 02:13:54 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49441/tests/dromaeo/cssquery-prototype.html) 02:13:55 INFO - PROCESS | 1957 | RSS: Main: 251617280 02:13:55 INFO - PROCESS | 1957 | 02:16:58 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49441/tests/dromaeo/cssquery-yui.html) 02:16:58 INFO - PROCESS | 1957 | RSS: Main: 256081920 02:16:58 INFO - PROCESS | 1957 | 02:20:01 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49441/tests/dromaeo/cssquery-yui.html (next: http://localhost:49441/tests/dromaeo/cssquery-dojo.html) 02:20:02 INFO - PROCESS | 1957 | RSS: Main: 259321856 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | __start_tp_report 02:20:02 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 02:20:02 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 02:20:02 INFO - PROCESS | 1957 | |i|pagename|runs| 02:20:02 INFO - PROCESS | 1957 | |0;dojo.html;3404.7957122572643;3453.844576994036;3454.6372630873743;3457.0147507960205;3488.6860182583564;5862.648241105531;5951.077582974635;5951.404859514047;5983.311919129302;5996.580239383245;5908.645481271116;5956.076808094742;5957.6127551709105;5971.88056238876;5995.430434108764;5365.597580181482;5389.9759045781175;5411.215373770801;5464.180372944071;5531.308586426697;4104.733192342503;4486.685931984763;5481.12302031675;5493.615446918718;5512.80705175319;5304.283921670563;5321.707306098163;5465.426130256325;5474.42518535554;5478.945210547903;4669.533046695304;5159.3550806149415;5334.413214546396;5364.946350536484;5406.243125962368;5276.657017293902;5330;5366.329208848894;5418.160185171305;5461.563074954034;5834.358220595731;5998.790042348497;6024.668643224621;6061.060535616986;6090.4518593326375;6208.441240288351;6295.055741638745;6295.559310848243;6350.682465876734;6355.491560675135;5948.613340132878;5959.344472108108;6350.428461438447;6378.712957916905;6506.349365063503;5780.1907732917425;5861.589688721834;5945;6041.969790151065;6050.485708714808;6400.647964362005;6457.225132984072;6466.902996455057;6467.870642587122;6479.416852483299;6299.590526615755;6319.842003949938;6323.494120470351;6324.620522768649;6332.873342533124;6181.505479561624;6292.465140463112;6333.46165575922;6368.777092801823;6371.936280637227;6258.874822503524;6260.718267677966;6301;6355.841103972438;6368.554201205964;6277.2153480814895;6313.589616674902;6321.304656487782;6327;6334.3032266450655;4939.110960027229;5014.157680230481;5060.165072763027;5069.518395752398;5110.616703747234;4452.332150177499;4458.621017213573;4472.530384309601;4509.526499717548;4587.908241835212;5045.495450454925;6025.457708806229;6072.180255665517;6137.202163718777;6143.539234557426;6227.564070515111;6301.558890877594;6319.273283572356;6339.4611458025665;6343.858105541047;6047.848803779941;6074.331823499411;6087.147799308101;6133.793750436599;6142.959235178526;5532.30846144232;5574.386817450078;5588.189712491666;5593.244911936837;5606.719664016783;6288.5598008138995;6466.773662921775;6530.987696906987;6536.150300460909;6549.967250163719;6245.68771561411;6270.9372906270355;6297.874042519033;6317.431431171217;6334.841628959313;6490.610563366213;6503.544751867513;6504.38208370204;6512;6516.218053833571;5351;6282.780102696383;6314.494840412664;6350.7777227796805;6356.523260755369;6239.376062393906;6243.7814676486105;6247.687615619292;6274.372562743689;6317.7157027932935;4941.901161976813;5979.910301345571;6291.213598300213;6315.431611155018;6325.177726895658;6234.470070043915;6248.125262463168;6259.593126446766;6261;6277.30949595535;5885.970570147122;6029.668368239789;6091.360407157184;6123.8162855114415;6135.294441139326;6175.752969881334;6271.4669253114;6287.182666253358;6312.084747711648;6327;6163.876722465436;6177.81466556004;6182.783602573888;6194.938050619617;6195.070739389128 02:20:02 INFO - PROCESS | 1957 | |1;ext.html;451.4785422836623;518.7406296851574;520.6641716093119;550.5767590777839;555.6082961512134;34666.65333346666;39706.205875882464;39782.60217397825;42289;42339.9415014624;43334;43647.78176109115;43751.90620234496;43902;43915;9824.754381140476;9983.351082179672;10008.199344052495;10043.748906277366;10070.892201857827;9721.611135554605;9818.754531136707;9819.410835349867;9827.852582211273;9872.407655540655;9834.655787047455;9860.654877079303;9872.259580531452;9879.703608891745;9919.107280344768;9841.557129929135;9881.357711748786;9885.950570247174;9895.554700038516;9900.900990990142;9868.062534059252;9953.4027958322;9954.9502252489;9957.302988790787;9998.45008524531;40674.79662601668;40886.38670419946;41052.589474105174;41098.58901410978;41168.176636467404;3401.727861771052;3434.364642541138;3482.3905816482015;3507.5615548056494;3729.049092481427;30571.847140764155;31011;31157.68842311593;31510;31815.045548633345;3179.5707579476707;3256.218507558193;3313.96686033139;3328.8169150696704;3372.7133193678565;387056.06471967744;388790;391012;391417;392254;58344.70827645835;58674.82650347055;58748.706256468446;58810.41189588049;58856;34515.654843451244;34921.82539087288;34930.65069349274;36753.816230918674;60691;16982.660346792996;17050.31798728037;17210.827891721172;17227.483175504756;17239.05185214825;12648.304343261208;13145.277009764364;13168.934155329354;13241.404136813673;13321.66695832612;19070.523236919187;19117.713234301496;19172.328968486036;19258.71111933322;19319.517012074528;6292.370762923762;6858.211305699909;7897.684092636345;8164.346587359132;8288.725953248553;833.9749807505784;981.5092453773113;1014.4674046125843;1059.782744537368;1065.2702898514542;29983.550246746316;30366.84816575903;30769.538456923165;30809;30846.53730194049;973.4305431322614;979.1436457244243;1051.8632577764995;1083.4799296337644;1153.3253046967618;14996.100233985995;15711.921440392953;15757.369705211893;15764.211789410483;16088.75866861998;658768;673093;674318;675023;676219;57977;58164.54588635318;58322;58384;58402.4159758397;1201.6815543880878;1345.5223395694388;1356.986430135686;1381.9170849749048;1398.5664444022386;24767.62848557237;28445.146645600664;28872;29310.97411590584;30292.84853575806;49426.50573494363;49667.00665986732;49917.50082499274;50058.24912626241;50237.24644130414;571715;581626;583346;583995;585702;21422;23210.65184022207;26475.33811654647;26615.33461663474;26688.466230675665;46965.06069878652;47979.760101199274;48199;48266.55200343995;48875.75562122309;38719.8384048479;38893.80553097217;38956;40424.595754042086;40733.18533629252;38254.808725956194;39236.41145382878;39764.38424257487;40321.395179072926;40776.368945241855;37681.81159094187;38037.429438559;38678.41982370323;38954;39145.804270978464;29340.679669415353;32123.839380802947;33204.50193247055;34589.13527161841;35015;21334.290743539;25293;25858;25875;25984.480310394065 02:20:02 INFO - PROCESS | 1957 | |2;jquery.html;376.72499075674756;383.7448097015485;384.81336551772387;392.3095352180162;407.96736261099113;19241.037948102592;20181.697274540857;20881.269155579557;20990.160393584276;21014.57970840582;16962.915185424088;19657.31199408021;19896.005199740026;20460.795392046075;20810.687839682418;4402.273624851896;5307.2569840222495;5434;6100.450959413652;6119.204503414572;6050.757969681207;6076.301225359074;6094.207752992105;6121.112438696408;6121.816345509619;5881.647101173922;5882.3529411764675;6039.245094363205;6055.091736239555;6060.2424696912885;5764.250647415851;5959.612625179393;6009.068594367902;6023.096535519663;6037.637741735488;5263.947360526422;5300.920486192672;5311.681299122027;5320.76056577455;5329.653572517813;12832.101752877303;13230.536931207458;13284.601461956157;15002.324895379734;25750.841212145497;2050.815426611597;2189.189999700105;2196.198387588535;2236.630955892292;2722.387462820869;9673.613055477772;10130.797384052352;10477.84283235752;10519.84220236697;10534.209934254885;1741.5210817025293;1882.4540883143873;1929.8745581537155;1968.5275533871768;1976.4861136104716;116014;121257.39371303088;122990.99999999911;123237;127575;9857.654982075594;11583.821001698914;11885.346305953082;12027.09796765246;12237.755244895052;14776.778348324784;14795.186264755326;14807.777883331759;14824;14867;7675.5010924289745;8575.699850505327;8775.912240877637;8865.955670221607;8873.334499912533;8762.38663293576;8916.331275154389;8926.509042002623;9036.819263614823;9050.547472626342;4583.747893865802;4611.792469338888;4622.19111655459;4639.698419602715;4673.6494762892235;1514.447226762246;1631.2903886809038;1805.9705967598343;1906.9904650476658;1987.8807271563753;850.1795767084793;854.5214679779343;935.8409070458039;971.0386717149971;992.5979978108877;17329.133543322783;17422.303107875796;20738.896305518676;21543.461413464476;21701.34895953124;788.2787249666491;815.3436483630616;917.9351951735954;942.2085448223388;974.1914211204684;9628.133467987775;10912.454377281105;11423.200375973769;11449.885501144881;11568.88431115695;564455;583107;597175;600576;603312;66755;136304.18963506384;141404;142070;142997.5700243005;902.3367824648877;936.6066252174103;957.8515330123842;1024.8513965475113;1026.6765968719978;19267.614647707247;19813.217394748885;20274.89862550678;20317.898410507853;20350.08424620925;50671.74664126803;53382.932341353735;54534.727326363114;54891;55834;74600;83426;85091.57454212937;85604.57197713971;86974.56512717396;7199;7571.848563028599;8001.679932802623;8236.794080147805;8357.832843343222;12706.428210730724;13128.671783205496;13148.868511314764;13419.261940593362;13515.526956556474;11303.43482825839;11441.485133169193;11525.423728813694;11727.589534366256;11760.117991150526;10428.843567346345;10632.362058276529;11167.609133680608;11175.608853690082;11426.771464570827;9729.70810875675;11411.942940285246;11539.711507212387;11606.12954028468;11957.820632690691;8142.796430089295;8244.54654993957;8394.496330220207;8444.577771111542;8467.95766021166;9269.629214831331;10609.681709548726;11385.373804440835;11541.884581154081;11686.649400517997 02:20:02 INFO - PROCESS | 1957 | |3;mootools.html;1492.1121932450196;1534.994578551049;1703.897766134032;1833.752443420138;1836.4123480486232;8162.265396114349;8428.95785521073;8634.870476942842;9103;9148.4968326742;8628.95685521573;8979.730608081769;9035.232005279559;9060.637574497012;9062.229710474601;2361.515889242701;2374.6675465434855;2396.2212281008656;2397.5924092904247;2409.494006258679;2046.447459186019;2373.0982226753895;2373.489699714561;2395.940101497468;2415.2995631267;2359.221456919221;2370.988145059281;2399.124319623342;2411.8552886826847;2413.806895448369;2359.398353419884;2371.833971621987;2381.428457170275;2390.4262976885598;2392.5214957008666;2372.5610762009082;2375.8099352051795;2383.9642405363934;2398.3524448398834;2400.759924007603;9017.098290170996;9049.683261085896;9057.954710226473;9117.997020327759;9118.726438206864;5256.684598924076;5414.971155480446;5418.593605479605;5425.674459532441;5442.346918369782;3315.8673653053847;3327.800331980089;3348.815815130167;3374.190194353362;3381.053305074583;1071.0521188748014;1074.4896174317214;1085.782843431317;1093.4314156638504;1107.645553422905;11837.644870653809;11844.407779610985;11931.821022684666;11953.043756499546;11970;3917.764934103963;4624.699394539344;4835.323054772335;4836.879078023077;4901.5588597026435;10055.095041446304;10075.294729369021;10122.898771012344;10210.948945255226;10224.948875255575;5344.839654810362;5407.621466497308;5436.293281873332;5446.2647542582035;5456.781728730885;4492.528284530077;4597;4811.446683631357;4944.085344211332;4985.875353116128;3610.9097272568397;3991.7405368650943;4022.0950286185957;4126.030382860025;4134.524529679065;1299.6880748620451;1315.3226088564397;1319.8878095362002;1329.4615680649351;1332.1407692038774;739.186894416138;850.2602735620051;910.9726708198765;920.889493260813;931.743770463128;5853.385394533598;5893.086571581412;6001.579889407787;6206.255249370104;6243.946277897067;903.7753843542038;919.8482250428738;924.177482040984;928.679605536089;1013.4122209118693;3141.6387115481557;3487.250241198104;4095.2219078375015;4102.138550904344;4126.546079931265;10756.300840445503;11082.335059896272;11089.27919685234;11180.105591552656;11198.720031999264;11035.724106897393;11042.944785276182;11064.723381915355;11093.057090147266;11119;7970.362371010306;8305.252527272574;8322.042965058974;8353.37349698775;8514.70198543048;5511.283533140666;5916.911246331395;5972.25346831646;6063.090536419396;6149.877002459836;9982.850257246293;10288.228382871164;10377.792444151226;10495.422751748727;10502.212334075128;10112;10216.693499195037;10521.105706014769;10527.210459215436;10683.57265709363;7029.226785053742;7280;7438.479306448497;7523.774286771406;7762.805929851573;8418.663253469793;8608.698695545625;8615.827683446421;8620.956895215484;8647.221750042527;6236.844078897882;7544.396448284234;7688.500247483896;7743.225677432211;7866.410019248694;7455.0681164854395;7541.170471248049;7561.432892533192;7566.886496702444;7683.462157648911;7076.893846592202;7204.71181152748;7219.8556028880175;7232.276772322725;7251.56490610565;5043.218301163325;5049.166887463527;5103.489651034867;5186.792528298976;5211.400688920671;4505.977470112629;5110.48895110486;5190.195519694454;5240.921386179287;5309.33633295838 02:20:02 INFO - PROCESS | 1957 | |4;prototype.html;289.30278029947823;314.63816610897464;319.39315300928234;324.485690181063;325.1416261070775;5442.530516760482;5592.29435022318;5598.804041858536;5680.147977803332;5707.571932105093;4843.0071835273775;5011.373578302712;5119.950410165917;5360.517553420192;5650.830475085754;4266.0614664773775;4268.231718290706;4277.6577873770175;4286.957130428687;4309.655227581786;4156.584341565849;4240.469941257343;4281.186574550826;4301.860007098121;4304.935425968613;4128.731632443896;4183.2430379240795;4201.285781417151;4219.346001369778;4228.344606585984;3724.776513409204;3890.8756717878855;4230.899966008829;4238.427812245353;4242.851500197478;3664.8350824212976;3681.4845921571;3684.2631473705364;3700.5744339401044;3717.981410092932;4376.956230437687;5031.169856973595;5087.618428617831;5110.386753589593;5376.1398176291605;4007.6192761687594;4077.633013028812;4798.280257961299;4839.0481806098605;4872.512748725135;4657.7903994319995;5558.416366281563;5891.734871930774;5892.230651593744;5913.970430147865;3204.5513628092085;3367.1413789483768;3807.9238415231816;4064.918701625951;4069.877903662895;5219.451957544441;5368.409474957752;6079.39206079393;6228.7887799831315;6274.686265686743;3695.0762309422644;3863.30460517104;4192.413062171298;4193.7693426861815;4207.284761590537;4023.752636682638;4221;4221.240176768211;4238.766867822299;4266.893327666833;4302.741835489881;4663.603593694506;4883.095592718842;4885.316055752198;4954.696066329102;5296.311479507639;5661.499108208984;5959.612625179349;5985.25184351956;6019.608725432833;1155.820847768597;1296.8458072315645;1331.0682522234474;1359.7688392973218;1434.4364642539474;859.9828003439897;865.5242811007217;891.7503099132254;901.7610333261691;905.7735566108473;4524.389207457017;4631.957809492905;4693.647976401783;4748.572628463386;4753.762311884392;4277.4335398760495;4468.966620187807;4473.932891006638;4636.536346365337;4753.714777113384;3723.8456078615172;4156.792160392029;4314.374415709767;4353.322706535521;4687.437507499122;2147.5597502511946;2256.458449971995;2521.735217802141;2672.8663566821583;2715.3618899558587;5093.956982587286;5174.611904107207;5230.92153617696;5350.91973620396;5366.838994830161;4577.368013392313;4826.734529600905;4844.297576851337;5216.347956505437;5279.683219006872;4287.721298115613;4921.655484116149;5081.34856171753;5294.576433885357;5299.641659461503;4391.648668106608;4580.999445363293;5118.718470484159;5124.180131178993;5126.512981266774;4390.626796722187;4587.96682362692;5031.471695471922;5038.312165424477;5061.392632884077;4307.9445535843915;4748.596369308648;5046.259040630976;5281.075811733008;5307.4427185145005;3308.553345298354;3413.232022794851;3527.4602286353784;3650.4159334506353;3712.053426376257;4227.725197862129;5118.828155053619;5127.6410651254055;5192.818251361185;5814.592978491634;4101.692373072091;4879.975600121977;5168.793248270177;5549.890021995698;5885.764569417175;5060.3168572242275;5868.94131058684;5891.49922256613;5914.911276330772;5915.556333274935;4721.480637129982;5443.265159203615;5706.372299047184;5772.278465191851;5807.94192058074;5065.7720402581235;5672.5745569081655;5915.940840591711;5926.762929482945;5935.970320148372;4709.7174169549935;5343.973280133574;5549.306336707911;5785.450382213683;5828.76684932598 02:20:02 INFO - PROCESS | 1957 | |5;yui.html;692.6818166075416;727.3017902813299;776.0493395590403;805.295366554265;821.6220538552268;15379.999999999985;15763.527094187164;15960;15976.360945562177;16007.839921600795;14380.928095359535;14408.783868241959;14421.351039203235;14430.422783088663;14470.842332613393;659.7361055577759;684.096991970599;804.0512195609208;824.5011767880436;829.7552222094466;831.2975535672377;838.4172999765166;841.2176675691604;841.7222316635496;842.5281842168405;753.5855279596227;860.0539406652695;872.6029656506274;875.5359659380539;877.385829919056;868.8566386546212;871.1897934920521;871.337783284705;872.8734333521636;874.0167311774254;646.056757134584;649.636203725915;649.9805005849832;650.4861159683844;651.8012006338065;14653.706925861423;14700.191489468076;14807.925960370238;14831.406743730346;14839.258037098101;14669.779953300602;14678.339474723663;14687.118772873662;14701.264936753227;14861.777073343908;11348.262362946381;11612.535498580046;11741.060715142854;12005.759884802255;12484.126111172221;3935.3900145477496;4485.977570112162;4566.45202575693;4587.1513769952335;4704.270838020112;109475.45262273717;116519;120063;120906.39546802209;122274.38862805718;10169.068376324483;10201.336913100624;10725.570977160825;10806.837897431546;10982.341059536293;20238;20242.190312387633;20339.389818305473;20399.08204130818;20421.2852550163;7832.765017049498;7906.723264685708;7931.5637639930355;7982.9600851995365;8068.394870384627;4393.780310984438;4457.821687132543;4488.730676159441;4499.212637788374;4676.3453116563705;3631.6368363163474;3780.527434070741;3789.7915614640906;3792.27946690128;3793.506844110303;679.6669631880442;694.5763084518439;709.3792931185213;710.5985118408083;718.1131302840987;593.6378808926552;618.4032408725601;663.3300366629738;678.945684345261;710.055626017406;8750.518721470253;9253.213476854542;9335.909996554477;9713.757156071013;9785.168260697777;572.4486641202305;607.6323824086364;661.1933441201726;662.6819126819057;695.2074634916199;4680.672352935262;4684.74233917131;4689.953100468952;4711.269753188261;4716.528347165256;101254;104578;124623;180661;184523;90150;100483;128958.35520822523;147957.26021369823;155103;128858;129217.70782292244;129571;133601;135313.3234333822;9018.5941632628;9648.469334186688;9833.117215407572;9858.359206651545;10034.347767395097;50547.49452505575;64613;65334;65769;66522;94118;94393.52803236214;95270;96061.5196924011;97689.51155244178;13255.536056237985;13255.734885302432;13380.464781408635;13425.395857186255;13778.242196679279;14506.274686265855;14521.854781452474;15015.174165421007;15260.923695381452;15494.845051549792;13132.474701012236;14088.859111408754;14186.929065354607;14757.852421475647;14796;11872.940635297115;13510.93244533771;13543.119697219649;14049.578512644637;14703.92648036753;13699.726005479635;14038;14086.082726518967;14351.641208969859;14499.347529360994;11215.766265710603;11923.10576706733;11925.463354148911;11970.461329240032;12136.514539418324;11447.542098316308;11654.791910611972;11865.644030679094;11872.52509899629;11908.404579770804 02:20:02 INFO - PROCESS | 1957 | __end_tp_report 02:20:02 INFO - PROCESS | 1957 | __start_cc_report 02:20:02 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,361 02:20:02 INFO - PROCESS | 1957 | __end_cc_report 02:20:02 INFO - PROCESS | 1957 | __startTimestamp1476609602031__endTimestamp 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | ------- Summary: start ------- 02:20:02 INFO - PROCESS | 1957 | Number of tests: 6 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5871.44 Median:6137.20 stddev:673.70 (11.0%) stddev-sans-first:647.38 02:20:02 INFO - PROCESS | 1957 | Values: 3404.8 3453.8 3454.6 3457.0 3488.7 5862.6 5951.1 5951.4 5983.3 5996.6 5908.6 5956.1 5957.6 5971.9 5995.4 5365.6 5390.0 5411.2 5464.2 5531.3 4104.7 4486.7 5481.1 5493.6 5512.8 5304.3 5321.7 5465.4 5474.4 5478.9 4669.5 5159.4 5334.4 5364.9 5406.2 5276.7 5330.0 5366.3 5418.2 5461.6 5834.4 5998.8 6024.7 6061.1 6090.5 6208.4 6295.1 6295.6 6350.7 6355.5 5948.6 5959.3 6350.4 6378.7 6506.3 5780.2 5861.6 5945.0 6042.0 6050.5 6400.6 6457.2 6466.9 6467.9 6479.4 6299.6 6319.8 6323.5 6324.6 6332.9 6181.5 6292.5 6333.5 6368.8 6371.9 6258.9 6260.7 6301.0 6355.8 6368.6 6277.2 6313.6 6321.3 6327.0 6334.3 4939.1 5014.2 5060.2 5069.5 5110.6 4452.3 4458.6 4472.5 4509.5 4587.9 5045.5 6025.5 6072.2 6137.2 6143.5 6227.6 6301.6 6319.3 6339.5 6343.9 6047.8 6074.3 6087.1 6133.8 6143.0 5532.3 5574.4 5588.2 5593.2 5606.7 6288.6 6466.8 6531.0 6536.2 6550.0 6245.7 6270.9 6297.9 6317.4 6334.8 6490.6 6503.5 6504.4 6512.0 6516.2 5351.0 6282.8 6314.5 6350.8 6356.5 6239.4 6243.8 6247.7 6274.4 6317.7 4941.9 5979.9 6291.2 6315.4 6325.2 6234.5 6248.1 6259.6 6261.0 6277.3 5886.0 6029.7 6091.4 6123.8 6135.3 6175.8 6271.5 6287.2 6312.1 6327.0 6163.9 6177.8 6182.8 6194.9 6195.1 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:67937.51 Median:215281.40 stddev:149928.41 (69.6%) stddev-sans-first:150263.38 02:20:02 INFO - PROCESS | 1957 | Values: 451.5 518.7 520.7 550.6 555.6 34666.7 39706.2 39782.6 42289.0 42339.9 43334.0 43647.8 43751.9 43902.0 43915.0 9824.8 9983.4 10008.2 10043.7 10070.9 9721.6 9818.8 9819.4 9827.9 9872.4 9834.7 9860.7 9872.3 9879.7 9919.1 9841.6 9881.4 9886.0 9895.6 9900.9 9868.1 9953.4 9955.0 9957.3 9998.5 40674.8 40886.4 41052.6 41098.6 41168.2 3401.7 3434.4 3482.4 3507.6 3729.0 30571.8 31011.0 31157.7 31510.0 31815.0 3179.6 3256.2 3314.0 3328.8 3372.7 387056.1 388790.0 391012.0 391417.0 392254.0 58344.7 58674.8 58748.7 58810.4 58856.0 34515.7 34921.8 34930.7 36753.8 60691.0 16982.7 17050.3 17210.8 17227.5 17239.1 12648.3 13145.3 13168.9 13241.4 13321.7 19070.5 19117.7 19172.3 19258.7 19319.5 6292.4 6858.2 7897.7 8164.3 8288.7 834.0 981.5 1014.5 1059.8 1065.3 29983.6 30366.8 30769.5 30809.0 30846.5 973.4 979.1 1051.9 1083.5 1153.3 14996.1 15711.9 15757.4 15764.2 16088.8 658768.0 673093.0 674318.0 675023.0 676219.0 57977.0 58164.5 58322.0 58384.0 58402.4 1201.7 1345.5 1357.0 1381.9 1398.6 24767.6 28445.1 28872.0 29311.0 30292.8 49426.5 49667.0 49917.5 50058.2 50237.2 571715.0 581626.0 583346.0 583995.0 585702.0 21422.0 23210.7 26475.3 26615.3 26688.5 46965.1 47979.8 48199.0 48266.6 48875.8 38719.8 38893.8 38956.0 40424.6 40733.2 38254.8 39236.4 39764.4 40321.4 40776.4 37681.8 38037.4 38678.4 38954.0 39145.8 29340.7 32123.8 33204.5 34589.1 35015.0 21334.3 25293.0 25858.0 25875.0 25984.5 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:34787.33 Median:1549.56 stddev:98813.89 (6376.9%) stddev-sans-first:99057.31 02:20:02 INFO - PROCESS | 1957 | Values: 376.7 383.7 384.8 392.3 408.0 19241.0 20181.7 20881.3 20990.2 21014.6 16962.9 19657.3 19896.0 20460.8 20810.7 4402.3 5307.3 5434.0 6100.5 6119.2 6050.8 6076.3 6094.2 6121.1 6121.8 5881.6 5882.4 6039.2 6055.1 6060.2 5764.3 5959.6 6009.1 6023.1 6037.6 5263.9 5300.9 5311.7 5320.8 5329.7 12832.1 13230.5 13284.6 15002.3 25750.8 2050.8 2189.2 2196.2 2236.6 2722.4 9673.6 10130.8 10477.8 10519.8 10534.2 1741.5 1882.5 1929.9 1968.5 1976.5 116014.0 121257.4 122991.0 123237.0 127575.0 9857.7 11583.8 11885.3 12027.1 12237.8 14776.8 14795.2 14807.8 14824.0 14867.0 7675.5 8575.7 8775.9 8866.0 8873.3 8762.4 8916.3 8926.5 9036.8 9050.5 4583.7 4611.8 4622.2 4639.7 4673.6 1514.4 1631.3 1806.0 1907.0 1987.9 850.2 854.5 935.8 971.0 992.6 17329.1 17422.3 20738.9 21543.5 21701.3 788.3 815.3 917.9 942.2 974.2 9628.1 10912.5 11423.2 11449.9 11568.9 564455.0 583107.0 597175.0 600576.0 603312.0 66755.0 136304.2 141404.0 142070.0 142997.6 902.3 936.6 957.9 1024.9 1026.7 19267.6 19813.2 20274.9 20317.9 20350.1 50671.7 53382.9 54534.7 54891.0 55834.0 74600.0 83426.0 85091.6 85604.6 86974.6 7199.0 7571.8 8001.7 8236.8 8357.8 12706.4 13128.7 13148.9 13419.3 13515.5 11303.4 11441.5 11525.4 11727.6 11760.1 10428.8 10632.4 11167.6 11175.6 11426.8 9729.7 11411.9 11539.7 11606.1 11957.8 8142.8 8244.5 8394.5 8444.6 8468.0 9269.6 10609.7 11385.4 11541.9 11686.6 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:5814.61 Median:4823.38 stddev:3305.13 (68.5%) stddev-sans-first:3298.44 02:20:02 INFO - PROCESS | 1957 | Values: 1492.1 1535.0 1703.9 1833.8 1836.4 8162.3 8429.0 8634.9 9103.0 9148.5 8629.0 8979.7 9035.2 9060.6 9062.2 2361.5 2374.7 2396.2 2397.6 2409.5 2046.4 2373.1 2373.5 2395.9 2415.3 2359.2 2371.0 2399.1 2411.9 2413.8 2359.4 2371.8 2381.4 2390.4 2392.5 2372.6 2375.8 2384.0 2398.4 2400.8 9017.1 9049.7 9058.0 9118.0 9118.7 5256.7 5415.0 5418.6 5425.7 5442.3 3315.9 3327.8 3348.8 3374.2 3381.1 1071.1 1074.5 1085.8 1093.4 1107.6 11837.6 11844.4 11931.8 11953.0 11970.0 3917.8 4624.7 4835.3 4836.9 4901.6 10055.1 10075.3 10122.9 10210.9 10224.9 5344.8 5407.6 5436.3 5446.3 5456.8 4492.5 4597.0 4811.4 4944.1 4985.9 3610.9 3991.7 4022.1 4126.0 4134.5 1299.7 1315.3 1319.9 1329.5 1332.1 739.2 850.3 911.0 920.9 931.7 5853.4 5893.1 6001.6 6206.3 6243.9 903.8 919.8 924.2 928.7 1013.4 3141.6 3487.3 4095.2 4102.1 4126.5 10756.3 11082.3 11089.3 11180.1 11198.7 11035.7 11042.9 11064.7 11093.1 11119.0 7970.4 8305.3 8322.0 8353.4 8514.7 5511.3 5916.9 5972.3 6063.1 6149.9 9982.9 10288.2 10377.8 10495.4 10502.2 10112.0 10216.7 10521.1 10527.2 10683.6 7029.2 7280.0 7438.5 7523.8 7762.8 8418.7 8608.7 8615.8 8621.0 8647.2 6236.8 7544.4 7688.5 7743.2 7866.4 7455.1 7541.2 7561.4 7566.9 7683.5 7076.9 7204.7 7219.9 7232.3 7251.6 5043.2 5049.2 5103.5 5186.8 5211.4 4506.0 5110.5 5190.2 5240.9 5309.3 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:4416.36 Median:4751.16 stddev:1340.65 (28.2%) stddev-sans-first:1308.13 02:20:02 INFO - PROCESS | 1957 | Values: 289.3 314.6 319.4 324.5 325.1 5442.5 5592.3 5598.8 5680.1 5707.6 4843.0 5011.4 5120.0 5360.5 5650.8 4266.1 4268.2 4277.7 4287.0 4309.7 4156.6 4240.5 4281.2 4301.9 4304.9 4128.7 4183.2 4201.3 4219.3 4228.3 3724.8 3890.9 4230.9 4238.4 4242.9 3664.8 3681.5 3684.3 3700.6 3718.0 4377.0 5031.2 5087.6 5110.4 5376.1 4007.6 4077.6 4798.3 4839.0 4872.5 4657.8 5558.4 5891.7 5892.2 5914.0 3204.6 3367.1 3807.9 4064.9 4069.9 5219.5 5368.4 6079.4 6228.8 6274.7 3695.1 3863.3 4192.4 4193.8 4207.3 4023.8 4221.0 4221.2 4238.8 4266.9 4302.7 4663.6 4883.1 4885.3 4954.7 5296.3 5661.5 5959.6 5985.3 6019.6 1155.8 1296.8 1331.1 1359.8 1434.4 860.0 865.5 891.8 901.8 905.8 4524.4 4632.0 4693.6 4748.6 4753.8 4277.4 4469.0 4473.9 4636.5 4753.7 3723.8 4156.8 4314.4 4353.3 4687.4 2147.6 2256.5 2521.7 2672.9 2715.4 5094.0 5174.6 5230.9 5350.9 5366.8 4577.4 4826.7 4844.3 5216.3 5279.7 4287.7 4921.7 5081.3 5294.6 5299.6 4391.6 4581.0 5118.7 5124.2 5126.5 4390.6 4588.0 5031.5 5038.3 5061.4 4307.9 4748.6 5046.3 5281.1 5307.4 3308.6 3413.2 3527.5 3650.4 3712.1 4227.7 5118.8 5127.6 5192.8 5814.6 4101.7 4880.0 5168.8 5549.9 5885.8 5060.3 5868.9 5891.5 5914.9 5915.6 4721.5 5443.3 5706.4 5772.3 5807.9 5065.8 5672.6 5915.9 5926.8 5936.0 4709.7 5344.0 5549.3 5785.5 5828.8 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:25508.61 Median:3706.08 stddev:41211.40 (1112.0%) stddev-sans-first:41284.89 02:20:02 INFO - PROCESS | 1957 | Values: 692.7 727.3 776.0 805.3 821.6 15380.0 15763.5 15960.0 15976.4 16007.8 14380.9 14408.8 14421.4 14430.4 14470.8 659.7 684.1 804.1 824.5 829.8 831.3 838.4 841.2 841.7 842.5 753.6 860.1 872.6 875.5 877.4 868.9 871.2 871.3 872.9 874.0 646.1 649.6 650.0 650.5 651.8 14653.7 14700.2 14807.9 14831.4 14839.3 14669.8 14678.3 14687.1 14701.3 14861.8 11348.3 11612.5 11741.1 12005.8 12484.1 3935.4 4486.0 4566.5 4587.2 4704.3 109475.5 116519.0 120063.0 120906.4 122274.4 10169.1 10201.3 10725.6 10806.8 10982.3 20238.0 20242.2 20339.4 20399.1 20421.3 7832.8 7906.7 7931.6 7983.0 8068.4 4393.8 4457.8 4488.7 4499.2 4676.3 3631.6 3780.5 3789.8 3792.3 3793.5 679.7 694.6 709.4 710.6 718.1 593.6 618.4 663.3 678.9 710.1 8750.5 9253.2 9335.9 9713.8 9785.2 572.4 607.6 661.2 662.7 695.2 4680.7 4684.7 4690.0 4711.3 4716.5 101254.0 104578.0 124623.0 180661.0 184523.0 90150.0 100483.0 128958.4 147957.3 155103.0 128858.0 129217.7 129571.0 133601.0 135313.3 9018.6 9648.5 9833.1 9858.4 10034.3 50547.5 64613.0 65334.0 65769.0 66522.0 94118.0 94393.5 95270.0 96061.5 97689.5 13255.5 13255.7 13380.5 13425.4 13778.2 14506.3 14521.9 15015.2 15260.9 15494.8 13132.5 14088.9 14186.9 14757.9 14796.0 11872.9 13510.9 13543.1 14049.6 14703.9 13699.7 14038.0 14086.1 14351.6 14499.3 11215.8 11923.1 11925.5 11970.5 12136.5 11447.5 11654.8 11865.6 11872.5 11908.4 02:20:02 INFO - PROCESS | 1957 | -------- Summary: end -------- 02:20:02 INFO - PROCESS | 1957 | 02:20:02 INFO - TEST-INFO | 1957: exit 0 02:20:02 INFO - TEST-OK | dromaeo_css | took 1113273ms 02:20:02 INFO - TEST-START | kraken 02:20:02 INFO - operating with platform_type : mac_ 02:20:02 INFO - Initialising browser for kraken test... 02:20:02 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmp5_pTNq/profile http://localhost:49441/getInfo.html) 02:20:05 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 02:20:05 INFO - PROCESS | 1964 | colorDepth:24 02:20:05 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 02:20:05 INFO - PROCESS | 1964 | __metrics 02:20:05 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:20:06 INFO - TEST-INFO | 1964: exit 0 02:20:06 INFO - Browser initialized. 02:20:06 INFO - Running cycle 1/1 for kraken test... 02:20:06 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmp5_pTNq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:18 INFO - PROCESS | 1967 | RSS: Main: 225144832 02:20:18 INFO - PROCESS | 1967 | 02:20:21 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49441/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:22 INFO - PROCESS | 1967 | RSS: Main: 237645824 02:20:22 INFO - PROCESS | 1967 | 02:20:24 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49441/tests/kraken/driver.html?testName=audio-dft) 02:20:25 INFO - PROCESS | 1967 | RSS: Main: 245907456 02:20:25 INFO - PROCESS | 1967 | 02:20:28 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49441/tests/kraken/driver.html?testName=audio-fft) 02:20:29 INFO - PROCESS | 1967 | RSS: Main: 247812096 02:20:29 INFO - PROCESS | 1967 | 02:20:31 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49441/tests/kraken/driver.html?testName=audio-oscillator) 02:20:32 INFO - PROCESS | 1967 | RSS: Main: 249901056 02:20:32 INFO - PROCESS | 1967 | 02:20:34 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:34 INFO - PROCESS | 1967 | RSS: Main: 250204160 02:20:34 INFO - PROCESS | 1967 | 02:20:37 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49441/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:38 INFO - PROCESS | 1967 | RSS: Main: 250380288 02:20:38 INFO - PROCESS | 1967 | 02:20:41 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49441/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:41 INFO - PROCESS | 1967 | RSS: Main: 250597376 02:20:41 INFO - PROCESS | 1967 | 02:20:44 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49441/tests/kraken/driver.html?testName=json-parse-financial) 02:20:45 INFO - PROCESS | 1967 | RSS: Main: 250839040 02:20:45 INFO - PROCESS | 1967 | 02:20:47 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:47 INFO - PROCESS | 1967 | RSS: Main: 250511360 02:20:47 INFO - PROCESS | 1967 | 02:20:49 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:50 INFO - PROCESS | 1967 | RSS: Main: 250626048 02:20:50 INFO - PROCESS | 1967 | 02:20:52 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:53 INFO - PROCESS | 1967 | RSS: Main: 251101184 02:20:53 INFO - PROCESS | 1967 | 02:20:56 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:56 INFO - PROCESS | 1967 | RSS: Main: 250839040 02:20:56 INFO - PROCESS | 1967 | 02:20:59 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:00 INFO - PROCESS | 1967 | RSS: Main: 251092992 02:21:00 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49441/tests/kraken/driver.html?testName=ai-astar) 02:21:02 INFO - PROCESS | 1967 | RSS: Main: 252407808 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | __start_tp_report 02:21:02 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 02:21:02 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 02:21:02 INFO - PROCESS | 1967 | |i|pagename|runs| 02:21:02 INFO - PROCESS | 1967 | |0;ai-astar;105;144;104;103;127;171;174;174;117;113 02:21:02 INFO - PROCESS | 1967 | |1;audio-beat-detection;156;134;140;168;142;114;113;112;143;123 02:21:02 INFO - PROCESS | 1967 | |2;audio-dft;200;198;273;186;282;209;276;279;197;198 02:21:02 INFO - PROCESS | 1967 | |3;audio-fft;86;58;58;83;52;70;81;83;102;82 02:21:02 INFO - PROCESS | 1967 | |4;audio-oscillator;86;70;85;72;69;74;88;68;70;86 02:21:02 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;89;86;87;84;89;86;89;85;87;86 02:21:02 INFO - PROCESS | 1967 | |6;imaging-darkroom;162;98;104;98;121;174;161;99;134;97 02:21:02 INFO - PROCESS | 1967 | |7;imaging-desaturate;102;110;126;94;91;90;94;91;129;106 02:21:02 INFO - PROCESS | 1967 | |8;json-parse-financial;47;79;80;89;90;92;72;60;60;59 02:21:02 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;68;75;69;74;76;80;64;73;96;106 02:21:02 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;85;84;84;87;85;81;88;86;69;91 02:21:02 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;134;142;138;140;149;143;159;173;204;144 02:21:02 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;171;172;166;167;212;235;188;189;234;174 02:21:02 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;69;58;64;79;91 02:21:02 INFO - PROCESS | 1967 | __end_tp_report 02:21:02 INFO - PROCESS | 1967 | __start_cc_report 02:21:02 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,941 02:21:02 INFO - PROCESS | 1967 | __end_cc_report 02:21:02 INFO - PROCESS | 1967 | __startTimestamp1476609662542__endTimestamp 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | ------- Summary: start ------- 02:21:02 INFO - PROCESS | 1967 | Number of tests: 14 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:133.20 Median:135.50 stddev:30.08 (22.2%) stddev-sans-first:30.12 02:21:02 INFO - PROCESS | 1967 | Values: 105.0 144.0 104.0 103.0 127.0 171.0 174.0 174.0 117.0 113.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:141.00 stddev:19.05 (13.5%) stddev-sans-first:18.54 02:21:02 INFO - PROCESS | 1967 | Values: 156.0 134.0 140.0 168.0 142.0 114.0 113.0 112.0 143.0 123.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:229.80 Median:241.00 stddev:41.48 (17.2%) stddev-sans-first:42.57 02:21:02 INFO - PROCESS | 1967 | Values: 200.0 198.0 273.0 186.0 282.0 209.0 276.0 279.0 197.0 198.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:75.50 Median:81.50 stddev:15.61 (19.2%) stddev-sans-first:16.09 02:21:02 INFO - PROCESS | 1967 | Values: 86.0 58.0 58.0 83.0 52.0 70.0 81.0 83.0 102.0 82.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:79.50 stddev:8.32 (10.5%) stddev-sans-first:8.14 02:21:02 INFO - PROCESS | 1967 | Values: 86.0 70.0 85.0 72.0 69.0 74.0 88.0 68.0 70.0 86.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:1.75 (2.0%) stddev-sans-first:1.67 02:21:02 INFO - PROCESS | 1967 | Values: 89.0 86.0 87.0 84.0 89.0 86.0 89.0 85.0 87.0 86.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:124.80 Median:135.50 stddev:30.77 (22.7%) stddev-sans-first:29.55 02:21:02 INFO - PROCESS | 1967 | Values: 162.0 98.0 104.0 98.0 121.0 174.0 161.0 99.0 134.0 97.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:90.50 stddev:14.46 (16.0%) stddev-sans-first:15.33 02:21:02 INFO - PROCESS | 1967 | Values: 102.0 110.0 126.0 94.0 91.0 90.0 94.0 91.0 129.0 106.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:79.50 stddev:15.64 (19.7%) stddev-sans-first:13.52 02:21:02 INFO - PROCESS | 1967 | Values: 47.0 79.0 80.0 89.0 90.0 92.0 72.0 60.0 60.0 59.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:74.50 stddev:13.09 (17.6%) stddev-sans-first:13.37 02:21:02 INFO - PROCESS | 1967 | Values: 68.0 75.0 69.0 74.0 76.0 80.0 64.0 73.0 96.0 106.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.50 stddev:5.91 (6.9%) stddev-sans-first:6.25 02:21:02 INFO - PROCESS | 1967 | Values: 85.0 84.0 84.0 87.0 85.0 81.0 88.0 86.0 69.0 91.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:146.50 stddev:21.37 (14.6%) stddev-sans-first:21.58 02:21:02 INFO - PROCESS | 1967 | Values: 134.0 142.0 138.0 140.0 149.0 143.0 159.0 173.0 204.0 144.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:188.50 stddev:26.85 (14.2%) stddev-sans-first:27.51 02:21:02 INFO - PROCESS | 1967 | Values: 171.0 172.0 166.0 167.0 212.0 235.0 188.0 189.0 234.0 174.0 02:21:02 INFO - PROCESS | 1967 | 02:21:02 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:68.00 stddev:9.02 (13.3%) stddev-sans-first:9.51 02:21:02 INFO - PROCESS | 1967 | Values: 67.0 68.0 68.0 68.0 67.0 69.0 58.0 64.0 79.0 91.0 02:21:02 INFO - PROCESS | 1967 | -------- Summary: end -------- 02:21:02 INFO - PROCESS | 1967 | 02:21:03 INFO - TEST-INFO | 1967: exit 0 02:21:03 INFO - TEST-OK | kraken | took 60655ms 02:21:03 INFO - SUITE-END | took 1173s 02:21:03 INFO - Completed test suite (00:19:34) 02:21:03 INFO - javascript benchmark 02:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7381.506104591371, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3404.7957122572643, 3453.844576994036, 3454.6372630873743, 3457.0147507960205, 3488.6860182583564, 5862.648241105531, 5951.077582974635, 5951.404859514047, 5983.311919129302, 5996.580239383245, 5908.645481271116, 5956.076808094742, 5957.6127551709105, 5971.88056238876, 5995.430434108764, 5365.597580181482, 5389.9759045781175, 5411.215373770801, 5464.180372944071, 5531.308586426697, 4104.733192342503, 4486.685931984763, 5481.12302031675, 5493.615446918718, 5512.80705175319, 5304.283921670563, 5321.707306098163, 5465.426130256325, 5474.42518535554, 5478.945210547903, 4669.533046695304, 5159.3550806149415, 5334.413214546396, 5364.946350536484, 5406.243125962368, 5276.657017293902, 5330.0, 5366.329208848894, 5418.160185171305, 5461.563074954034, 5834.358220595731, 5998.790042348497, 6024.668643224621, 6061.060535616986, 6090.4518593326375, 6208.441240288351, 6295.055741638745, 6295.559310848243, 6350.682465876734, 6355.491560675135, 5948.613340132878, 5959.344472108108, 6350.428461438447, 6378.712957916905, 6506.349365063503, 5780.1907732917425, 5861.589688721834, 5945.0, 6041.969790151065, 6050.485708714808, 6400.647964362005, 6457.225132984072, 6466.902996455057, 6467.870642587122, 6479.416852483299, 6299.590526615755, 6319.842003949938, 6323.494120470351, 6324.620522768649, 6332.873342533124, 6181.505479561624, 6292.465140463112, 6333.46165575922, 6368.777092801823, 6371.936280637227, 6258.874822503524, 6260.718267677966, 6301.0, 6355.841103972438, 6368.554201205964, 6277.2153480814895, 6313.589616674902, 6321.304656487782, 6327.0, 6334.3032266450655, 4939.110960027229, 5014.157680230481, 5060.165072763027, 5069.518395752398, 5110.616703747234, 4452.332150177499, 4458.621017213573, 4472.530384309601, 4509.526499717548, 4587.908241835212, 5045.495450454925, 6025.457708806229, 6072.180255665517, 6137.202163718777, 6143.539234557426, 6227.564070515111, 6301.558890877594, 6319.273283572356, 6339.4611458025665, 6343.858105541047, 6047.848803779941, 6074.331823499411, 6087.147799308101, 6133.793750436599, 6142.959235178526, 5532.30846144232, 5574.386817450078, 5588.189712491666, 5593.244911936837, 5606.719664016783, 6288.5598008138995, 6466.773662921775, 6530.987696906987, 6536.150300460909, 6549.967250163719, 6245.68771561411, 6270.9372906270355, 6297.874042519033, 6317.431431171217, 6334.841628959313, 6490.610563366213, 6503.544751867513, 6504.38208370204, 6512.0, 6516.218053833571, 5351.0, 6282.780102696383, 6314.494840412664, 6350.7777227796805, 6356.523260755369, 6239.376062393906, 6243.7814676486105, 6247.687615619292, 6274.372562743689, 6317.7157027932935, 4941.901161976813, 5979.910301345571, 6291.213598300213, 6315.431611155018, 6325.177726895658, 6234.470070043915, 6248.125262463168, 6259.593126446766, 6261.0, 6277.30949595535, 5885.970570147122, 6029.668368239789, 6091.360407157184, 6123.8162855114415, 6135.294441139326, 6175.752969881334, 6271.4669253114, 6287.182666253358, 6312.084747711648, 6327.0, 6163.876722465436, 6177.81466556004, 6182.783602573888, 6194.938050619617, 6195.070739389128], "value": 5829.041074667738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.4785422836623, 518.7406296851574, 520.6641716093119, 550.5767590777839, 555.6082961512134, 34666.65333346666, 39706.205875882464, 39782.60217397825, 42289.0, 42339.9415014624, 43334.0, 43647.78176109115, 43751.90620234496, 43902.0, 43915.0, 9824.754381140476, 9983.351082179672, 10008.199344052495, 10043.748906277366, 10070.892201857827, 9721.611135554605, 9818.754531136707, 9819.410835349867, 9827.852582211273, 9872.407655540655, 9834.655787047455, 9860.654877079303, 9872.259580531452, 9879.703608891745, 9919.107280344768, 9841.557129929135, 9881.357711748786, 9885.950570247174, 9895.554700038516, 9900.900990990142, 9868.062534059252, 9953.4027958322, 9954.9502252489, 9957.302988790787, 9998.45008524531, 40674.79662601668, 40886.38670419946, 41052.589474105174, 41098.58901410978, 41168.176636467404, 3401.727861771052, 3434.364642541138, 3482.3905816482015, 3507.5615548056494, 3729.049092481427, 30571.847140764155, 31011.0, 31157.68842311593, 31510.0, 31815.045548633345, 3179.5707579476707, 3256.218507558193, 3313.96686033139, 3328.8169150696704, 3372.7133193678565, 387056.06471967744, 388790.0, 391012.0, 391417.0, 392254.0, 58344.70827645835, 58674.82650347055, 58748.706256468446, 58810.41189588049, 58856.0, 34515.654843451244, 34921.82539087288, 34930.65069349274, 36753.816230918674, 60691.0, 16982.660346792996, 17050.31798728037, 17210.827891721172, 17227.483175504756, 17239.05185214825, 12648.304343261208, 13145.277009764364, 13168.934155329354, 13241.404136813673, 13321.66695832612, 19070.523236919187, 19117.713234301496, 19172.328968486036, 19258.71111933322, 19319.517012074528, 6292.370762923762, 6858.211305699909, 7897.684092636345, 8164.346587359132, 8288.725953248553, 833.9749807505784, 981.5092453773113, 1014.4674046125843, 1059.782744537368, 1065.2702898514542, 29983.550246746316, 30366.84816575903, 30769.538456923165, 30809.0, 30846.53730194049, 973.4305431322614, 979.1436457244243, 1051.8632577764995, 1083.4799296337644, 1153.3253046967618, 14996.100233985995, 15711.921440392953, 15757.369705211893, 15764.211789410483, 16088.75866861998, 658768.0, 673093.0, 674318.0, 675023.0, 676219.0, 57977.0, 58164.54588635318, 58322.0, 58384.0, 58402.4159758397, 1201.6815543880878, 1345.5223395694388, 1356.986430135686, 1381.9170849749048, 1398.5664444022386, 24767.62848557237, 28445.146645600664, 28872.0, 29310.97411590584, 30292.84853575806, 49426.50573494363, 49667.00665986732, 49917.50082499274, 50058.24912626241, 50237.24644130414, 571715.0, 581626.0, 583346.0, 583995.0, 585702.0, 21422.0, 23210.65184022207, 26475.33811654647, 26615.33461663474, 26688.466230675665, 46965.06069878652, 47979.760101199274, 48199.0, 48266.55200343995, 48875.75562122309, 38719.8384048479, 38893.80553097217, 38956.0, 40424.595754042086, 40733.18533629252, 38254.808725956194, 39236.41145382878, 39764.38424257487, 40321.395179072926, 40776.368945241855, 37681.81159094187, 38037.429438559, 38678.41982370323, 38954.0, 39145.804270978464, 29340.679669415353, 32123.839380802947, 33204.50193247055, 34589.13527161841, 35015.0, 21334.290743539, 25293.0, 25858.0, 25875.0, 25984.480310394065], "value": 19801.204578239736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.72499075674756, 383.7448097015485, 384.81336551772387, 392.3095352180162, 407.96736261099113, 19241.037948102592, 20181.697274540857, 20881.269155579557, 20990.160393584276, 21014.57970840582, 16962.915185424088, 19657.31199408021, 19896.005199740026, 20460.795392046075, 20810.687839682418, 4402.273624851896, 5307.2569840222495, 5434.0, 6100.450959413652, 6119.204503414572, 6050.757969681207, 6076.301225359074, 6094.207752992105, 6121.112438696408, 6121.816345509619, 5881.647101173922, 5882.3529411764675, 6039.245094363205, 6055.091736239555, 6060.2424696912885, 5764.250647415851, 5959.612625179393, 6009.068594367902, 6023.096535519663, 6037.637741735488, 5263.947360526422, 5300.920486192672, 5311.681299122027, 5320.76056577455, 5329.653572517813, 12832.101752877303, 13230.536931207458, 13284.601461956157, 15002.324895379734, 25750.841212145497, 2050.815426611597, 2189.189999700105, 2196.198387588535, 2236.630955892292, 2722.387462820869, 9673.613055477772, 10130.797384052352, 10477.84283235752, 10519.84220236697, 10534.209934254885, 1741.5210817025293, 1882.4540883143873, 1929.8745581537155, 1968.5275533871768, 1976.4861136104716, 116014.0, 121257.39371303088, 122990.99999999911, 123237.0, 127575.0, 9857.654982075594, 11583.821001698914, 11885.346305953082, 12027.09796765246, 12237.755244895052, 14776.778348324784, 14795.186264755326, 14807.777883331759, 14824.0, 14867.0, 7675.5010924289745, 8575.699850505327, 8775.912240877637, 8865.955670221607, 8873.334499912533, 8762.38663293576, 8916.331275154389, 8926.509042002623, 9036.819263614823, 9050.547472626342, 4583.747893865802, 4611.792469338888, 4622.19111655459, 4639.698419602715, 4673.6494762892235, 1514.447226762246, 1631.2903886809038, 1805.9705967598343, 1906.9904650476658, 1987.8807271563753, 850.1795767084793, 854.5214679779343, 935.8409070458039, 971.0386717149971, 992.5979978108877, 17329.133543322783, 17422.303107875796, 20738.896305518676, 21543.461413464476, 21701.34895953124, 788.2787249666491, 815.3436483630616, 917.9351951735954, 942.2085448223388, 974.1914211204684, 9628.133467987775, 10912.454377281105, 11423.200375973769, 11449.885501144881, 11568.88431115695, 564455.0, 583107.0, 597175.0, 600576.0, 603312.0, 66755.0, 136304.18963506384, 141404.0, 142070.0, 142997.5700243005, 902.3367824648877, 936.6066252174103, 957.8515330123842, 1024.8513965475113, 1026.6765968719978, 19267.614647707247, 19813.217394748885, 20274.89862550678, 20317.898410507853, 20350.08424620925, 50671.74664126803, 53382.932341353735, 54534.727326363114, 54891.0, 55834.0, 74600.0, 83426.0, 85091.57454212937, 85604.57197713971, 86974.56512717396, 7199.0, 7571.848563028599, 8001.679932802623, 8236.794080147805, 8357.832843343222, 12706.428210730724, 13128.671783205496, 13148.868511314764, 13419.261940593362, 13515.526956556474, 11303.43482825839, 11441.485133169193, 11525.423728813694, 11727.589534366256, 11760.117991150526, 10428.843567346345, 10632.362058276529, 11167.609133680608, 11175.608853690082, 11426.771464570827, 9729.70810875675, 11411.942940285246, 11539.711507212387, 11606.12954028468, 11957.820632690691, 8142.796430089295, 8244.54654993957, 8394.496330220207, 8444.577771111542, 8467.95766021166, 9269.629214831331, 10609.681709548726, 11385.373804440835, 11541.884581154081, 11686.649400517997], "value": 9471.012335419387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.1121932450196, 1534.994578551049, 1703.897766134032, 1833.752443420138, 1836.4123480486232, 8162.265396114349, 8428.95785521073, 8634.870476942842, 9103.0, 9148.4968326742, 8628.95685521573, 8979.730608081769, 9035.232005279559, 9060.637574497012, 9062.229710474601, 2361.515889242701, 2374.6675465434855, 2396.2212281008656, 2397.5924092904247, 2409.494006258679, 2046.447459186019, 2373.0982226753895, 2373.489699714561, 2395.940101497468, 2415.2995631267, 2359.221456919221, 2370.988145059281, 2399.124319623342, 2411.8552886826847, 2413.806895448369, 2359.398353419884, 2371.833971621987, 2381.428457170275, 2390.4262976885598, 2392.5214957008666, 2372.5610762009082, 2375.8099352051795, 2383.9642405363934, 2398.3524448398834, 2400.759924007603, 9017.098290170996, 9049.683261085896, 9057.954710226473, 9117.997020327759, 9118.726438206864, 5256.684598924076, 5414.971155480446, 5418.593605479605, 5425.674459532441, 5442.346918369782, 3315.8673653053847, 3327.800331980089, 3348.815815130167, 3374.190194353362, 3381.053305074583, 1071.0521188748014, 1074.4896174317214, 1085.782843431317, 1093.4314156638504, 1107.645553422905, 11837.644870653809, 11844.407779610985, 11931.821022684666, 11953.043756499546, 11970.0, 3917.764934103963, 4624.699394539344, 4835.323054772335, 4836.879078023077, 4901.5588597026435, 10055.095041446304, 10075.294729369021, 10122.898771012344, 10210.948945255226, 10224.948875255575, 5344.839654810362, 5407.621466497308, 5436.293281873332, 5446.2647542582035, 5456.781728730885, 4492.528284530077, 4597.0, 4811.446683631357, 4944.085344211332, 4985.875353116128, 3610.9097272568397, 3991.7405368650943, 4022.0950286185957, 4126.030382860025, 4134.524529679065, 1299.6880748620451, 1315.3226088564397, 1319.8878095362002, 1329.4615680649351, 1332.1407692038774, 739.186894416138, 850.2602735620051, 910.9726708198765, 920.889493260813, 931.743770463128, 5853.385394533598, 5893.086571581412, 6001.579889407787, 6206.255249370104, 6243.946277897067, 903.7753843542038, 919.8482250428738, 924.177482040984, 928.679605536089, 1013.4122209118693, 3141.6387115481557, 3487.250241198104, 4095.2219078375015, 4102.138550904344, 4126.546079931265, 10756.300840445503, 11082.335059896272, 11089.27919685234, 11180.105591552656, 11198.720031999264, 11035.724106897393, 11042.944785276182, 11064.723381915355, 11093.057090147266, 11119.0, 7970.362371010306, 8305.252527272574, 8322.042965058974, 8353.37349698775, 8514.70198543048, 5511.283533140666, 5916.911246331395, 5972.25346831646, 6063.090536419396, 6149.877002459836, 9982.850257246293, 10288.228382871164, 10377.792444151226, 10495.422751748727, 10502.212334075128, 10112.0, 10216.693499195037, 10521.105706014769, 10527.210459215436, 10683.57265709363, 7029.226785053742, 7280.0, 7438.479306448497, 7523.774286771406, 7762.805929851573, 8418.663253469793, 8608.698695545625, 8615.827683446421, 8620.956895215484, 8647.221750042527, 6236.844078897882, 7544.396448284234, 7688.500247483896, 7743.225677432211, 7866.410019248694, 7455.0681164854395, 7541.170471248049, 7561.432892533192, 7566.886496702444, 7683.462157648911, 7076.893846592202, 7204.71181152748, 7219.8556028880175, 7232.276772322725, 7251.56490610565, 5043.218301163325, 5049.166887463527, 5103.489651034867, 5186.792528298976, 5211.400688920671, 4505.977470112629, 5110.48895110486, 5190.195519694454, 5240.921386179287, 5309.33633295838], "value": 4650.330738433209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.30278029947823, 314.63816610897464, 319.39315300928234, 324.485690181063, 325.1416261070775, 5442.530516760482, 5592.29435022318, 5598.804041858536, 5680.147977803332, 5707.571932105093, 4843.0071835273775, 5011.373578302712, 5119.950410165917, 5360.517553420192, 5650.830475085754, 4266.0614664773775, 4268.231718290706, 4277.6577873770175, 4286.957130428687, 4309.655227581786, 4156.584341565849, 4240.469941257343, 4281.186574550826, 4301.860007098121, 4304.935425968613, 4128.731632443896, 4183.2430379240795, 4201.285781417151, 4219.346001369778, 4228.344606585984, 3724.776513409204, 3890.8756717878855, 4230.899966008829, 4238.427812245353, 4242.851500197478, 3664.8350824212976, 3681.4845921571, 3684.2631473705364, 3700.5744339401044, 3717.981410092932, 4376.956230437687, 5031.169856973595, 5087.618428617831, 5110.386753589593, 5376.1398176291605, 4007.6192761687594, 4077.633013028812, 4798.280257961299, 4839.0481806098605, 4872.512748725135, 4657.7903994319995, 5558.416366281563, 5891.734871930774, 5892.230651593744, 5913.970430147865, 3204.5513628092085, 3367.1413789483768, 3807.9238415231816, 4064.918701625951, 4069.877903662895, 5219.451957544441, 5368.409474957752, 6079.39206079393, 6228.7887799831315, 6274.686265686743, 3695.0762309422644, 3863.30460517104, 4192.413062171298, 4193.7693426861815, 4207.284761590537, 4023.752636682638, 4221.0, 4221.240176768211, 4238.766867822299, 4266.893327666833, 4302.741835489881, 4663.603593694506, 4883.095592718842, 4885.316055752198, 4954.696066329102, 5296.311479507639, 5661.499108208984, 5959.612625179349, 5985.25184351956, 6019.608725432833, 1155.820847768597, 1296.8458072315645, 1331.0682522234474, 1359.7688392973218, 1434.4364642539474, 859.9828003439897, 865.5242811007217, 891.7503099132254, 901.7610333261691, 905.7735566108473, 4524.389207457017, 4631.957809492905, 4693.647976401783, 4748.572628463386, 4753.762311884392, 4277.4335398760495, 4468.966620187807, 4473.932891006638, 4636.536346365337, 4753.714777113384, 3723.8456078615172, 4156.792160392029, 4314.374415709767, 4353.322706535521, 4687.437507499122, 2147.5597502511946, 2256.458449971995, 2521.735217802141, 2672.8663566821583, 2715.3618899558587, 5093.956982587286, 5174.611904107207, 5230.92153617696, 5350.91973620396, 5366.838994830161, 4577.368013392313, 4826.734529600905, 4844.297576851337, 5216.347956505437, 5279.683219006872, 4287.721298115613, 4921.655484116149, 5081.34856171753, 5294.576433885357, 5299.641659461503, 4391.648668106608, 4580.999445363293, 5118.718470484159, 5124.180131178993, 5126.512981266774, 4390.626796722187, 4587.96682362692, 5031.471695471922, 5038.312165424477, 5061.392632884077, 4307.9445535843915, 4748.596369308648, 5046.259040630976, 5281.075811733008, 5307.4427185145005, 3308.553345298354, 3413.232022794851, 3527.4602286353784, 3650.4159334506353, 3712.053426376257, 4227.725197862129, 5118.828155053619, 5127.6410651254055, 5192.818251361185, 5814.592978491634, 4101.692373072091, 4879.975600121977, 5168.793248270177, 5549.890021995698, 5885.764569417175, 5060.3168572242275, 5868.94131058684, 5891.49922256613, 5914.911276330772, 5915.556333274935, 4721.480637129982, 5443.265159203615, 5706.372299047184, 5772.278465191851, 5807.94192058074, 5065.7720402581235, 5672.5745569081655, 5915.940840591711, 5926.762929482945, 5935.970320148372, 4709.7174169549935, 5343.973280133574, 5549.306336707911, 5785.450382213683, 5828.76684932598], "value": 3996.9172813254268, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.6818166075416, 727.3017902813299, 776.0493395590403, 805.295366554265, 821.6220538552268, 15379.999999999985, 15763.527094187164, 15960.0, 15976.360945562177, 16007.839921600795, 14380.928095359535, 14408.783868241959, 14421.351039203235, 14430.422783088663, 14470.842332613393, 659.7361055577759, 684.096991970599, 804.0512195609208, 824.5011767880436, 829.7552222094466, 831.2975535672377, 838.4172999765166, 841.2176675691604, 841.7222316635496, 842.5281842168405, 753.5855279596227, 860.0539406652695, 872.6029656506274, 875.5359659380539, 877.385829919056, 868.8566386546212, 871.1897934920521, 871.337783284705, 872.8734333521636, 874.0167311774254, 646.056757134584, 649.636203725915, 649.9805005849832, 650.4861159683844, 651.8012006338065, 14653.706925861423, 14700.191489468076, 14807.925960370238, 14831.406743730346, 14839.258037098101, 14669.779953300602, 14678.339474723663, 14687.118772873662, 14701.264936753227, 14861.777073343908, 11348.262362946381, 11612.535498580046, 11741.060715142854, 12005.759884802255, 12484.126111172221, 3935.3900145477496, 4485.977570112162, 4566.45202575693, 4587.1513769952335, 4704.270838020112, 109475.45262273717, 116519.0, 120063.0, 120906.39546802209, 122274.38862805718, 10169.068376324483, 10201.336913100624, 10725.570977160825, 10806.837897431546, 10982.341059536293, 20238.0, 20242.190312387633, 20339.389818305473, 20399.08204130818, 20421.2852550163, 7832.765017049498, 7906.723264685708, 7931.5637639930355, 7982.9600851995365, 8068.394870384627, 4393.780310984438, 4457.821687132543, 4488.730676159441, 4499.212637788374, 4676.3453116563705, 3631.6368363163474, 3780.527434070741, 3789.7915614640906, 3792.27946690128, 3793.506844110303, 679.6669631880442, 694.5763084518439, 709.3792931185213, 710.5985118408083, 718.1131302840987, 593.6378808926552, 618.4032408725601, 663.3300366629738, 678.945684345261, 710.055626017406, 8750.518721470253, 9253.213476854542, 9335.909996554477, 9713.757156071013, 9785.168260697777, 572.4486641202305, 607.6323824086364, 661.1933441201726, 662.6819126819057, 695.2074634916199, 4680.672352935262, 4684.74233917131, 4689.953100468952, 4711.269753188261, 4716.528347165256, 101254.0, 104578.0, 124623.0, 180661.0, 184523.0, 90150.0, 100483.0, 128958.35520822523, 147957.26021369823, 155103.0, 128858.0, 129217.70782292244, 129571.0, 133601.0, 135313.3234333822, 9018.5941632628, 9648.469334186688, 9833.117215407572, 9858.359206651545, 10034.347767395097, 50547.49452505575, 64613.0, 65334.0, 65769.0, 66522.0, 94118.0, 94393.52803236214, 95270.0, 96061.5196924011, 97689.51155244178, 13255.536056237985, 13255.734885302432, 13380.464781408635, 13425.395857186255, 13778.242196679279, 14506.274686265855, 14521.854781452474, 15015.174165421007, 15260.923695381452, 15494.845051549792, 13132.474701012236, 14088.859111408754, 14186.929065354607, 14757.852421475647, 14796.0, 11872.940635297115, 13510.93244533771, 13543.119697219649, 14049.578512644637, 14703.92648036753, 13699.726005479635, 14038.0, 14086.082726518967, 14351.641208969859, 14499.347529360994, 11215.766265710603, 11923.10576706733, 11925.463354148911, 11970.461329240032, 12136.514539418324, 11447.542098316308, 11654.791910611972, 11865.644030679094, 11872.52509899629, 11908.404579770804], "value": 7960.308449151831, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 144.0, 104.0, 103.0, 127.0, 171.0, 174.0, 174.0, 117.0, 113.0], "value": 133.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 140.0, 168.0, 142.0, 114.0, 113.0, 112.0, 143.0, 123.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 198.0, 273.0, 186.0, 282.0, 209.0, 276.0, 279.0, 197.0, 198.0], "value": 229.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 58.0, 83.0, 52.0, 70.0, 81.0, 83.0, 102.0, 82.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 85.0, 72.0, 69.0, 74.0, 88.0, 68.0, 70.0, 86.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 84.0, 89.0, 86.0, 89.0, 85.0, 87.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 98.0, 104.0, 98.0, 121.0, 174.0, 161.0, 99.0, 134.0, 97.0], "value": 124.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 126.0, 94.0, 91.0, 90.0, 94.0, 91.0, 129.0, 106.0], "value": 103.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 79.0, 80.0, 89.0, 90.0, 92.0, 72.0, 60.0, 60.0, 59.0], "value": 72.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 69.0, 74.0, 76.0, 80.0, 64.0, 73.0, 96.0, 106.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 87.0, 85.0, 81.0, 88.0, 86.0, 69.0, 91.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 138.0, 140.0, 149.0, 143.0, 159.0, 173.0, 204.0, 144.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 166.0, 167.0, 212.0, 235.0, 188.0, 189.0, 234.0, 174.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 58.0, 64.0, 79.0, 91.0], "value": 69.9, "unit": "score"}]}]} 02:21:03 INFO - Return code: 0 02:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:21:03 ERROR - # TBPL SUCCESS # 02:21:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:21:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:21:03 INFO - 2016-10-16 02:21:03.839 screenresolution[1972:23438] starting screenresolution argv=screenresolution get 02:21:03 INFO - 2016-10-16 02:21:03.842 screenresolution[1972:23438] Display 0: 1600x1200x32@60 02:21:03 INFO - 2016-10-16 02:21:03.848 screenresolution[1973:23440] starting screenresolution argv=screenresolution list 02:21:03 INFO - Available Modes on Display 0 02:21:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:21:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:21:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:21:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:21:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:21:04 INFO - Intel Iris: 02:21:04 INFO - Chipset Model: Intel Iris 02:21:04 INFO - Type: GPU 02:21:04 INFO - Bus: Built-In 02:21:04 INFO - VRAM (Dynamic, Max): 1536 MB 02:21:04 INFO - Vendor: Intel (0x8086) 02:21:04 INFO - Device ID: 0x0a2e 02:21:04 INFO - Revision ID: 0x0009 02:21:04 INFO - Displays: 02:21:04 INFO - Display: 02:21:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:21:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:21:04 INFO - Display Serial Number: 1600x1200 60 02:21:04 INFO - Main Display: Yes 02:21:04 INFO - Mirror: Off 02:21:04 INFO - Online: Yes 02:21:04 INFO - Rotation: Supported 02:21:04 INFO - Return code: 0 02:21:04 INFO - Running post-action listener: _resource_record_post_action 02:21:04 INFO - [mozharness: 2016-10-16 09:21:04.083800Z] Finished run-tests step (success) 02:21:04 INFO - Running post-run listener: _resource_record_post_run 02:21:04 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 1990656; Write bytes: 664826368; Read time: 20; Write time: 1967 02:21:04 INFO - TinderboxPrint: CPU usage
54.5% 02:21:04 INFO - TinderboxPrint: I/O read bytes / time
1,990,656 / 20 02:21:04 INFO - TinderboxPrint: I/O write bytes / time
664,826,368 / 1,967 02:21:04 INFO - TinderboxPrint: CPU idle
2,195.6 (45.5%) 02:21:04 INFO - TinderboxPrint: CPU system
977.9 (20.2%) 02:21:04 INFO - TinderboxPrint: CPU user
1,656.1 (34.3%) 02:21:04 INFO - TinderboxPrint: Swap in / out
365,215,744 / 0 02:21:04 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358302208; Write bytes: 355132928; Read time: 27901; Write time: 838 02:21:04 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 1155072; Write bytes: 298662912; Read time: 15; Write time: 1092 02:21:04 INFO - Running post-run listener: _upload_blobber_files 02:21:04 INFO - Blob upload gear active. 02:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:04 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 02:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:21:04 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:05 INFO - (blobuploader) - INFO - Done attempting. 02:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:06 INFO - (blobuploader) - INFO - Done attempting. 02:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:08 INFO - (blobuploader) - INFO - Done attempting. 02:21:08 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:08 INFO - Return code: 0 02:21:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7cb8373222ee25c403c7170f73b72eb993ce4e4196483cc42d19d19f0afae4e12a3c13623f188d125f294838e4227e2e72e5d4022531c6e512566ad6a28a181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b8efbc6c8d21625ef1420a7e5d48110e20c4f0d8631ff2c972fb390f50f495ecdc46e9025a070db6ceb9200cf20a3a89b238d0eaaf38a5ba4113904c3eba114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d94c54441d8236ff132b898aa822f083cff9d8ef968c0210c8b5a34e9007e2ac6b73b94cc3741a80226c89285a9b31860c3ff76401534c2d7dd94cfccd12db"} 02:21:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:08 INFO - Contents: 02:21:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7cb8373222ee25c403c7170f73b72eb993ce4e4196483cc42d19d19f0afae4e12a3c13623f188d125f294838e4227e2e72e5d4022531c6e512566ad6a28a181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b8efbc6c8d21625ef1420a7e5d48110e20c4f0d8631ff2c972fb390f50f495ecdc46e9025a070db6ceb9200cf20a3a89b238d0eaaf38a5ba4113904c3eba114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d94c54441d8236ff132b898aa822f083cff9d8ef968c0210c8b5a34e9007e2ac6b73b94cc3741a80226c89285a9b31860c3ff76401534c2d7dd94cfccd12db"} 02:21:08 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:08 INFO - Copying logs to upload dir... 02:21:08 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.881105 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-16 02:21:08.853879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:08.859973) ========= 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.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7cb8373222ee25c403c7170f73b72eb993ce4e4196483cc42d19d19f0afae4e12a3c13623f188d125f294838e4227e2e72e5d4022531c6e512566ad6a28a181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b8efbc6c8d21625ef1420a7e5d48110e20c4f0d8631ff2c972fb390f50f495ecdc46e9025a070db6ceb9200cf20a3a89b238d0eaaf38a5ba4113904c3eba114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d94c54441d8236ff132b898aa822f083cff9d8ef968c0210c8b5a34e9007e2ac6b73b94cc3741a80226c89285a9b31860c3ff76401534c2d7dd94cfccd12db"} build_url:https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7cb8373222ee25c403c7170f73b72eb993ce4e4196483cc42d19d19f0afae4e12a3c13623f188d125f294838e4227e2e72e5d4022531c6e512566ad6a28a181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b8efbc6c8d21625ef1420a7e5d48110e20c4f0d8631ff2c972fb390f50f495ecdc46e9025a070db6ceb9200cf20a3a89b238d0eaaf38a5ba4113904c3eba114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d94c54441d8236ff132b898aa822f083cff9d8ef968c0210c8b5a34e9007e2ac6b73b94cc3741a80226c89285a9b31860c3ff76401534c2d7dd94cfccd12db"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:08.897464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:08.897822) ========= 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.WhAeKBZoxT/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.c9JhEkswKN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005306 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:08.946463) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 02:21:08.946880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 02:21:08.947440) ========= ========= Total master_lag: 0.23 =========