builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1476608401.98 results: success (0) buildid: 20161016004034 builduid: 379722e4d4cf460cab1dcee7798e1189 revision: df83c59042d9b82f1d27b4afb9066744da22cd98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:01.977451) ========= 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:01.978530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:01.978986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.158475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.158888) ========= 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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:02-- 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% 33.0M=0s 2016-10-16 02:00:02 (33.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163660 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.353812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.354272) ========= 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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.026977 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.427127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:02.427604) ========= 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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:02,507 truncating revision to first 12 chars 2016-10-16 02:00:02,507 Setting DEBUG logging. 2016-10-16 02:00:02,507 attempt 1/10 2016-10-16 02:00:02,507 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,856 unpacking tar archive at: mozilla-aurora-df83c59042d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625341 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:03.078983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:03.082506) ========= script_repo_revision: df83c59042d9b82f1d27b4afb9066744da22cd98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:03.083058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:03.083504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 02:00:03.118825) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-16 02:00:03.119283) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 --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', 02:00:03 INFO - 'system_bits': '32', 02:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:03 INFO - 'title': 't-yosemite-r7-0182', 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.325193Z] 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:05 INFO - Running post-action listener: _resource_record_post_action 02:00:05 INFO - [mozharness: 2016-10-16 09:00:05.607580Z] Finished clobber step (success) 02:00:05 INFO - [mozharness: 2016-10-16 09:00:05.607713Z] Running read-buildbot-config step. 02:00:05 INFO - Running pre-action listener: _resource_record_pre_action 02:00:05 INFO - Running main action method: read_buildbot_config 02:00:05 INFO - Using buildbot properties: 02:00:05 INFO - { 02:00:05 INFO - "project": "", 02:00:05 INFO - "product": "firefox", 02:00:05 INFO - "script_repo_revision": "production", 02:00:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:00:05 INFO - "repository": "", 02:00:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:00:05 INFO - "buildid": "20161016004034", 02:00:05 INFO - "stage_platform": "macosx64", 02:00:05 INFO - "basedir": "/builds/slave/test", 02:00:05 INFO - "nightly_build": "True", 02:00:05 INFO - "buildnumber": 2, 02:00:05 INFO - "slavename": "t-yosemite-r7-0182", 02:00:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:00:05 INFO - "platform": "yosemite_r7", 02:00:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:00:05 INFO - "branch": "mozilla-aurora", 02:00:05 INFO - "repo_path": "releases/mozilla-aurora", 02:00:05 INFO - "revision": "df83c59042d9b82f1d27b4afb9066744da22cd98", 02:00:05 INFO - "pgo_build": "False", 02:00:05 INFO - "builduid": "379722e4d4cf460cab1dcee7798e1189", 02:00:05 INFO - "slavebuilddir": "test" 02:00:05 INFO - } 02:00:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:00:05 INFO - Running post-action listener: _resource_record_post_action 02:00:05 INFO - [mozharness: 2016-10-16 09:00:05.611249Z] Finished read-buildbot-config step (success) 02:00:05 INFO - [mozharness: 2016-10-16 09:00:05.611393Z] Running download-and-extract step. 02:00:05 INFO - Running pre-action listener: _resource_record_pre_action 02:00:05 INFO - Running main action method: download_and_extract 02:00:05 INFO - mkdir: /builds/slave/test/build/tests 02:00:05 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:05 INFO - trying https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:00:05 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:05 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:06 INFO - Downloaded 1199 bytes. 02:00:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:00:06 INFO - Using the following test package requirements: 02:00:06 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:00:06 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:00:06 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:00:06 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'jsshell-mac.zip'], 02:00:06 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:00:06 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:00:06 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:00:06 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:00:06 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:00:06 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:00:06 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:00:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:00:06 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:06 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:06 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:07 INFO - Expected file size: 16435251 02:00:14 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:14 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:14 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:14 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:14 INFO - Expected file size: 16435251 02:00:21 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:21 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:21 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:22 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:22 INFO - trying https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:00:22 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:22 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:26 INFO - Running post-action listener: _resource_record_post_action 02:00:26 INFO - Running post-action listener: set_extra_try_arguments 02:00:26 INFO - [mozharness: 2016-10-16 09:00:26.418624Z] Finished download-and-extract step (success) 02:00:26 INFO - [mozharness: 2016-10-16 09:00:26.418761Z] Running populate-webroot step. 02:00:26 INFO - Running pre-action listener: _resource_record_pre_action 02:00:26 INFO - Running main action method: populate_webroot 02:00:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:26 INFO - '--tppagecycles', 02:00:26 INFO - '7'], 02:00:26 INFO - 'tests': ['tsvgm']}}, 02:00:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['damp', 'tps']}, 02:00:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'tests': ['damp', 'tps']}, 02:00:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['dromaeo_dom']}, 02:00:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['basic_compositor_video']}, 02:00:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:00:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['a11yr', 02:00:26 INFO - 'ts_paint', 02:00:26 INFO - 'tpaint', 02:00:26 INFO - 'sessionrestore', 02:00:26 INFO - 'sessionrestore_no_auto_restore', 02:00:26 INFO - 'tabpaint']}, 02:00:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['tsvgx', 02:00:26 INFO - 'tsvgr_opacity', 02:00:26 INFO - 'tart', 02:00:26 INFO - 'tscrollx', 02:00:26 INFO - 'cart']}, 02:00:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:26 INFO - 'tsvgr_opacity', 02:00:26 INFO - 'tart', 02:00:26 INFO - 'tscrollx', 02:00:26 INFO - 'cart']}, 02:00:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'talos_options': ['--disable-e10s'], 02:00:26 INFO - 'tests': ['tp5o']}, 02:00:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'tests': ['tp5o']}, 02:00:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'talos_options': ['--disable-e10s', 02:00:26 INFO - '--xperf_path', 02:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:26 INFO - 'tests': ['tp5n']}, 02:00:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:26 INFO - 'talos_options': ['--xperf_path', 02:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:26 INFO - 'tests': ['tp5n']}}, 02:00:26 INFO - 'talos.zip': {'path': '', 02:00:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:26 INFO - Running post-action listener: _resource_record_post_action 02:00:26 INFO - [mozharness: 2016-10-16 09:00:26.437361Z] Finished populate-webroot step (success) 02:00:26 INFO - [mozharness: 2016-10-16 09:00:26.437490Z] Running create-virtualenv step. 02:00:26 INFO - Running pre-action listener: _resource_record_pre_action 02:00:26 INFO - Running main action method: create_virtualenv 02:00:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:26 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:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:26 INFO - Using real prefix '/tools/python27' 02:00:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:30 INFO - Installing pip.................done. 02:00:30 INFO - Return code: 0 02:00:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:30 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:30 INFO - 'HOME': '/Users/cltbld', 02:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:30 INFO - 'LOGNAME': 'cltbld', 02:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:30 INFO - 'MOZ_NO_REMOTE': '1', 02:00:30 INFO - 'NO_EM_RESTART': '1', 02:00:30 INFO - 'PAGER': '/bin/cat', 02:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:30 INFO - 'PWD': '/builds/slave/test', 02:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:30 INFO - 'SHELL': '/bin/bash', 02:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:30 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:30 INFO - 'USER': 'cltbld', 02:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:30 INFO - 'XPC_FLAGS': '0x0', 02:00:30 INFO - 'XPC_SERVICE_NAME': '0', 02:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:30 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:30 INFO - Cleaning up... 02:00:30 INFO - Return code: 0 02:00:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:00:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:30 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:30 INFO - 'HOME': '/Users/cltbld', 02:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:30 INFO - 'LOGNAME': 'cltbld', 02:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:30 INFO - 'MOZ_NO_REMOTE': '1', 02:00:30 INFO - 'NO_EM_RESTART': '1', 02:00:30 INFO - 'PAGER': '/bin/cat', 02:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:30 INFO - 'PWD': '/builds/slave/test', 02:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:30 INFO - 'SHELL': '/bin/bash', 02:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:30 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:30 INFO - 'USER': 'cltbld', 02:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:30 INFO - 'XPC_FLAGS': '0x0', 02:00:30 INFO - 'XPC_SERVICE_NAME': '0', 02:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:30 INFO - Downloading/unpacking psutil>=3.1.1 02:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:34 INFO - Installing collected packages: psutil 02:00:34 INFO - Running setup.py install for psutil 02:00:34 INFO - building 'psutil._psutil_osx' extension 02:00:34 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:35 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:35 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:35 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:35 INFO - building 'psutil._psutil_posix' extension 02:00:35 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:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:00:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:00:35 INFO - ^ 02:00:35 INFO - 1 warning generated. 02:00:35 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:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:35 INFO - Successfully installed psutil 02:00:35 INFO - Cleaning up... 02:00:35 INFO - Return code: 0 02:00:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:00:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:35 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:35 INFO - 'HOME': '/Users/cltbld', 02:00:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:35 INFO - 'LOGNAME': 'cltbld', 02:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:35 INFO - 'MOZ_NO_REMOTE': '1', 02:00:35 INFO - 'NO_EM_RESTART': '1', 02:00:35 INFO - 'PAGER': '/bin/cat', 02:00:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:35 INFO - 'PWD': '/builds/slave/test', 02:00:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:35 INFO - 'SHELL': '/bin/bash', 02:00:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:35 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:35 INFO - 'USER': 'cltbld', 02:00:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:35 INFO - 'XPC_FLAGS': '0x0', 02:00:35 INFO - 'XPC_SERVICE_NAME': '0', 02:00:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:00:36 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:36 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 - 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:36 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:36 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:36 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:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:38 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:38 INFO - Installing collected packages: mozsystemmonitor 02:00:38 INFO - Running setup.py install for mozsystemmonitor 02:00:38 INFO - Successfully installed mozsystemmonitor 02:00:38 INFO - Cleaning up... 02:00:38 INFO - Return code: 0 02:00:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:38 INFO - 'HOME': '/Users/cltbld', 02:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:38 INFO - 'LOGNAME': 'cltbld', 02:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:38 INFO - 'MOZ_NO_REMOTE': '1', 02:00:38 INFO - 'NO_EM_RESTART': '1', 02:00:38 INFO - 'PAGER': '/bin/cat', 02:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:38 INFO - 'PWD': '/builds/slave/test', 02:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:38 INFO - 'SHELL': '/bin/bash', 02:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:38 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:38 INFO - 'USER': 'cltbld', 02:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:38 INFO - 'XPC_FLAGS': '0x0', 02:00:38 INFO - 'XPC_SERVICE_NAME': '0', 02:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:39 INFO - Downloading/unpacking 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:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:42 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:42 INFO - warning: no files found matching '*.txt' 02:00:42 INFO - no previously-included directories found matching 'build' 02:00:42 INFO - no previously-included directories found matching 'dist' 02:00:42 INFO - no previously-included directories found matching '.git*' 02:00:42 INFO - Installing collected packages: jsonschema, functools32 02:00:42 INFO - Running setup.py install for functools32 02:00:42 INFO - warning: no files found matching '*.txt' 02:00:42 INFO - no previously-included directories found matching 'build' 02:00:42 INFO - no previously-included directories found matching 'dist' 02:00:42 INFO - no previously-included directories found matching '.git*' 02:00:42 INFO - Successfully installed jsonschema functools32 02:00:42 INFO - Cleaning up... 02:00:42 INFO - Return code: 0 02:00:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:42 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:42 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:42 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:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:42 INFO - 'HOME': '/Users/cltbld', 02:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:42 INFO - 'LOGNAME': 'cltbld', 02:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:42 INFO - 'MOZ_NO_REMOTE': '1', 02:00:42 INFO - 'NO_EM_RESTART': '1', 02:00:42 INFO - 'PAGER': '/bin/cat', 02:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:42 INFO - 'PWD': '/builds/slave/test', 02:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:42 INFO - 'SHELL': '/bin/bash', 02:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:42 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:42 INFO - 'USER': 'cltbld', 02:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:42 INFO - 'XPC_FLAGS': '0x0', 02:00:42 INFO - 'XPC_SERVICE_NAME': '0', 02:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:00:42 INFO - Cleaning up... 02:00:42 INFO - Return code: 0 02:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:42 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:42 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:42 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:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:42 INFO - 'HOME': '/Users/cltbld', 02:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:42 INFO - 'LOGNAME': 'cltbld', 02:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:42 INFO - 'MOZ_NO_REMOTE': '1', 02:00:42 INFO - 'NO_EM_RESTART': '1', 02:00:42 INFO - 'PAGER': '/bin/cat', 02:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:42 INFO - 'PWD': '/builds/slave/test', 02:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:42 INFO - 'SHELL': '/bin/bash', 02:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:42 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:42 INFO - 'USER': 'cltbld', 02:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:42 INFO - 'XPC_FLAGS': '0x0', 02:00:42 INFO - 'XPC_SERVICE_NAME': '0', 02:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:42 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:42 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:42 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:42 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:42 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:42 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:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Downloading docopt-0.6.1.tar.gz 02:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:46 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:46 INFO - Running setup.py install for blobuploader 02:00:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:46 INFO - Running setup.py install for requests 02:00:47 INFO - Running setup.py install for docopt 02:00:47 INFO - Successfully installed blobuploader requests docopt 02:00:47 INFO - Cleaning up... 02:00:47 INFO - Return code: 0 02:00:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:47 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:47 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:47 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:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:47 INFO - 'HOME': '/Users/cltbld', 02:00:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:47 INFO - 'LOGNAME': 'cltbld', 02:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:47 INFO - 'MOZ_NO_REMOTE': '1', 02:00:47 INFO - 'NO_EM_RESTART': '1', 02:00:47 INFO - 'PAGER': '/bin/cat', 02:00:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:47 INFO - 'PWD': '/builds/slave/test', 02:00:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:47 INFO - 'SHELL': '/bin/bash', 02:00:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:47 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:47 INFO - 'USER': 'cltbld', 02:00:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:47 INFO - 'XPC_FLAGS': '0x0', 02:00:47 INFO - 'XPC_SERVICE_NAME': '0', 02:00:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:47 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-mvKmuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Mq_OOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-DweNNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-I7x74Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RdJ0EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-uEWOXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-FrKsMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-EdMtzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-A08Z8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fA2BS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fnSerz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-HKLVn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-3JV6oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-kcKm_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-vKnFRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-mtzrXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-bGjmsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:49 INFO - Running setup.py install for manifestparser 02:00:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:49 INFO - Running setup.py install for mozcrash 02:00:50 INFO - Running setup.py install for mozdebug 02:00:50 INFO - Running setup.py install for mozdevice 02:00:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Running setup.py install for mozfile 02:00:50 INFO - Running setup.py install for mozhttpd 02:00:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Running setup.py install for mozinfo 02:00:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Running setup.py install for mozInstall 02:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:50 INFO - Running setup.py install for mozleak 02:00:51 INFO - Running setup.py install for mozlog 02:00:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Running setup.py install for moznetwork 02:00:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Running setup.py install for mozprocess 02:00:51 INFO - Running setup.py install for mozprofile 02:00:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Running setup.py install for mozrunner 02:00:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:51 INFO - Running setup.py install for mozscreenshot 02:00:52 INFO - Running setup.py install for moztest 02:00:52 INFO - Running setup.py install for mozversion 02:00:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:52 INFO - Cleaning up... 02:00:52 INFO - Return code: 0 02:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:52 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:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:52 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:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:52 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:52 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:52 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:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:52 INFO - 'HOME': '/Users/cltbld', 02:00:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:52 INFO - 'LOGNAME': 'cltbld', 02:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:52 INFO - 'MOZ_NO_REMOTE': '1', 02:00:52 INFO - 'NO_EM_RESTART': '1', 02:00:52 INFO - 'PAGER': '/bin/cat', 02:00:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:52 INFO - 'PWD': '/builds/slave/test', 02:00:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:52 INFO - 'SHELL': '/bin/bash', 02:00:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:52 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:52 INFO - 'USER': 'cltbld', 02:00:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:52 INFO - 'XPC_FLAGS': '0x0', 02:00:52 INFO - 'XPC_SERVICE_NAME': '0', 02:00:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-qaBPfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-vrxWMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:52 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-a4w8N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-sxETHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-gPkBC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-lUYnCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-37Em1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-zsV7QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-5W182M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xqIGfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-uidyfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ByzGem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:53 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-u9f07u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-WosiAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-yqSLJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-8XPm2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xeqCzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:54 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:54 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:54 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:54 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:54 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:54 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:57 INFO - Downloading blessings-1.6.tar.gz 02:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:57 INFO - Installing collected packages: blessings 02:00:57 INFO - Running setup.py install for blessings 02:00:57 INFO - Successfully installed blessings 02:00:57 INFO - Cleaning up... 02:00:57 INFO - Return code: 0 02:00:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:00:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:57 INFO - Reading from file tmpfile_stdout 02:00:57 INFO - Current package versions: 02:00:57 INFO - blessings == 1.6 02:00:57 INFO - blobuploader == 1.2.4 02:00:57 INFO - docopt == 0.6.1 02:00:57 INFO - functools32 == 3.2.3-2 02:00:57 INFO - jsonschema == 2.5.1 02:00:57 INFO - manifestparser == 1.1 02:00:57 INFO - mozInstall == 1.12 02:00:57 INFO - mozcrash == 0.17 02:00:57 INFO - mozdebug == 0.1 02:00:57 INFO - mozdevice == 0.48 02:00:57 INFO - mozfile == 1.2 02:00:57 INFO - mozhttpd == 0.7 02:00:57 INFO - mozinfo == 0.9 02:00:57 INFO - mozleak == 0.1 02:00:57 INFO - mozlog == 3.4 02:00:57 INFO - moznetwork == 0.27 02:00:57 INFO - mozprocess == 0.23 02:00:57 INFO - mozprofile == 0.28 02:00:57 INFO - mozrunner == 6.12 02:00:57 INFO - mozscreenshot == 0.1 02:00:57 INFO - mozsystemmonitor == 0.3 02:00:57 INFO - moztest == 0.7 02:00:57 INFO - mozversion == 1.4 02:00:57 INFO - psutil == 3.1.1 02:00:57 INFO - requests == 1.2.3 02:00:57 INFO - wsgiref == 0.1.2 02:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:57 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:57 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:57 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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:57 INFO - 'HOME': '/Users/cltbld', 02:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:57 INFO - 'LOGNAME': 'cltbld', 02:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:57 INFO - 'MOZ_NO_REMOTE': '1', 02:00:57 INFO - 'NO_EM_RESTART': '1', 02:00:57 INFO - 'PAGER': '/bin/cat', 02:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:57 INFO - 'PWD': '/builds/slave/test', 02:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:57 INFO - 'SHELL': '/bin/bash', 02:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:57 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:57 INFO - 'USER': 'cltbld', 02:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:57 INFO - 'XPC_FLAGS': '0x0', 02:00:57 INFO - 'XPC_SERVICE_NAME': '0', 02:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Cleaning up... 02:00:58 INFO - Return code: 0 02:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:00:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 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 0x10bc8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad10dcff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, '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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:58 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:58 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:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:00:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:58 INFO - 'HOME': '/Users/cltbld', 02:00:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:58 INFO - 'LOGNAME': 'cltbld', 02:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:58 INFO - 'MOZ_NO_REMOTE': '1', 02:00:58 INFO - 'NO_EM_RESTART': '1', 02:00:58 INFO - 'PAGER': '/bin/cat', 02:00:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:58 INFO - 'PWD': '/builds/slave/test', 02:00:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:58 INFO - 'SHELL': '/bin/bash', 02:00:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:00:58 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:00:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:58 INFO - 'USER': 'cltbld', 02:00:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:58 INFO - 'XPC_FLAGS': '0x0', 02:00:58 INFO - 'XPC_SERVICE_NAME': '0', 02:00:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:00:58 INFO - Cleaning up... 02:00:58 INFO - Return code: 0 02:00:58 INFO - Running post-action listener: _resource_record_post_action 02:00:58 INFO - Running post-action listener: _start_resource_monitoring 02:00:58 INFO - Starting resource monitoring. 02:00:58 INFO - [mozharness: 2016-10-16 09:00:58.354172Z] Finished create-virtualenv step (success) 02:00:58 INFO - [mozharness: 2016-10-16 09:00:58.355143Z] Running install step. 02:00:58 INFO - Running pre-action listener: _resource_record_pre_action 02:00:58 INFO - Running main action method: install 02:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:58 INFO - Reading from file tmpfile_stdout 02:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:00:58 INFO - Reading from file tmpfile_stdout 02:00:58 INFO - Output received: 02:00:58 INFO - Usage: mozinstall [options] installer 02:00:58 INFO - Options: 02:00:58 INFO - -h, --help show this help message and exit 02:00:58 INFO - -d DEST, --destination=DEST 02:00:58 INFO - Directory to install application into. [default: 02:00:58 INFO - "/builds/slave/test"] 02:00:58 INFO - --app=APP Application being installed. [default: firefox] 02:00:58 INFO - mkdir: /builds/slave/test/build/application 02:00:58 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:58 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:31 INFO - Reading from file tmpfile_stdout 02:01:31 INFO - Output received: 02:01:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:01:31 INFO - Running post-action listener: _resource_record_post_action 02:01:31 INFO - [mozharness: 2016-10-16 09:01:31.036252Z] Finished install step (success) 02:01:31 INFO - [mozharness: 2016-10-16 09:01:31.036412Z] Running run-tests step. 02:01:31 INFO - Running pre-action listener: _resource_record_pre_action 02:01:31 INFO - Running main action method: run_tests 02:01:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:01:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:01:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:01:31 INFO - 2016-10-16 02:01:31.050 screenresolution[1648:8466] starting screenresolution argv=screenresolution get 02:01:31 INFO - 2016-10-16 02:01:31.053 screenresolution[1648:8466] Display 0: 1600x1200x32@60 02:01:31 INFO - 2016-10-16 02:01:31.059 screenresolution[1649:8469] starting screenresolution argv=screenresolution list 02:01:31 INFO - Available Modes on Display 0 02:01:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:01:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:01:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:01:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:01:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:01:31 INFO - Intel Iris: 02:01:31 INFO - Chipset Model: Intel Iris 02:01:31 INFO - Type: GPU 02:01:31 INFO - Bus: Built-In 02:01:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:01:31 INFO - Vendor: Intel (0x8086) 02:01:31 INFO - Device ID: 0x0a2e 02:01:31 INFO - Revision ID: 0x0009 02:01:31 INFO - Displays: 02:01:31 INFO - Display: 02:01:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:01:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:01:31 INFO - Display Serial Number: 1600x1200 60 02:01:31 INFO - Main Display: Yes 02:01:31 INFO - Mirror: Off 02:01:31 INFO - Online: Yes 02:01:31 INFO - Rotation: Supported 02:01:31 INFO - Return code: 0 02:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:31 INFO - Python 2.7.3 02:01:31 INFO - Return code: 0 02:01:31 INFO - grabbing minidump binary from tooltool 02:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:31 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 0x10ba9fd30>, '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 0x10b905db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba97b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:31 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:31 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:31 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:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:31 INFO - Return code: 0 02:01:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:01:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:01:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:31 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', '--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-0182', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:01:31 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 --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-0182 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:01:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4FHXbkvbY/Render', 02:01:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:31 INFO - 'HOME': '/Users/cltbld', 02:01:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:31 INFO - 'LOGNAME': 'cltbld', 02:01:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:31 INFO - 'MOZ_NO_REMOTE': '1', 02:01:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:31 INFO - 'NO_EM_RESTART': '1', 02:01:31 INFO - 'PAGER': '/bin/cat', 02:01:31 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:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:31 INFO - 'PWD': '/builds/slave/test', 02:01:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:31 INFO - 'SHELL': '/bin/bash', 02:01:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8U5dq4nQOU/Listeners', 02:01:31 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:01:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:31 INFO - 'USER': 'cltbld', 02:01:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:31 INFO - 'XPC_FLAGS': '0x0', 02:01:31 INFO - 'XPC_SERVICE_NAME': '0', 02:01:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-0182', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:01:31 INFO - mozversion application_buildid: 20161016004034 02:01:31 INFO - mozversion application_changeset: df83c59042d9b82f1d27b4afb9066744da22cd98 02:01:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:01:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:31 INFO - mozversion application_name: Firefox 02:01:31 INFO - mozversion application_remotingname: firefox-dev 02:01:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:31 INFO - mozversion application_vendor: Mozilla 02:01:31 INFO - mozversion application_version: 51.0a2 02:01:31 INFO - mozversion platform_buildid: 20161016004034 02:01:31 INFO - mozversion platform_changeset: df83c59042d9b82f1d27b4afb9066744da22cd98 02:01:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:31 INFO - mozversion platform_version: 51.0a2 02:01:31 INFO - using testdate: 1476608491 02:01:31 INFO - actual date: 1476608491 02:01:31 INFO - starting webserver on 'localhost:49272' 02:01:31 INFO - SUITE-START | Running 2 tests 02:01:31 INFO - TEST-START | dromaeo_css 02:01:31 INFO - operating with platform_type : mac_ 02:01:31 INFO - Initialising browser for dromaeo_css test... 02:01:31 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp6uSaxi/profile http://localhost:49272/getInfo.html) 02:01:34 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 02:01:34 INFO - PROCESS | 1659 | colorDepth:24 02:01:34 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 02:01:34 INFO - PROCESS | 1659 | __metrics 02:01:34 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:01:34 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:01:35 INFO - TEST-INFO | 1659: exit 0 02:01:35 INFO - Browser initialized. 02:01:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:35 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp6uSaxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:47 INFO - PROCESS | 1664 | RSS: Main: 219582464 02:01:47 INFO - PROCESS | 1664 | 02:02:38 INFO - PROCESS | 1664 | 1476608558347 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:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:04:51 INFO - PROCESS | 1664 | RSS: Main: 336748544 02:04:51 INFO - PROCESS | 1664 | 02:07:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:07:55 INFO - PROCESS | 1664 | RSS: Main: 351535104 02:07:55 INFO - PROCESS | 1664 | 02:10:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:10:58 INFO - PROCESS | 1664 | RSS: Main: 348663808 02:10:58 INFO - PROCESS | 1664 | 02:14:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:14:01 INFO - PROCESS | 1664 | RSS: Main: 324038656 02:14:01 INFO - PROCESS | 1664 | 02:17:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:17:05 INFO - PROCESS | 1664 | RSS: Main: 311111680 02:17:05 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:20:08 INFO - PROCESS | 1664 | RSS: Main: 483426304 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | __start_tp_report 02:20:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:20:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:20:08 INFO - PROCESS | 1664 | |i|pagename|runs| 02:20:08 INFO - PROCESS | 1664 | |0;dojo.html;2745.588161775733;3309.205790610254;3336.1659585103707;3355.3289342131548;3392.7964322140656;5739.913901291478;5767.942320576793;5854.560907931901;5859.853503662411;5874.823755287348;5749.3388260350075;5797.739101740422;5811.244538210038;5821.854453638661;5843.678597677126;5285.392179899322;5297.602679799012;5308.893822123575;5343.572514198855;5359.624826262163;5229.954009198156;5234.476552344754;5253.080710875601;5387.865303367427;5419.891602167954;5322.733863306819;5335.573154147678;5341.813036543722;5359.490848369399;5360.624756267063;5344.652597581145;5359.08895487768;5359.517643412073;5367.194920761878;5369.40936496985;5106.9489305106845;5264.210368444726;5274.55166310864;5281.973590132063;5309.097453432887;5817.650940943557;5867.149263356832;5880.705964701748;5891.882162356772;5909.349971503131;6256.03031530109;6260.561760676755;6270.498360131179;6281.7173227204885;6285.654289014103;4865.951340486586;6162.876742465126;6169.2288463942;6213.254409470847;6261.0295404211965;5735.856603584902;5825.271841019872;5835.67903765297;5852.356240813507;5853.678047707332;6320.905186422207;6331.873362532723;6341.4292713656;6350.301466838644;6353.8729225416155;6117.327094019654;6122.581127188521;6139.43080903429;6224.502039836802;6225.688715564203;5276.683398996072;6142.406692085091;6249.25008998923;6273.404026617464;6307.117003619497;6259.155014073133;6294.3076261612105;6295.401936815995;6300;6311.652859092702;6105.938940610537;6184.381561843779;6282.717277722513;6286.937130628727;6292.559520833498;4963.776630051584;4983.401991761012;5012.298278241049;5018.04657115147;5053.823116190915;4443.155800397914;4456.5766252205985;4470.351798989193;4474.574915383034;4491.124230774967;5823.82528524145;5867.589268751147;5868.589198756046;5892.793752218738;5901.5868889177345;6130.386961303834;6186.721597528122;6242.469390101892;6248.687565621701;6252.968735156386;5877.853053673693;5954.493868021266;5962.612430192024;5998.970005149947;6004.969975150097;5465.672059676433;5469.316335458067;5472.261244731911;5476.2333273341765;5476.726163691879;6188.535859810622;6256.343083976299;6361.840953976188;6443.387878151568;6454.354564543508;5246.6065045121;6190.102435146969;6224.595401298901;6232.283287421823;6263.812085637438;6415.1981002374705;6423.4861211103935;6430.678466076771;6445.613263204223;6451.387118223761;6105.236845394325;6203.96898015507;6219.782307619212;6243.843903902439;6268.1851359323;6181.690915454119;6188.845278868064;6208.255009398901;6210.503159747119;6281.748730050746;5159.767810448464;5965.8664853677665;6203.875922481435;6218.253809542884;6221.129041934223;6153.784617538365;6208.2860471044605;6211.09939058843;6211.192544969125;6230.968845155927;5857.824265272048;5926.318473375444;5947.226860508279;5950.404959504188;5959.344472107978;6161.4146656067605;6166;6169.352218017044;6171.475424588781;6179.660118693515;5829.94170058294;5903.321118071477;6012.38195487213;6041.758329666764;6065.150878877049 02:20:08 INFO - PROCESS | 1664 | |1;ext.html;459.7999870056525;492.8693896117529;534.02540363836;537.9596530260231;548.4625067433917;29674.258143546394;38908.61091389085;39726.205475890536;39736.60263397365;42121.15757684852;40884.59115408853;41391.17217655645;41397;41420;41425.7928710356;8746.256568191711;9648.855267170999;9840;9847.803043939117;9854.507274636275;8649.48103113812;11837.64487065385;11993.580224692138;12019.93990030053;12266.264024158534;11831.11266655;12044.518219271218;12083.516659333616;12118.272903625812;12154;12066.215695979734;12135.271883687006;12137.211081279776;12157.939210303935;12182.269063856196;11877.109216808687;11934.925856672855;11954;11965.282083074957;11970.401479926057;38776;39035.60964390348;39084.60915390866;39086.804565977276;39156;3426.3318652862454;3434.708049815769;3442.862285508577;3573.714102871764;3612.7651702639246;28481.715182848115;29017.41965160685;29611.407771844442;30822.7670893164;31187.220319491968;2658.8138830281887;3117.9688203117908;3225.6129264488177;3240.7245384142375;3292.506124081383;488084;488959;490948;491392;493353;32876.1780955478;60462.69768651129;60999.695001524706;61070.38929610736;61097;32984.3403131936;33896;34216.315673686884;34231.973040808814;34270;14640.560783176308;14768.261586920826;14774.89188310881;14780.63048423798;14791.556253312418;11524;11748.17762756616;12436.502539898484;12519.56181533642;12563.057770667236;7618.885716714254;7737.3036426721865;7805;7811.336036436853;7818.374530037583;3187.9043628691174;3225.870965161367;3238.5304130900886;3239.773215874913;3271.084096452997;891.2201823404521;921.861720741894;943.061653654618;948.2177203806887;969.7139343893568;22822.885885570468;28242.43515129686;28857.422851543273;29614.551840432883;29944.101676949726;995.6664517386756;1008.6448193009892;1019.7756493571402;1113.6826004588654;1156.7223866272034;12433.316167610687;14809.333579988926;15204.391824326904;15256.542303730906;15587.298571564306;344128;346070;348221;348562.514374853;348708;46319.07361852744;54738.45261547333;54774.72612636911;55047;55335.44664553383;1207.3782002268838;1222.407132540735;1222.8715984821822;1345.8048582955416;1356.7490014347377;28762.280942976595;31046;31083;31475.685243148193;31589.8420507896;50978.74510627572;51554.711132220495;51604.483955159965;51691.483085168664;51695.22457163221;589951;592309;594125;594546;600400;25405;25802.870985644953;26081.608775867997;26081.869590651924;26099.08653197129;45279.54720452753;45343;45367.773161133984;45655;46185.5360847931;36751.816240918626;37400.6259937408;37612.811935940146;37878.62121378861;39036.414453783786;32332.191695207806;34775.65224347724;35515;36661.450078248316;37455.62544374631;35531.75638852628;36313.63686363103;37029;37201;37480.625193747714;25381.954165500258;31054.844725776227;31927.201819954687;33652;33703.83148084244;21094;24497.142600009625;24638.630420543348;25256.242312730647;25346.74653253444 02:20:08 INFO - PROCESS | 1664 | |2;jquery.html;330.48279442672214;352.1513153300546;372.9291434627422;380.18260739410266;399.9240144372569;15068.246587670614;15353.923230383847;15998.760018599716;19335.12991915364;20353.28763493278;17881.91059044703;20017.499562510944;20586;20864.374068777925;21228.575428491422;5893.292804863422;6142.631442113465;6162.260528736558;6167.969160154193;6170.784022559212;5080.618953578496;6814.795556133324;6898.172219333687;6937.757178498754;6973.442124630017;6600.603963762165;6713.93286067138;6847.315268473138;6865.759698410557;6879.965600172017;6724.293949135319;6793.252742198354;6797.898031529531;6828.829279268058;6835.521513494057;5746.396628354005;5851.32709738377;5906.291245050578;5913.467787899067;5916.408359164092;25824.74175258242;25894;25957.36596876439;26037.828297726457;26153.73846261532;2392.545416370884;2418.2019933422102;2761.144045345949;3103.7982531135403;3269.885554005622;15989.520314390587;16006;16200.432984845474;16600;16702.49892503227;1683.4612923864368;1843.861710371714;1902.258119333461;1909.5798924236647;1940.8544359173118;122505.38747306296;123566;123730;124730.37634811767;126945;9480.336376453582;9796.363236389612;10139.340942838839;10158.15571639942;10690.893091069145;12426.192297500633;12505.06212034101;12513.436895339732;12526.37368131608;12536.937315313366;8082.676692932217;8188.590570471452;8249.133840946613;8312.667493300321;8325.95837020811;8406;8609.65561377538;8656.91343086561;8780.385373023826;8808.691695790745;3786.9431958520645;3844.7116466264583;3917.3536366499206;3971.4241434991764;3980.920381592352;1867.1504465468179;1905.123263871564;1922.5866438715743;1933.3180133283852;1936.932207372735;831.4720152703077;882.9205371516595;896.421807933879;943.7829299261208;1032.5972870580479;20559.97200139987;21388.465288367603;21458.3520801461;21470.677939830915;21492.355229343146;897.8294124116397;929.4980710416299;946.7207173883721;947.3842002698301;983.6655537117415;9140.862887056699;11399.259048161843;11431.028362589273;11436.714082148013;11461.140414468948;486022;593437;602946;607927;608423;91497;127469.36265318614;131828.34085829702;133752;136792;842.5636194111779;884.712468447757;917.1424717888796;917.7200953709049;951.8048799995984;19551.804481954998;19645.50886227856;20111;20142.194312227348;20142.697859531825;42478;55915.44084559265;56872;57016;58181;76736.61631691805;81306.18693812986;83709.74435383597;84078.57960710158;84173.57913210394;7815.520711676474;7977.361811055218;8010.439269251096;8374.115823939808;8454.32365410778;11507.252028618113;12718.936405317914;12991.35043247815;13273.867261327263;13404.195748255135;11134.944325278646;11202.49588768491;11308.434578271219;11587.88412115868;11693.88306116928;10670.413127277763;10766.246362754531;10814.29707069038;11061.502232399722;11555.8266625999;11366.659000230007;11447.828282575934;11746.76506469883;11875.990540804129;11884.227525210834;7937.722179723913;8031.518108913484;8136.22705842944;8185.549794761345;8405.831883362422;8292.87560686578;10734.892651073389;11188.552457901918;11410.714732131431;11534.307941523535 02:20:08 INFO - PROCESS | 1664 | |3;mootools.html;1523.1546491697106;1532.1573134775872;1736.340190727524;1838.209569884949;1893.4887580353297;6898.413634841038;8901.06538813425;8909.376343655938;8910.198082172603;8926.732198034053;7197.49617526772;7796.298333150015;7974.681012759483;8000.359971202304;8704.347173961947;2346.1905642553293;2398.4963157736897;2399.8560086394787;2401.2796161151673;2402.9279121626378;2361.6103342948395;2379.2981070584133;2402.255300856731;2406.302172370011;2411.6744239527616;2345.495718420539;2368.301351101429;2391.1033362489065;2392.83250172488;2397.2328854766483;1998.3505360757813;2386.129062892049;2400.7959323457612;2404.927852164438;2405.3625789165885;2347.401412639783;2360.3037104054347;2366.7514910934447;2368.857868527894;2374.5250949810106;8767.167119123673;8823.11768823119;8853.822923541558;8873.689420870303;8921.330900182513;5167.741612919339;5322;5332.920006199872;5336.546393556514;5339.813106541291;3572.2676851245433;3575.4636804479537;3592.9281414371567;3648.5804132524836;3649.3978493548534;1086.3319058778793;1090.6019302954364;1092.5302120088359;1103.7406209540752;1117.3463523838564;11107;11578.015868651091;11683.240589361665;11691.181617286793;11712.590059347967;4552.203364411281;4613.284940834176;4811.78346974387;4812.879678008007;4821.445533763592;9878.012198780209;9897;9912.008799120174;9924.454155021398;9929.553170107363;5298.28473156119;5312.574994000471;5317.893642127213;5329.25390445338;5331.893362132813;3780.4140358244517;4362.083962367875;4525.637948964075;4709.7174169549935;4874.390701162355;3874.6512813846325;3921.254961557295;3985.362342025262;4015.0966032642423;4024.69814763888;1153.6712037069394;1220.742635085863;1273.5669872243482;1274.4010315151863;1290.8580056193812;835.8787975743484;896.090468174803;903.263839970422;920.4431319052011;923.7644400677784;5764.423557644202;5863.20846685692;6069.089636554464;6074.605150665193;6119.4798442132915;381.67176228443515;429.6433959813347;447.9417675702203;454.20287395620477;464.579555502271;3970.3647416413814;3982.820773065219;3984.163325701635;3989.7007724420782;4028.738132021409;10512;10768.3538987661;10859.40273284961;10870.61952831647;10894.727631809268;10761.78476430467;10814;10821.835632873457;10826.945865270623;10835.729106772395;6482.416582507692;8084.676612935416;8173.918260817316;8183.345332373396;8197;5831.679257640871;6037.245344331958;6116.938830611637;6139.140520327069;6211.689415529115;9567.282453815853;9804.36271642341;10041.748956276151;10151.441670708182;10174.542145603318;8673.653053877773;9946.552405141641;10183.981601839756;10312.793744125225;10315.742106447398;7517.361024312776;7525.510841795266;7547.886781698388;7579.772606821804;7620.5808680523105;8247.463914845515;8326.833463330579;8328.583570821556;8332.208440198172;8334.458260213067;7342.48602597813;7454.018392642986;7463.2536746327105;7545.170031296663;7600.543967361976;7275.163356214103;7303.488755787044;7307.196208417176;7312.7440539582985;7416.110066792019;6870.3473170048765;7028.789136325714;7035.015097886402;7038.577685338896;7046.788596342118;4951.504849515164;5049.394072711299;5112.3865136183895;5120.641555091108;5174.818881339135;4787.928181077356;4945.703257804399;4987.950120498894;5169.431362550041;5227.215917612389 02:20:08 INFO - PROCESS | 1664 | |4;prototype.html;298.741588525925;302.4269010225621;307.71536328895763;312.62328893683116;315.0909625729769;4429.335599660053;5180.974095129519;5231.058409486291;5359.598030147735;5451.945480545193;4953.678010929296;5149.253358263049;5275.683458992454;5338.466153384659;5377.435369286227;4114.6296833285;4124.917501649973;4130.8554200602985;4131.917361652765;4147.543770185277;3819.2934307153264;3997.060690737674;4111.600587371514;4128.731632443896;4148.937765933513;3432.6567343265724;3637.1816341323256;4091.672666186698;4098.073905264521;4107.301758701028;3905.882823515299;3926.7630696330707;4027.637512623878;4065;4092.2224777292217;2982.6719060903283;3509.31568344173;3515.9979405869462;3531.6644918732677;3584.211473475831;4948.752562371903;5169.741512924376;5241.554467870197;5298.735063246861;5372.838814835562;3913.941290880639;4572.245579479382;4600.435851810367;4637.118947399983;4639.884002899921;4665.346851440801;5387.057264978613;5644.74598643062;5679.630823996468;5680.715964201773;3288.819114948677;3623.420252759572;3795.734298599099;3847;3869.3228684980018;5741.88516229673;5864.149698293723;5959.36117567668;6026.337102918676;6051.304100028465;3284.2593425484533;3293.2754793945774;3842.9624001519433;3941.4825292262685;3947.381573554886;3510.3856825055514;3672.265546890633;3787.901508562486;3828.5979972103087;3997.5802540733384;3770.490983717163;4270.7010509264055;4508.752018638941;4566.360709500673;4595.195840727859;4936.407631084293;4980.950190498121;5692.430756924275;5723.941070901897;5742.770289188469;1260.552503861116;1305.4843336882068;1313.238321773369;1315.8223639808696;1332.5275570494464;880.9560670605225;891.2068259249273;911.886014248219;914.6112902016616;917.0233701108432;5326.067938110815;5336.386315573759;5342.171963345688;5348.866278343073;5376.903007826951;5756.913646295309;5770.682612456355;5771.365149833515;5780.364159942403;5785.479306862402;5068.391792984866;5329.413764485904;5333.893322133536;5346.224797404355;5376.569874410038;2738.7261273872455;2819.2528979820363;2826.590144429046;2912.5339945608603;3089.351236240415;5441.59188060897;5762.271318604402;6062.818115456455;6106.236720409949;6160.8767824643255;4623.838165664186;5818.650880947157;5889.705514724246;5975.223220981332;6007.279126504847;5055.772490237948;5986.73059712314;5995.400459954057;6002.999999999913;6066;5436.130219164915;5556.833295001156;5686.606781338599;5773.595848290579;5842.721338677834;5127.6410651254055;5278.261043453843;5491.862703432286;5698.951061182248;5751.309842818889;5693.348928810764;5935.673537955454;6015.789447369321;6018.157457955802;6018.712889102113;2792.9022484212956;3433.7081348084694;3784.5647750509042;3862.1268684688466;3897.1940203053755;4760.78576464053;5503.6697798130635;5786.623869448473;5802.622829516068;5851.678157701367;4940.7648087978005;5333.493318134771;5486.396496385315;5614.466625670555;5636.830895073154;4750.691205071659;4816.638752093677;5644.867098760227;5669.177969194526;5677.9495793278375;4779.569838714532;5265.077881775651;5493.258410114743;5548.9722551386985;5551.611387202857;5243.501867322599;5622.7750889963945;5636.802711905064;5643.717814109196;5727.427257274406;4627.251925939865;5494.203340515683;5495.148252020943;5512.747478987257;5518.972405137949 02:20:08 INFO - PROCESS | 1664 | |5;yui.html;737.5095561451635;750.5571712689514;770.4529783853463;784.2745460449083;791.6041979010495;13265.602031939034;17442.215100320485;17470.213840377182;17490.212940417663;17518;16593;16731.996080235163;16736;16744.66510669789;16745.162741862918;674.4166296153841;695.5027155583757;699.8775214337496;845.4166625028726;858.8024754306513;831.6922738586701;843.8734289723196;859.0593300336153;859.9398042137053;860.3031544449017;913.7441516375426;916.1434059154711;916.170865366844;916.5508900638706;917.1149840404008;718.8741970155202;741.6365980669487;910.4218821048648;910.9635614575409;911.6809116809097;647.588781123985;664.64773669955;665.7403612591094;665.7470161338708;667.7963221217527;15391.153486558234;15403.152826594533;15449.691006179926;15454.381824726997;15465.226738663021;13465.730685386336;13609.094726738265;13712.794308085287;13723;13850.030497865153;12459.252444853248;12707.301098439582;12772.61682149537;12912.741745165044;13290.069695121345;4491.887702807423;4517.299818528133;4518.299663552155;4624.144533261324;4650.139724151043;119049;120750;121230.78769212372;121449;121672;10371.429571373495;10743.83884241737;10744.73138171552;10865.674029779118;11153.442327883573;20958.47603809917;20985.265515706877;21003.949802509815;21113.472163196042;21132.894335528224;6787.864242715217;7702.8844567331535;7805.41459390548;7815.843683126305;8113.432059755878;4334.50153232376;4350.0647360817575;4359.019220675323;4396.340548917688;4501.864944051684;3652.160003199279;3812.5615554211067;3813.771173729585;3815.04623844039;3817.3319669057805;583.7489879351834;602.4367216652444;679.942204912588;686.8763622547889;709.6487238816716;511.66230288009734;563.6702529020487;660.3660485933558;671.993280067193;676.922153952292;8910.198082172636;9553.474558899326;9592.712218633453;9803.950980245196;9813.362131461432;575.7524264566193;591.5031373646158;609.1441524657863;610.8320211941663;685.6263336481629;3478.8782392616135;3995.400689896481;4755.524447555217;4766.189747742892;4777.235642297216;130188;130946.34526827304;132494;136406;143085;120508.82011354617;126199;127606.36196818957;130162;131040;107627;109500.452497737;110635.44682276537;111461;120060;8829.779255518664;9871.170002931149;9894.257930655374;9916.623111575642;10035.899641003496;54011.45988540064;59987;61511;64078.67960660167;64906;70549.64725176341;76189.23810761822;82995;91358;96133.5193324029;12917.22496650204;12931.612051638465;13388.598342049754;13390.598282051555;13624.250666213453;13171.868281317447;14282.785758213427;14884.851151488347;15011.699766004836;15230.771538427154;13190.208587484782;13544.729105418033;13839.238841863795;14137.787933181216;14799;12487.31319777421;12730.17253878495;12873.678158046123;13255;13316.06787524864;13299.933500332436;13336.133151345519;13670.52153174634;13677.589672309847;13781.793273101111;10750.408727520062;11131.443427828739;11809.527618895148;11855.466504007512;12249.877501224873;9767.951160244153;9903.653372131941;11601.245919015237;11693.181477296508;11867.465964031811 02:20:08 INFO - PROCESS | 1664 | __end_tp_report 02:20:08 INFO - PROCESS | 1664 | __start_cc_report 02:20:08 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1172 02:20:08 INFO - PROCESS | 1664 | __end_cc_report 02:20:08 INFO - PROCESS | 1664 | __startTimestamp1476609608449__endTimestamp 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:20:08 INFO - PROCESS | 1664 | Number of tests: 6 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5783.22 Median:5959.34 stddev:653.29 (11.0%) stddev-sans-first:610.29 02:20:08 INFO - PROCESS | 1664 | Values: 2745.6 3309.2 3336.2 3355.3 3392.8 5739.9 5767.9 5854.6 5859.9 5874.8 5749.3 5797.7 5811.2 5821.9 5843.7 5285.4 5297.6 5308.9 5343.6 5359.6 5230.0 5234.5 5253.1 5387.9 5419.9 5322.7 5335.6 5341.8 5359.5 5360.6 5344.7 5359.1 5359.5 5367.2 5369.4 5106.9 5264.2 5274.6 5282.0 5309.1 5817.7 5867.1 5880.7 5891.9 5909.3 6256.0 6260.6 6270.5 6281.7 6285.7 4866.0 6162.9 6169.2 6213.3 6261.0 5735.9 5825.3 5835.7 5852.4 5853.7 6320.9 6331.9 6341.4 6350.3 6353.9 6117.3 6122.6 6139.4 6224.5 6225.7 5276.7 6142.4 6249.3 6273.4 6307.1 6259.2 6294.3 6295.4 6300.0 6311.7 6105.9 6184.4 6282.7 6286.9 6292.6 4963.8 4983.4 5012.3 5018.0 5053.8 4443.2 4456.6 4470.4 4474.6 4491.1 5823.8 5867.6 5868.6 5892.8 5901.6 6130.4 6186.7 6242.5 6248.7 6253.0 5877.9 5954.5 5962.6 5999.0 6005.0 5465.7 5469.3 5472.3 5476.2 5476.7 6188.5 6256.3 6361.8 6443.4 6454.4 5246.6 6190.1 6224.6 6232.3 6263.8 6415.2 6423.5 6430.7 6445.6 6451.4 6105.2 6204.0 6219.8 6243.8 6268.2 6181.7 6188.8 6208.3 6210.5 6281.7 5159.8 5965.9 6203.9 6218.3 6221.1 6153.8 6208.3 6211.1 6211.2 6231.0 5857.8 5926.3 5947.2 5950.4 5959.3 6161.4 6166.0 6169.4 6171.5 6179.7 5829.9 5903.3 6012.4 6041.8 6065.2 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:60815.81 Median:18848.17 stddev:130318.88 (691.4%) stddev-sans-first:130605.67 02:20:08 INFO - PROCESS | 1664 | Values: 459.8 492.9 534.0 538.0 548.5 29674.3 38908.6 39726.2 39736.6 42121.2 40884.6 41391.2 41397.0 41420.0 41425.8 8746.3 9648.9 9840.0 9847.8 9854.5 8649.5 11837.6 11993.6 12019.9 12266.3 11831.1 12044.5 12083.5 12118.3 12154.0 12066.2 12135.3 12137.2 12157.9 12182.3 11877.1 11934.9 11954.0 11965.3 11970.4 38776.0 39035.6 39084.6 39086.8 39156.0 3426.3 3434.7 3442.9 3573.7 3612.8 28481.7 29017.4 29611.4 30822.8 31187.2 2658.8 3118.0 3225.6 3240.7 3292.5 488084.0 488959.0 490948.0 491392.0 493353.0 32876.2 60462.7 60999.7 61070.4 61097.0 32984.3 33896.0 34216.3 34232.0 34270.0 14640.6 14768.3 14774.9 14780.6 14791.6 11524.0 11748.2 12436.5 12519.6 12563.1 7618.9 7737.3 7805.0 7811.3 7818.4 3187.9 3225.9 3238.5 3239.8 3271.1 891.2 921.9 943.1 948.2 969.7 22822.9 28242.4 28857.4 29614.6 29944.1 995.7 1008.6 1019.8 1113.7 1156.7 12433.3 14809.3 15204.4 15256.5 15587.3 344128.0 346070.0 348221.0 348562.5 348708.0 46319.1 54738.5 54774.7 55047.0 55335.4 1207.4 1222.4 1222.9 1345.8 1356.7 28762.3 31046.0 31083.0 31475.7 31589.8 50978.7 51554.7 51604.5 51691.5 51695.2 589951.0 592309.0 594125.0 594546.0 600400.0 25405.0 25802.9 26081.6 26081.9 26099.1 45279.5 45343.0 45367.8 45655.0 46185.5 36751.8 37400.6 37612.8 37878.6 39036.4 32332.2 34775.7 35515.0 36661.5 37455.6 35531.8 36313.6 37029.0 37201.0 37480.6 25382.0 31054.8 31927.2 33652.0 33703.8 21094.0 24497.1 24638.6 25256.2 25346.7 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34861.21 Median:1800.18 stddev:97382.73 (5409.6%) stddev-sans-first:97621.40 02:20:08 INFO - PROCESS | 1664 | Values: 330.5 352.2 372.9 380.2 399.9 15068.2 15353.9 15998.8 19335.1 20353.3 17881.9 20017.5 20586.0 20864.4 21228.6 5893.3 6142.6 6162.3 6168.0 6170.8 5080.6 6814.8 6898.2 6937.8 6973.4 6600.6 6713.9 6847.3 6865.8 6880.0 6724.3 6793.3 6797.9 6828.8 6835.5 5746.4 5851.3 5906.3 5913.5 5916.4 25824.7 25894.0 25957.4 26037.8 26153.7 2392.5 2418.2 2761.1 3103.8 3269.9 15989.5 16006.0 16200.4 16600.0 16702.5 1683.5 1843.9 1902.3 1909.6 1940.9 122505.4 123566.0 123730.0 124730.4 126945.0 9480.3 9796.4 10139.3 10158.2 10690.9 12426.2 12505.1 12513.4 12526.4 12536.9 8082.7 8188.6 8249.1 8312.7 8326.0 8406.0 8609.7 8656.9 8780.4 8808.7 3786.9 3844.7 3917.4 3971.4 3980.9 1867.2 1905.1 1922.6 1933.3 1936.9 831.5 882.9 896.4 943.8 1032.6 20560.0 21388.5 21458.4 21470.7 21492.4 897.8 929.5 946.7 947.4 983.7 9140.9 11399.3 11431.0 11436.7 11461.1 486022.0 593437.0 602946.0 607927.0 608423.0 91497.0 127469.4 131828.3 133752.0 136792.0 842.6 884.7 917.1 917.7 951.8 19551.8 19645.5 20111.0 20142.2 20142.7 42478.0 55915.4 56872.0 57016.0 58181.0 76736.6 81306.2 83709.7 84078.6 84173.6 7815.5 7977.4 8010.4 8374.1 8454.3 11507.3 12718.9 12991.4 13273.9 13404.2 11134.9 11202.5 11308.4 11587.9 11693.9 10670.4 10766.2 10814.3 11061.5 11555.8 11366.7 11447.8 11746.8 11876.0 11884.2 7937.7 8031.5 8136.2 8185.5 8405.8 8292.9 10734.9 11188.6 11410.7 11534.3 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5678.09 Median:4847.92 stddev:3189.61 (65.8%) stddev-sans-first:3183.27 02:20:08 INFO - PROCESS | 1664 | Values: 1523.2 1532.2 1736.3 1838.2 1893.5 6898.4 8901.1 8909.4 8910.2 8926.7 7197.5 7796.3 7974.7 8000.4 8704.3 2346.2 2398.5 2399.9 2401.3 2402.9 2361.6 2379.3 2402.3 2406.3 2411.7 2345.5 2368.3 2391.1 2392.8 2397.2 1998.4 2386.1 2400.8 2404.9 2405.4 2347.4 2360.3 2366.8 2368.9 2374.5 8767.2 8823.1 8853.8 8873.7 8921.3 5167.7 5322.0 5332.9 5336.5 5339.8 3572.3 3575.5 3592.9 3648.6 3649.4 1086.3 1090.6 1092.5 1103.7 1117.3 11107.0 11578.0 11683.2 11691.2 11712.6 4552.2 4613.3 4811.8 4812.9 4821.4 9878.0 9897.0 9912.0 9924.5 9929.6 5298.3 5312.6 5317.9 5329.3 5331.9 3780.4 4362.1 4525.6 4709.7 4874.4 3874.7 3921.3 3985.4 4015.1 4024.7 1153.7 1220.7 1273.6 1274.4 1290.9 835.9 896.1 903.3 920.4 923.8 5764.4 5863.2 6069.1 6074.6 6119.5 381.7 429.6 447.9 454.2 464.6 3970.4 3982.8 3984.2 3989.7 4028.7 10512.0 10768.4 10859.4 10870.6 10894.7 10761.8 10814.0 10821.8 10826.9 10835.7 6482.4 8084.7 8173.9 8183.3 8197.0 5831.7 6037.2 6116.9 6139.1 6211.7 9567.3 9804.4 10041.7 10151.4 10174.5 8673.7 9946.6 10184.0 10312.8 10315.7 7517.4 7525.5 7547.9 7579.8 7620.6 8247.5 8326.8 8328.6 8332.2 8334.5 7342.5 7454.0 7463.3 7545.2 7600.5 7275.2 7303.5 7307.2 7312.7 7416.1 6870.3 7028.8 7035.0 7038.6 7046.8 4951.5 5049.4 5112.4 5120.6 5174.8 4787.9 4945.7 4988.0 5169.4 5227.2 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4555.73 Median:5242.53 stddev:1430.26 (27.3%) stddev-sans-first:1398.12 02:20:08 INFO - PROCESS | 1664 | Values: 298.7 302.4 307.7 312.6 315.1 4429.3 5181.0 5231.1 5359.6 5451.9 4953.7 5149.3 5275.7 5338.5 5377.4 4114.6 4124.9 4130.9 4131.9 4147.5 3819.3 3997.1 4111.6 4128.7 4148.9 3432.7 3637.2 4091.7 4098.1 4107.3 3905.9 3926.8 4027.6 4065.0 4092.2 2982.7 3509.3 3516.0 3531.7 3584.2 4948.8 5169.7 5241.6 5298.7 5372.8 3913.9 4572.2 4600.4 4637.1 4639.9 4665.3 5387.1 5644.7 5679.6 5680.7 3288.8 3623.4 3795.7 3847.0 3869.3 5741.9 5864.1 5959.4 6026.3 6051.3 3284.3 3293.3 3843.0 3941.5 3947.4 3510.4 3672.3 3787.9 3828.6 3997.6 3770.5 4270.7 4508.8 4566.4 4595.2 4936.4 4981.0 5692.4 5723.9 5742.8 1260.6 1305.5 1313.2 1315.8 1332.5 881.0 891.2 911.9 914.6 917.0 5326.1 5336.4 5342.2 5348.9 5376.9 5756.9 5770.7 5771.4 5780.4 5785.5 5068.4 5329.4 5333.9 5346.2 5376.6 2738.7 2819.3 2826.6 2912.5 3089.4 5441.6 5762.3 6062.8 6106.2 6160.9 4623.8 5818.7 5889.7 5975.2 6007.3 5055.8 5986.7 5995.4 6003.0 6066.0 5436.1 5556.8 5686.6 5773.6 5842.7 5127.6 5278.3 5491.9 5699.0 5751.3 5693.3 5935.7 6015.8 6018.2 6018.7 2792.9 3433.7 3784.6 3862.1 3897.2 4760.8 5503.7 5786.6 5802.6 5851.7 4940.8 5333.5 5486.4 5614.5 5636.8 4750.7 4816.6 5644.9 5669.2 5677.9 4779.6 5265.1 5493.3 5549.0 5551.6 5243.5 5622.8 5636.8 5643.7 5727.4 4627.3 5494.2 5495.1 5512.7 5519.0 02:20:08 INFO - PROCESS | 1664 | 02:20:08 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:24643.96 Median:3732.36 stddev:38684.69 (1036.5%) stddev-sans-first:38751.57 02:20:08 INFO - PROCESS | 1664 | Values: 737.5 750.6 770.5 784.3 791.6 13265.6 17442.2 17470.2 17490.2 17518.0 16593.0 16732.0 16736.0 16744.7 16745.2 674.4 695.5 699.9 845.4 858.8 831.7 843.9 859.1 859.9 860.3 913.7 916.1 916.2 916.6 917.1 718.9 741.6 910.4 911.0 911.7 647.6 664.6 665.7 665.7 667.8 15391.2 15403.2 15449.7 15454.4 15465.2 13465.7 13609.1 13712.8 13723.0 13850.0 12459.3 12707.3 12772.6 12912.7 13290.1 4491.9 4517.3 4518.3 4624.1 4650.1 119049.0 120750.0 121230.8 121449.0 121672.0 10371.4 10743.8 10744.7 10865.7 11153.4 20958.5 20985.3 21003.9 21113.5 21132.9 6787.9 7702.9 7805.4 7815.8 8113.4 4334.5 4350.1 4359.0 4396.3 4501.9 3652.2 3812.6 3813.8 3815.0 3817.3 583.7 602.4 679.9 686.9 709.6 511.7 563.7 660.4 672.0 676.9 8910.2 9553.5 9592.7 9804.0 9813.4 575.8 591.5 609.1 610.8 685.6 3478.9 3995.4 4755.5 4766.2 4777.2 130188.0 130946.3 132494.0 136406.0 143085.0 120508.8 126199.0 127606.4 130162.0 131040.0 107627.0 109500.5 110635.4 111461.0 120060.0 8829.8 9871.2 9894.3 9916.6 10035.9 54011.5 59987.0 61511.0 64078.7 64906.0 70549.6 76189.2 82995.0 91358.0 96133.5 12917.2 12931.6 13388.6 13390.6 13624.3 13171.9 14282.8 14884.9 15011.7 15230.8 13190.2 13544.7 13839.2 14137.8 14799.0 12487.3 12730.2 12873.7 13255.0 13316.1 13299.9 13336.1 13670.5 13677.6 13781.8 10750.4 11131.4 11809.5 11855.5 12249.9 9768.0 9903.7 11601.2 11693.2 11867.5 02:20:08 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:20:08 INFO - PROCESS | 1664 | 02:20:09 INFO - TEST-INFO | 1664: exit 0 02:20:09 INFO - TEST-OK | dromaeo_css | took 1117485ms 02:20:09 INFO - TEST-START | kraken 02:20:09 INFO - operating with platform_type : mac_ 02:20:09 INFO - Initialising browser for kraken test... 02:20:09 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpeI115i/profile http://localhost:49272/getInfo.html) 02:20:11 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 02:20:11 INFO - PROCESS | 1669 | colorDepth:24 02:20:11 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 02:20:11 INFO - PROCESS | 1669 | __metrics 02:20:11 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:20:11 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:12 INFO - TEST-INFO | 1669: exit 0 02:20:12 INFO - Browser initialized. 02:20:12 INFO - Running cycle 1/1 for kraken test... 02:20:12 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpeI115i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:24 INFO - PROCESS | 1671 | RSS: Main: 220049408 02:20:24 INFO - PROCESS | 1671 | 02:20:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:28 INFO - PROCESS | 1671 | RSS: Main: 269897728 02:20:28 INFO - PROCESS | 1671 | 02:20:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:20:31 INFO - PROCESS | 1671 | RSS: Main: 280739840 02:20:31 INFO - PROCESS | 1671 | 02:20:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:20:35 INFO - PROCESS | 1671 | RSS: Main: 377139200 02:20:35 INFO - PROCESS | 1671 | 02:20:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:20:37 INFO - PROCESS | 1671 | RSS: Main: 279805952 02:20:37 INFO - PROCESS | 1671 | 02:20:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:40 INFO - PROCESS | 1671 | RSS: Main: 280137728 02:20:40 INFO - PROCESS | 1671 | 02:20:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:43 INFO - PROCESS | 1671 | RSS: Main: 320409600 02:20:43 INFO - PROCESS | 1671 | 02:20:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:47 INFO - PROCESS | 1671 | RSS: Main: 320180224 02:20:47 INFO - PROCESS | 1671 | 02:20:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:20:50 INFO - PROCESS | 1671 | RSS: Main: 319754240 02:20:50 INFO - PROCESS | 1671 | 02:20:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:52 INFO - PROCESS | 1671 | RSS: Main: 290250752 02:20:52 INFO - PROCESS | 1671 | 02:20:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:55 INFO - PROCESS | 1671 | RSS: Main: 295759872 02:20:55 INFO - PROCESS | 1671 | 02:20:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:58 INFO - PROCESS | 1671 | RSS: Main: 298274816 02:20:58 INFO - PROCESS | 1671 | 02:21:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:01 INFO - PROCESS | 1671 | RSS: Main: 316940288 02:21:01 INFO - PROCESS | 1671 | 02:21:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:05 INFO - PROCESS | 1671 | RSS: Main: 310448128 02:21:05 INFO - PROCESS | 1671 | 02:21:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:21:07 INFO - PROCESS | 1671 | RSS: Main: 354340864 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | __start_tp_report 02:21:07 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 02:21:07 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 02:21:07 INFO - PROCESS | 1671 | |i|pagename|runs| 02:21:07 INFO - PROCESS | 1671 | |0;ai-astar;114;114;116;115;120;167;166;116;115;115 02:21:07 INFO - PROCESS | 1671 | |1;audio-beat-detection;140;109;112;144;109;107;108;110;139;108 02:21:07 INFO - PROCESS | 1671 | |2;audio-dft;184;185;186;185;184;183;186;181;184;179 02:21:07 INFO - PROCESS | 1671 | |3;audio-fft;81;59;58;87;64;59;58;58;82;58 02:21:07 INFO - PROCESS | 1671 | |4;audio-oscillator;84;70;94;69;68;69;95;90;100;126 02:21:07 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;85;87;85;88;84;88;84;87;85 02:21:07 INFO - PROCESS | 1671 | |6;imaging-darkroom;151;135;96;98;96;96;95;94;96;94 02:21:07 INFO - PROCESS | 1671 | |7;imaging-desaturate;87;87;86;85;83;85;87;84;127;85 02:21:07 INFO - PROCESS | 1671 | |8;json-parse-financial;57;55;54;53;56;57;58;57;57;55 02:21:07 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;66;72;67;75;72;68;69;72;71;72 02:21:07 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;83;85;82;82;81;81;84;82;82;82 02:21:07 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;134;138;138;139;140;136;139;140;166;141 02:21:07 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;163;165;163;163;164;166;181;226;191;165 02:21:07 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;70;62;59;75;78 02:21:07 INFO - PROCESS | 1671 | __end_tp_report 02:21:07 INFO - PROCESS | 1671 | __start_cc_report 02:21:07 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1946 02:21:07 INFO - PROCESS | 1671 | __end_cc_report 02:21:07 INFO - PROCESS | 1671 | __startTimestamp1476609667116__endTimestamp 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | ------- Summary: start ------- 02:21:07 INFO - PROCESS | 1671 | Number of tests: 14 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:125.80 Median:116.00 stddev:21.52 (18.6%) stddev-sans-first:22.40 02:21:07 INFO - PROCESS | 1671 | Values: 114.0 114.0 116.0 115.0 120.0 167.0 166.0 116.0 115.0 115.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:111.00 stddev:15.56 (14.0%) stddev-sans-first:14.45 02:21:07 INFO - PROCESS | 1671 | Values: 140.0 109.0 112.0 144.0 109.0 107.0 108.0 110.0 139.0 108.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.21 (1.2%) stddev-sans-first:2.35 02:21:07 INFO - PROCESS | 1671 | Values: 184.0 185.0 186.0 185.0 184.0 183.0 186.0 181.0 184.0 179.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:11.92 (19.4%) stddev-sans-first:11.41 02:21:07 INFO - PROCESS | 1671 | Values: 81.0 59.0 58.0 87.0 64.0 59.0 58.0 58.0 82.0 58.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:77.00 stddev:18.61 (24.2%) stddev-sans-first:19.72 02:21:07 INFO - PROCESS | 1671 | Values: 84.0 70.0 94.0 69.0 68.0 69.0 95.0 90.0 100.0 126.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 02:21:07 INFO - PROCESS | 1671 | Values: 88.0 85.0 87.0 85.0 88.0 84.0 88.0 84.0 87.0 85.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:96.00 stddev:20.36 (21.2%) stddev-sans-first:13.18 02:21:07 INFO - PROCESS | 1671 | Values: 151.0 135.0 96.0 98.0 96.0 96.0 95.0 94.0 96.0 94.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:85.50 stddev:13.21 (15.4%) stddev-sans-first:13.98 02:21:07 INFO - PROCESS | 1671 | Values: 87.0 87.0 86.0 85.0 83.0 85.0 87.0 84.0 127.0 85.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.60 (2.8%) stddev-sans-first:1.64 02:21:07 INFO - PROCESS | 1671 | Values: 57.0 55.0 54.0 53.0 56.0 57.0 58.0 57.0 57.0 55.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:72.00 stddev:2.80 (3.9%) stddev-sans-first:2.47 02:21:07 INFO - PROCESS | 1671 | Values: 66.0 72.0 67.0 75.0 72.0 68.0 69.0 72.0 71.0 72.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 02:21:07 INFO - PROCESS | 1671 | Values: 83.0 85.0 82.0 82.0 81.0 81.0 84.0 82.0 82.0 82.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:139.50 stddev:8.99 (6.4%) stddev-sans-first:9.16 02:21:07 INFO - PROCESS | 1671 | Values: 134.0 138.0 138.0 139.0 140.0 136.0 139.0 140.0 166.0 141.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:165.50 stddev:20.35 (12.3%) stddev-sans-first:21.14 02:21:07 INFO - PROCESS | 1671 | Values: 163.0 165.0 163.0 163.0 164.0 166.0 181.0 226.0 191.0 165.0 02:21:07 INFO - PROCESS | 1671 | 02:21:07 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:5.52 (8.2%) stddev-sans-first:5.84 02:21:07 INFO - PROCESS | 1671 | Values: 67.0 67.0 68.0 67.0 67.0 70.0 62.0 59.0 75.0 78.0 02:21:07 INFO - PROCESS | 1671 | -------- Summary: end -------- 02:21:07 INFO - PROCESS | 1671 | 02:21:08 INFO - TEST-INFO | 1671: exit 0 02:21:08 INFO - TEST-OK | kraken | took 58967ms 02:21:08 INFO - SUITE-END | took 1176s 02:21:08 INFO - Completed test suite (00:19:36) 02:21:08 INFO - javascript benchmark 02:21:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2745.588161775733, 3309.205790610254, 3336.1659585103707, 3355.3289342131548, 3392.7964322140656, 5739.913901291478, 5767.942320576793, 5854.560907931901, 5859.853503662411, 5874.823755287348, 5749.3388260350075, 5797.739101740422, 5811.244538210038, 5821.854453638661, 5843.678597677126, 5285.392179899322, 5297.602679799012, 5308.893822123575, 5343.572514198855, 5359.624826262163, 5229.954009198156, 5234.476552344754, 5253.080710875601, 5387.865303367427, 5419.891602167954, 5322.733863306819, 5335.573154147678, 5341.813036543722, 5359.490848369399, 5360.624756267063, 5344.652597581145, 5359.08895487768, 5359.517643412073, 5367.194920761878, 5369.40936496985, 5106.9489305106845, 5264.210368444726, 5274.55166310864, 5281.973590132063, 5309.097453432887, 5817.650940943557, 5867.149263356832, 5880.705964701748, 5891.882162356772, 5909.349971503131, 6256.03031530109, 6260.561760676755, 6270.498360131179, 6281.7173227204885, 6285.654289014103, 4865.951340486586, 6162.876742465126, 6169.2288463942, 6213.254409470847, 6261.0295404211965, 5735.856603584902, 5825.271841019872, 5835.67903765297, 5852.356240813507, 5853.678047707332, 6320.905186422207, 6331.873362532723, 6341.4292713656, 6350.301466838644, 6353.8729225416155, 6117.327094019654, 6122.581127188521, 6139.43080903429, 6224.502039836802, 6225.688715564203, 5276.683398996072, 6142.406692085091, 6249.25008998923, 6273.404026617464, 6307.117003619497, 6259.155014073133, 6294.3076261612105, 6295.401936815995, 6300.0, 6311.652859092702, 6105.938940610537, 6184.381561843779, 6282.717277722513, 6286.937130628727, 6292.559520833498, 4963.776630051584, 4983.401991761012, 5012.298278241049, 5018.04657115147, 5053.823116190915, 4443.155800397914, 4456.5766252205985, 4470.351798989193, 4474.574915383034, 4491.124230774967, 5823.82528524145, 5867.589268751147, 5868.589198756046, 5892.793752218738, 5901.5868889177345, 6130.386961303834, 6186.721597528122, 6242.469390101892, 6248.687565621701, 6252.968735156386, 5877.853053673693, 5954.493868021266, 5962.612430192024, 5998.970005149947, 6004.969975150097, 5465.672059676433, 5469.316335458067, 5472.261244731911, 5476.2333273341765, 5476.726163691879, 6188.535859810622, 6256.343083976299, 6361.840953976188, 6443.387878151568, 6454.354564543508, 5246.6065045121, 6190.102435146969, 6224.595401298901, 6232.283287421823, 6263.812085637438, 6415.1981002374705, 6423.4861211103935, 6430.678466076771, 6445.613263204223, 6451.387118223761, 6105.236845394325, 6203.96898015507, 6219.782307619212, 6243.843903902439, 6268.1851359323, 6181.690915454119, 6188.845278868064, 6208.255009398901, 6210.503159747119, 6281.748730050746, 5159.767810448464, 5965.8664853677665, 6203.875922481435, 6218.253809542884, 6221.129041934223, 6153.784617538365, 6208.2860471044605, 6211.09939058843, 6211.192544969125, 6230.968845155927, 5857.824265272048, 5926.318473375444, 5947.226860508279, 5950.404959504188, 5959.344472107978, 6161.4146656067605, 6166.0, 6169.352218017044, 6171.475424588781, 6179.660118693515, 5829.94170058294, 5903.321118071477, 6012.38195487213, 6041.758329666764, 6065.150878877049], "value": 5740.604615095763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.7999870056525, 492.8693896117529, 534.02540363836, 537.9596530260231, 548.4625067433917, 29674.258143546394, 38908.61091389085, 39726.205475890536, 39736.60263397365, 42121.15757684852, 40884.59115408853, 41391.17217655645, 41397.0, 41420.0, 41425.7928710356, 8746.256568191711, 9648.855267170999, 9840.0, 9847.803043939117, 9854.507274636275, 8649.48103113812, 11837.64487065385, 11993.580224692138, 12019.93990030053, 12266.264024158534, 11831.11266655, 12044.518219271218, 12083.516659333616, 12118.272903625812, 12154.0, 12066.215695979734, 12135.271883687006, 12137.211081279776, 12157.939210303935, 12182.269063856196, 11877.109216808687, 11934.925856672855, 11954.0, 11965.282083074957, 11970.401479926057, 38776.0, 39035.60964390348, 39084.60915390866, 39086.804565977276, 39156.0, 3426.3318652862454, 3434.708049815769, 3442.862285508577, 3573.714102871764, 3612.7651702639246, 28481.715182848115, 29017.41965160685, 29611.407771844442, 30822.7670893164, 31187.220319491968, 2658.8138830281887, 3117.9688203117908, 3225.6129264488177, 3240.7245384142375, 3292.506124081383, 488084.0, 488959.0, 490948.0, 491392.0, 493353.0, 32876.1780955478, 60462.69768651129, 60999.695001524706, 61070.38929610736, 61097.0, 32984.3403131936, 33896.0, 34216.315673686884, 34231.973040808814, 34270.0, 14640.560783176308, 14768.261586920826, 14774.89188310881, 14780.63048423798, 14791.556253312418, 11524.0, 11748.17762756616, 12436.502539898484, 12519.56181533642, 12563.057770667236, 7618.885716714254, 7737.3036426721865, 7805.0, 7811.336036436853, 7818.374530037583, 3187.9043628691174, 3225.870965161367, 3238.5304130900886, 3239.773215874913, 3271.084096452997, 891.2201823404521, 921.861720741894, 943.061653654618, 948.2177203806887, 969.7139343893568, 22822.885885570468, 28242.43515129686, 28857.422851543273, 29614.551840432883, 29944.101676949726, 995.6664517386756, 1008.6448193009892, 1019.7756493571402, 1113.6826004588654, 1156.7223866272034, 12433.316167610687, 14809.333579988926, 15204.391824326904, 15256.542303730906, 15587.298571564306, 344128.0, 346070.0, 348221.0, 348562.514374853, 348708.0, 46319.07361852744, 54738.45261547333, 54774.72612636911, 55047.0, 55335.44664553383, 1207.3782002268838, 1222.407132540735, 1222.8715984821822, 1345.8048582955416, 1356.7490014347377, 28762.280942976595, 31046.0, 31083.0, 31475.685243148193, 31589.8420507896, 50978.74510627572, 51554.711132220495, 51604.483955159965, 51691.483085168664, 51695.22457163221, 589951.0, 592309.0, 594125.0, 594546.0, 600400.0, 25405.0, 25802.870985644953, 26081.608775867997, 26081.869590651924, 26099.08653197129, 45279.54720452753, 45343.0, 45367.773161133984, 45655.0, 46185.5360847931, 36751.816240918626, 37400.6259937408, 37612.811935940146, 37878.62121378861, 39036.414453783786, 32332.191695207806, 34775.65224347724, 35515.0, 36661.450078248316, 37455.62544374631, 35531.75638852628, 36313.63686363103, 37029.0, 37201.0, 37480.625193747714, 25381.954165500258, 31054.844725776227, 31927.201819954687, 33652.0, 33703.83148084244, 21094.0, 24497.142600009625, 24638.630420543348, 25256.242312730647, 25346.74653253444], "value": 18358.715369442092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.48279442672214, 352.1513153300546, 372.9291434627422, 380.18260739410266, 399.9240144372569, 15068.246587670614, 15353.923230383847, 15998.760018599716, 19335.12991915364, 20353.28763493278, 17881.91059044703, 20017.499562510944, 20586.0, 20864.374068777925, 21228.575428491422, 5893.292804863422, 6142.631442113465, 6162.260528736558, 6167.969160154193, 6170.784022559212, 5080.618953578496, 6814.795556133324, 6898.172219333687, 6937.757178498754, 6973.442124630017, 6600.603963762165, 6713.93286067138, 6847.315268473138, 6865.759698410557, 6879.965600172017, 6724.293949135319, 6793.252742198354, 6797.898031529531, 6828.829279268058, 6835.521513494057, 5746.396628354005, 5851.32709738377, 5906.291245050578, 5913.467787899067, 5916.408359164092, 25824.74175258242, 25894.0, 25957.36596876439, 26037.828297726457, 26153.73846261532, 2392.545416370884, 2418.2019933422102, 2761.144045345949, 3103.7982531135403, 3269.885554005622, 15989.520314390587, 16006.0, 16200.432984845474, 16600.0, 16702.49892503227, 1683.4612923864368, 1843.861710371714, 1902.258119333461, 1909.5798924236647, 1940.8544359173118, 122505.38747306296, 123566.0, 123730.0, 124730.37634811767, 126945.0, 9480.336376453582, 9796.363236389612, 10139.340942838839, 10158.15571639942, 10690.893091069145, 12426.192297500633, 12505.06212034101, 12513.436895339732, 12526.37368131608, 12536.937315313366, 8082.676692932217, 8188.590570471452, 8249.133840946613, 8312.667493300321, 8325.95837020811, 8406.0, 8609.65561377538, 8656.91343086561, 8780.385373023826, 8808.691695790745, 3786.9431958520645, 3844.7116466264583, 3917.3536366499206, 3971.4241434991764, 3980.920381592352, 1867.1504465468179, 1905.123263871564, 1922.5866438715743, 1933.3180133283852, 1936.932207372735, 831.4720152703077, 882.9205371516595, 896.421807933879, 943.7829299261208, 1032.5972870580479, 20559.97200139987, 21388.465288367603, 21458.3520801461, 21470.677939830915, 21492.355229343146, 897.8294124116397, 929.4980710416299, 946.7207173883721, 947.3842002698301, 983.6655537117415, 9140.862887056699, 11399.259048161843, 11431.028362589273, 11436.714082148013, 11461.140414468948, 486022.0, 593437.0, 602946.0, 607927.0, 608423.0, 91497.0, 127469.36265318614, 131828.34085829702, 133752.0, 136792.0, 842.5636194111779, 884.712468447757, 917.1424717888796, 917.7200953709049, 951.8048799995984, 19551.804481954998, 19645.50886227856, 20111.0, 20142.194312227348, 20142.697859531825, 42478.0, 55915.44084559265, 56872.0, 57016.0, 58181.0, 76736.61631691805, 81306.18693812986, 83709.74435383597, 84078.57960710158, 84173.57913210394, 7815.520711676474, 7977.361811055218, 8010.439269251096, 8374.115823939808, 8454.32365410778, 11507.252028618113, 12718.936405317914, 12991.35043247815, 13273.867261327263, 13404.195748255135, 11134.944325278646, 11202.49588768491, 11308.434578271219, 11587.88412115868, 11693.88306116928, 10670.413127277763, 10766.246362754531, 10814.29707069038, 11061.502232399722, 11555.8266625999, 11366.659000230007, 11447.828282575934, 11746.76506469883, 11875.990540804129, 11884.227525210834, 7937.722179723913, 8031.518108913484, 8136.22705842944, 8185.549794761345, 8405.831883362422, 8292.87560686578, 10734.892651073389, 11188.552457901918, 11410.714732131431, 11534.307941523535], "value": 9735.88553289816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.1546491697106, 1532.1573134775872, 1736.340190727524, 1838.209569884949, 1893.4887580353297, 6898.413634841038, 8901.06538813425, 8909.376343655938, 8910.198082172603, 8926.732198034053, 7197.49617526772, 7796.298333150015, 7974.681012759483, 8000.359971202304, 8704.347173961947, 2346.1905642553293, 2398.4963157736897, 2399.8560086394787, 2401.2796161151673, 2402.9279121626378, 2361.6103342948395, 2379.2981070584133, 2402.255300856731, 2406.302172370011, 2411.6744239527616, 2345.495718420539, 2368.301351101429, 2391.1033362489065, 2392.83250172488, 2397.2328854766483, 1998.3505360757813, 2386.129062892049, 2400.7959323457612, 2404.927852164438, 2405.3625789165885, 2347.401412639783, 2360.3037104054347, 2366.7514910934447, 2368.857868527894, 2374.5250949810106, 8767.167119123673, 8823.11768823119, 8853.822923541558, 8873.689420870303, 8921.330900182513, 5167.741612919339, 5322.0, 5332.920006199872, 5336.546393556514, 5339.813106541291, 3572.2676851245433, 3575.4636804479537, 3592.9281414371567, 3648.5804132524836, 3649.3978493548534, 1086.3319058778793, 1090.6019302954364, 1092.5302120088359, 1103.7406209540752, 1117.3463523838564, 11107.0, 11578.015868651091, 11683.240589361665, 11691.181617286793, 11712.590059347967, 4552.203364411281, 4613.284940834176, 4811.78346974387, 4812.879678008007, 4821.445533763592, 9878.012198780209, 9897.0, 9912.008799120174, 9924.454155021398, 9929.553170107363, 5298.28473156119, 5312.574994000471, 5317.893642127213, 5329.25390445338, 5331.893362132813, 3780.4140358244517, 4362.083962367875, 4525.637948964075, 4709.7174169549935, 4874.390701162355, 3874.6512813846325, 3921.254961557295, 3985.362342025262, 4015.0966032642423, 4024.69814763888, 1153.6712037069394, 1220.742635085863, 1273.5669872243482, 1274.4010315151863, 1290.8580056193812, 835.8787975743484, 896.090468174803, 903.263839970422, 920.4431319052011, 923.7644400677784, 5764.423557644202, 5863.20846685692, 6069.089636554464, 6074.605150665193, 6119.4798442132915, 381.67176228443515, 429.6433959813347, 447.9417675702203, 454.20287395620477, 464.579555502271, 3970.3647416413814, 3982.820773065219, 3984.163325701635, 3989.7007724420782, 4028.738132021409, 10512.0, 10768.3538987661, 10859.40273284961, 10870.61952831647, 10894.727631809268, 10761.78476430467, 10814.0, 10821.835632873457, 10826.945865270623, 10835.729106772395, 6482.416582507692, 8084.676612935416, 8173.918260817316, 8183.345332373396, 8197.0, 5831.679257640871, 6037.245344331958, 6116.938830611637, 6139.140520327069, 6211.689415529115, 9567.282453815853, 9804.36271642341, 10041.748956276151, 10151.441670708182, 10174.542145603318, 8673.653053877773, 9946.552405141641, 10183.981601839756, 10312.793744125225, 10315.742106447398, 7517.361024312776, 7525.510841795266, 7547.886781698388, 7579.772606821804, 7620.5808680523105, 8247.463914845515, 8326.833463330579, 8328.583570821556, 8332.208440198172, 8334.458260213067, 7342.48602597813, 7454.018392642986, 7463.2536746327105, 7545.170031296663, 7600.543967361976, 7275.163356214103, 7303.488755787044, 7307.196208417176, 7312.7440539582985, 7416.110066792019, 6870.3473170048765, 7028.789136325714, 7035.015097886402, 7038.577685338896, 7046.788596342118, 4951.504849515164, 5049.394072711299, 5112.3865136183895, 5120.641555091108, 5174.818881339135, 4787.928181077356, 4945.703257804399, 4987.950120498894, 5169.431362550041, 5227.215917612389], "value": 4494.849705641696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.741588525925, 302.4269010225621, 307.71536328895763, 312.62328893683116, 315.0909625729769, 4429.335599660053, 5180.974095129519, 5231.058409486291, 5359.598030147735, 5451.945480545193, 4953.678010929296, 5149.253358263049, 5275.683458992454, 5338.466153384659, 5377.435369286227, 4114.6296833285, 4124.917501649973, 4130.8554200602985, 4131.917361652765, 4147.543770185277, 3819.2934307153264, 3997.060690737674, 4111.600587371514, 4128.731632443896, 4148.937765933513, 3432.6567343265724, 3637.1816341323256, 4091.672666186698, 4098.073905264521, 4107.301758701028, 3905.882823515299, 3926.7630696330707, 4027.637512623878, 4065.0, 4092.2224777292217, 2982.6719060903283, 3509.31568344173, 3515.9979405869462, 3531.6644918732677, 3584.211473475831, 4948.752562371903, 5169.741512924376, 5241.554467870197, 5298.735063246861, 5372.838814835562, 3913.941290880639, 4572.245579479382, 4600.435851810367, 4637.118947399983, 4639.884002899921, 4665.346851440801, 5387.057264978613, 5644.74598643062, 5679.630823996468, 5680.715964201773, 3288.819114948677, 3623.420252759572, 3795.734298599099, 3847.0, 3869.3228684980018, 5741.88516229673, 5864.149698293723, 5959.36117567668, 6026.337102918676, 6051.304100028465, 3284.2593425484533, 3293.2754793945774, 3842.9624001519433, 3941.4825292262685, 3947.381573554886, 3510.3856825055514, 3672.265546890633, 3787.901508562486, 3828.5979972103087, 3997.5802540733384, 3770.490983717163, 4270.7010509264055, 4508.752018638941, 4566.360709500673, 4595.195840727859, 4936.407631084293, 4980.950190498121, 5692.430756924275, 5723.941070901897, 5742.770289188469, 1260.552503861116, 1305.4843336882068, 1313.238321773369, 1315.8223639808696, 1332.5275570494464, 880.9560670605225, 891.2068259249273, 911.886014248219, 914.6112902016616, 917.0233701108432, 5326.067938110815, 5336.386315573759, 5342.171963345688, 5348.866278343073, 5376.903007826951, 5756.913646295309, 5770.682612456355, 5771.365149833515, 5780.364159942403, 5785.479306862402, 5068.391792984866, 5329.413764485904, 5333.893322133536, 5346.224797404355, 5376.569874410038, 2738.7261273872455, 2819.2528979820363, 2826.590144429046, 2912.5339945608603, 3089.351236240415, 5441.59188060897, 5762.271318604402, 6062.818115456455, 6106.236720409949, 6160.8767824643255, 4623.838165664186, 5818.650880947157, 5889.705514724246, 5975.223220981332, 6007.279126504847, 5055.772490237948, 5986.73059712314, 5995.400459954057, 6002.999999999913, 6066.0, 5436.130219164915, 5556.833295001156, 5686.606781338599, 5773.595848290579, 5842.721338677834, 5127.6410651254055, 5278.261043453843, 5491.862703432286, 5698.951061182248, 5751.309842818889, 5693.348928810764, 5935.673537955454, 6015.789447369321, 6018.157457955802, 6018.712889102113, 2792.9022484212956, 3433.7081348084694, 3784.5647750509042, 3862.1268684688466, 3897.1940203053755, 4760.78576464053, 5503.6697798130635, 5786.623869448473, 5802.622829516068, 5851.678157701367, 4940.7648087978005, 5333.493318134771, 5486.396496385315, 5614.466625670555, 5636.830895073154, 4750.691205071659, 4816.638752093677, 5644.867098760227, 5669.177969194526, 5677.9495793278375, 4779.569838714532, 5265.077881775651, 5493.258410114743, 5548.9722551386985, 5551.611387202857, 5243.501867322599, 5622.7750889963945, 5636.802711905064, 5643.717814109196, 5727.427257274406, 4627.251925939865, 5494.203340515683, 5495.148252020943, 5512.747478987257, 5518.972405137949], "value": 4100.758855202111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.5095561451635, 750.5571712689514, 770.4529783853463, 784.2745460449083, 791.6041979010495, 13265.602031939034, 17442.215100320485, 17470.213840377182, 17490.212940417663, 17518.0, 16593.0, 16731.996080235163, 16736.0, 16744.66510669789, 16745.162741862918, 674.4166296153841, 695.5027155583757, 699.8775214337496, 845.4166625028726, 858.8024754306513, 831.6922738586701, 843.8734289723196, 859.0593300336153, 859.9398042137053, 860.3031544449017, 913.7441516375426, 916.1434059154711, 916.170865366844, 916.5508900638706, 917.1149840404008, 718.8741970155202, 741.6365980669487, 910.4218821048648, 910.9635614575409, 911.6809116809097, 647.588781123985, 664.64773669955, 665.7403612591094, 665.7470161338708, 667.7963221217527, 15391.153486558234, 15403.152826594533, 15449.691006179926, 15454.381824726997, 15465.226738663021, 13465.730685386336, 13609.094726738265, 13712.794308085287, 13723.0, 13850.030497865153, 12459.252444853248, 12707.301098439582, 12772.61682149537, 12912.741745165044, 13290.069695121345, 4491.887702807423, 4517.299818528133, 4518.299663552155, 4624.144533261324, 4650.139724151043, 119049.0, 120750.0, 121230.78769212372, 121449.0, 121672.0, 10371.429571373495, 10743.83884241737, 10744.73138171552, 10865.674029779118, 11153.442327883573, 20958.47603809917, 20985.265515706877, 21003.949802509815, 21113.472163196042, 21132.894335528224, 6787.864242715217, 7702.8844567331535, 7805.41459390548, 7815.843683126305, 8113.432059755878, 4334.50153232376, 4350.0647360817575, 4359.019220675323, 4396.340548917688, 4501.864944051684, 3652.160003199279, 3812.5615554211067, 3813.771173729585, 3815.04623844039, 3817.3319669057805, 583.7489879351834, 602.4367216652444, 679.942204912588, 686.8763622547889, 709.6487238816716, 511.66230288009734, 563.6702529020487, 660.3660485933558, 671.993280067193, 676.922153952292, 8910.198082172636, 9553.474558899326, 9592.712218633453, 9803.950980245196, 9813.362131461432, 575.7524264566193, 591.5031373646158, 609.1441524657863, 610.8320211941663, 685.6263336481629, 3478.8782392616135, 3995.400689896481, 4755.524447555217, 4766.189747742892, 4777.235642297216, 130188.0, 130946.34526827304, 132494.0, 136406.0, 143085.0, 120508.82011354617, 126199.0, 127606.36196818957, 130162.0, 131040.0, 107627.0, 109500.452497737, 110635.44682276537, 111461.0, 120060.0, 8829.779255518664, 9871.170002931149, 9894.257930655374, 9916.623111575642, 10035.899641003496, 54011.45988540064, 59987.0, 61511.0, 64078.67960660167, 64906.0, 70549.64725176341, 76189.23810761822, 82995.0, 91358.0, 96133.5193324029, 12917.22496650204, 12931.612051638465, 13388.598342049754, 13390.598282051555, 13624.250666213453, 13171.868281317447, 14282.785758213427, 14884.851151488347, 15011.699766004836, 15230.771538427154, 13190.208587484782, 13544.729105418033, 13839.238841863795, 14137.787933181216, 14799.0, 12487.31319777421, 12730.17253878495, 12873.678158046123, 13255.0, 13316.06787524864, 13299.933500332436, 13336.133151345519, 13670.52153174634, 13677.589672309847, 13781.793273101111, 10750.408727520062, 11131.443427828739, 11809.527618895148, 11855.466504007512, 12249.877501224873, 9767.951160244153, 9903.653372131941, 11601.245919015237, 11693.181477296508, 11867.465964031811], "value": 7862.776193033531, "unit": "score"}], "name": "dromaeo_css", "value": 7278.843740309175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 115.0, 120.0, 167.0, 166.0, 116.0, 115.0, 115.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 112.0, 144.0, 109.0, 107.0, 108.0, 110.0, 139.0, 108.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 186.0, 185.0, 184.0, 183.0, 186.0, 181.0, 184.0, 179.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 87.0, 64.0, 59.0, 58.0, 58.0, 82.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 94.0, 69.0, 68.0, 69.0, 95.0, 90.0, 100.0, 126.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 84.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 135.0, 96.0, 98.0, 96.0, 96.0, 95.0, 94.0, 96.0, 94.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 85.0, 83.0, 85.0, 87.0, 84.0, 127.0, 85.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 56.0, 57.0, 58.0, 57.0, 57.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 67.0, 75.0, 72.0, 68.0, 69.0, 72.0, 71.0, 72.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 82.0, 82.0, 81.0, 81.0, 84.0, 82.0, 82.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 138.0, 139.0, 140.0, 136.0, 139.0, 140.0, 166.0, 141.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 164.0, 166.0, 181.0, 226.0, 191.0, 165.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 70.0, 62.0, 59.0, 75.0, 78.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1454.3, "alertThreshold": 2.0}]} 02:21:08 INFO - Return code: 0 02:21:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:21:08 INFO - # TBPL SUCCESS # 02:21:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:21:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:21:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:21:08 INFO - 2016-10-16 02:21:08.404 screenresolution[1675:10679] starting screenresolution argv=screenresolution get 02:21:08 INFO - 2016-10-16 02:21:08.407 screenresolution[1675:10679] Display 0: 1600x1200x32@60 02:21:08 INFO - 2016-10-16 02:21:08.413 screenresolution[1676:10682] starting screenresolution argv=screenresolution list 02:21:08 INFO - Available Modes on Display 0 02:21:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:21:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:21:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:21:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:21:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:21:08 INFO - Intel Iris: 02:21:08 INFO - Chipset Model: Intel Iris 02:21:08 INFO - Type: GPU 02:21:08 INFO - Bus: Built-In 02:21:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:21:08 INFO - Vendor: Intel (0x8086) 02:21:08 INFO - Device ID: 0x0a2e 02:21:08 INFO - Revision ID: 0x0009 02:21:08 INFO - Displays: 02:21:08 INFO - Display: 02:21:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:21:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:21:08 INFO - Display Serial Number: 1600x1200 60 02:21:08 INFO - Main Display: Yes 02:21:08 INFO - Mirror: Off 02:21:08 INFO - Online: Yes 02:21:08 INFO - Rotation: Supported 02:21:08 INFO - Return code: 0 02:21:08 INFO - Running post-action listener: _resource_record_post_action 02:21:08 INFO - [mozharness: 2016-10-16 09:21:08.660466Z] Finished run-tests step (success) 02:21:08 INFO - Running post-run listener: _resource_record_post_run 02:21:08 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 39239168; Write bytes: 659988480; Read time: 362; Write time: 1728 02:21:08 INFO - TinderboxPrint: CPU usage
53.3% 02:21:08 INFO - TinderboxPrint: I/O read bytes / time
39,239,168 / 362 02:21:08 INFO - TinderboxPrint: I/O write bytes / time
659,988,480 / 1,728 02:21:08 INFO - TinderboxPrint: CPU idle
2,259.0 (46.7%) 02:21:08 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 02:21:08 INFO - TinderboxPrint: CPU user
1,610.7 (33.3%) 02:21:08 INFO - TinderboxPrint: Swap in / out
406,302,720 / 0 02:21:08 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356512256; Write bytes: 355448320; Read time: 27687; Write time: 634 02:21:08 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37465600; Write bytes: 293517824; Read time: 342; Write time: 1059 02:21:09 INFO - Running post-run listener: _upload_blobber_files 02:21:09 INFO - Blob upload gear active. 02:21:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:09 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:09 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:09 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:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:10 INFO - (blobuploader) - INFO - Done attempting. 02:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:11 INFO - (blobuploader) - INFO - Done attempting. 02:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:13 INFO - (blobuploader) - INFO - Done attempting. 02:21:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:13 INFO - Return code: 0 02:21:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1aca4426319596d7ce046075e5034660df301b0d49374dd743313edca95e77e06b5cb16f337aaa2a6b44a0e4279fdb26715d7e841fa0223d64af6e2b76c00d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/499439f8368cbd998b0e19c2c7e9d35e2c25933ba566e29abe2c9a895734b362291c91a74edd4dd7cdff7919f02c992e8b37e4bb852f8871006a32c7a59cbce0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d39eea75798994c9bdca3b5fd578cd674b2cdfea48113dc1bb477b69196fec779ee1075a638b49345e739d9f26c501f6734b7283bc5894a8596d99a7c371fce"} 02:21:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:13 INFO - Contents: 02:21:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1aca4426319596d7ce046075e5034660df301b0d49374dd743313edca95e77e06b5cb16f337aaa2a6b44a0e4279fdb26715d7e841fa0223d64af6e2b76c00d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/499439f8368cbd998b0e19c2c7e9d35e2c25933ba566e29abe2c9a895734b362291c91a74edd4dd7cdff7919f02c992e8b37e4bb852f8871006a32c7a59cbce0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d39eea75798994c9bdca3b5fd578cd674b2cdfea48113dc1bb477b69196fec779ee1075a638b49345e739d9f26c501f6734b7283bc5894a8596d99a7c371fce"} 02:21:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:13 INFO - Copying logs to upload dir... 02:21:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.475527 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-16 02:21:13.636614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:13.640691) ========= 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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1aca4426319596d7ce046075e5034660df301b0d49374dd743313edca95e77e06b5cb16f337aaa2a6b44a0e4279fdb26715d7e841fa0223d64af6e2b76c00d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/499439f8368cbd998b0e19c2c7e9d35e2c25933ba566e29abe2c9a895734b362291c91a74edd4dd7cdff7919f02c992e8b37e4bb852f8871006a32c7a59cbce0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d39eea75798994c9bdca3b5fd578cd674b2cdfea48113dc1bb477b69196fec779ee1075a638b49345e739d9f26c501f6734b7283bc5894a8596d99a7c371fce"} 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.011151 build_url: 'https://queue.taskcluster.net/v1/task/Puxrsl1WSX2UbEKTpPV-qw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1aca4426319596d7ce046075e5034660df301b0d49374dd743313edca95e77e06b5cb16f337aaa2a6b44a0e4279fdb26715d7e841fa0223d64af6e2b76c00d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/499439f8368cbd998b0e19c2c7e9d35e2c25933ba566e29abe2c9a895734b362291c91a74edd4dd7cdff7919f02c992e8b37e4bb852f8871006a32c7a59cbce0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d39eea75798994c9bdca3b5fd578cd674b2cdfea48113dc1bb477b69196fec779ee1075a638b49345e739d9f26c501f6734b7283bc5894a8596d99a7c371fce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:13.674233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:13.674667) ========= 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.Q4FHXbkvbY/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.8U5dq4nQOU/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005220 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 02:21:13.724081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 02:21:13.724477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 02:21:13.724873) ========= ========= Total master_lag: 0.21 =========