builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0168 starttime: 1476916627.86 results: success (0) buildid: 20161019142722 builduid: f796e3a919b94dd1bb5097fde56bd5d7 revision: f9f623c85158de2792a8da1026fb5a2b57d7519d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:07.855547) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:07.856058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:07.856336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:07.885830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:07.886250) ========= 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.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-19 15:37:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 81.8M=0s 2016-10-19 15:37:07 (81.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097510 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:08.009288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:08.009619) ========= 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.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.035655 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:08.065386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 15:37:08.065744) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f9f623c85158de2792a8da1026fb5a2b57d7519d --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 f9f623c85158de2792a8da1026fb5a2b57d7519d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-19 15:37:08,143 truncating revision to first 12 chars 2016-10-19 15:37:08,143 Setting DEBUG logging. 2016-10-19 15:37:08,143 attempt 1/10 2016-10-19 15:37:08,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f9f623c85158?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 15:37:10,006 unpacking tar archive at: mozilla-aurora-f9f623c85158/testing/mozharness/ program finished with exit code 0 elapsedTime=2.138633 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 15:37:10.232534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:10.232925) ========= script_repo_revision: f9f623c85158de2792a8da1026fb5a2b57d7519d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:10.233361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:10.233630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:10.252093) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-19 15:37:10.252478) ========= /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.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:37:10 INFO - MultiFileLogger online at 20161019 15:37:10 in /builds/slave/test 15:37:10 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 15:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:10 INFO - {'append_to_log': False, 15:37:10 INFO - 'base_work_dir': '/builds/slave/test', 15:37:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:10 INFO - 'branch': 'Mozilla-Aurora', 15:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:10 INFO - 'config_files': ('talos/mac_config.py',), 15:37:10 INFO - 'default_actions': ('clobber', 15:37:10 INFO - 'read-buildbot-config', 15:37:10 INFO - 'download-and-extract', 15:37:10 INFO - 'populate-webroot', 15:37:10 INFO - 'create-virtualenv', 15:37:10 INFO - 'install', 15:37:10 INFO - 'run-tests'), 15:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:10 INFO - 'download_minidump_stackwalk': True, 15:37:10 INFO - 'download_symbols': 'ondemand', 15:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:10 INFO - 'installer_path': 'installer.exe', 15:37:10 INFO - 'log_level': 'info', 15:37:10 INFO - 'log_name': 'talos', 15:37:10 INFO - 'log_to_console': True, 15:37:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:37:10 INFO - 'opt_config_files': (), 15:37:10 INFO - 'pip_index': False, 15:37:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:37:10 INFO - 'cmd': ('bash', 15:37:10 INFO - '-c', 15:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:37:10 INFO - 'enabled': True, 15:37:10 INFO - 'halt_on_failure': False, 15:37:10 INFO - 'name': 'check_screen_resolution'},), 15:37:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:37:10 INFO - 'cmd': ('bash', 15:37:10 INFO - '-c', 15:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:37:10 INFO - 'enabled': True, 15:37:10 INFO - 'halt_on_failure': False, 15:37:10 INFO - 'name': 'check_screen_resolution'},), 15:37:10 INFO - 'run_cmd_checks_enabled': True, 15:37:10 INFO - 'sps_profile': False, 15:37:10 INFO - 'sps_profile_interval': 0, 15:37:10 INFO - 'suite': 'dromaeojs', 15:37:10 INFO - 'system_bits': '32', 15:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:10 INFO - 'title': 't-yosemite-r7-0168', 15:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:10 INFO - 'use_talos_json': True, 15:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:10 INFO - 'work_dir': 'build'} 15:37:10 INFO - [mozharness: 2016-10-19 22:37:10.453556Z] Running clobber step. 15:37:10 INFO - Running pre-action listener: _resource_record_pre_action 15:37:10 INFO - Running main action method: clobber 15:37:10 INFO - rmtree: /builds/slave/test/build 15:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:12 INFO - Running post-action listener: _resource_record_post_action 15:37:12 INFO - [mozharness: 2016-10-19 22:37:12.613291Z] Finished clobber step (success) 15:37:12 INFO - [mozharness: 2016-10-19 22:37:12.613425Z] Running read-buildbot-config step. 15:37:12 INFO - Running pre-action listener: _resource_record_pre_action 15:37:12 INFO - Running main action method: read_buildbot_config 15:37:12 INFO - Using buildbot properties: 15:37:12 INFO - { 15:37:12 INFO - "project": "", 15:37:12 INFO - "product": "firefox", 15:37:12 INFO - "script_repo_revision": "production", 15:37:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:37:12 INFO - "repository": "", 15:37:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:37:12 INFO - "buildid": "20161019142722", 15:37:12 INFO - "pgo_build": "False", 15:37:12 INFO - "basedir": "/builds/slave/test", 15:37:12 INFO - "buildnumber": 91, 15:37:12 INFO - "slavename": "t-yosemite-r7-0168", 15:37:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:37:12 INFO - "platform": "yosemite_r7", 15:37:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:37:12 INFO - "branch": "mozilla-aurora", 15:37:12 INFO - "repo_path": "releases/mozilla-aurora", 15:37:12 INFO - "revision": "f9f623c85158de2792a8da1026fb5a2b57d7519d", 15:37:12 INFO - "stage_platform": "macosx64", 15:37:12 INFO - "builduid": "f796e3a919b94dd1bb5097fde56bd5d7", 15:37:12 INFO - "slavebuilddir": "test" 15:37:12 INFO - } 15:37:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:37:12 INFO - Running post-action listener: _resource_record_post_action 15:37:12 INFO - [mozharness: 2016-10-19 22:37:12.616828Z] Finished read-buildbot-config step (success) 15:37:12 INFO - [mozharness: 2016-10-19 22:37:12.616975Z] Running download-and-extract step. 15:37:12 INFO - Running pre-action listener: _resource_record_pre_action 15:37:12 INFO - Running main action method: download_and_extract 15:37:12 INFO - mkdir: /builds/slave/test/build/tests 15:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:12 INFO - trying https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:37:12 INFO - Downloading https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:37:13 INFO - Downloaded 1199 bytes. 15:37:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:37:13 INFO - Using the following test package requirements: 15:37:13 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:37:13 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:37:13 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:37:13 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'jsshell-mac.zip'], 15:37:13 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:37:13 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:37:13 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:37:13 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:37:13 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:37:13 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:37:13 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:37:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:37:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:37:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:37:13 INFO - Fetch https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:37:14 INFO - Expected file size: 16436098 15:37:21 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:37:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:37:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:37:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:37:21 INFO - Expected file size: 16436098 15:37:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:37:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:37:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:37:29 INFO - Expected file size: 14414081 15:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:29 INFO - trying https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:37:29 INFO - Downloading https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:37:33 INFO - Downloaded 115419613 bytes. 15:37:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:37:33 INFO - mkdir: /builds/slave/test/properties 15:37:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:37:33 INFO - Writing to file /builds/slave/test/properties/build_url 15:37:33 INFO - Contents: 15:37:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:37:33 INFO - Running post-action listener: _resource_record_post_action 15:37:33 INFO - Running post-action listener: set_extra_try_arguments 15:37:33 INFO - [mozharness: 2016-10-19 22:37:33.655128Z] Finished download-and-extract step (success) 15:37:33 INFO - [mozharness: 2016-10-19 22:37:33.655251Z] Running populate-webroot step. 15:37:33 INFO - Running pre-action listener: _resource_record_pre_action 15:37:33 INFO - Running main action method: populate_webroot 15:37:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:37:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:37:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:37:33 INFO - '--tppagecycles', 15:37:33 INFO - '7'], 15:37:33 INFO - 'tests': ['tsvgm']}}, 15:37:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:37:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:37:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:37:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:37:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:37:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:37:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['damp', 'tps']}, 15:37:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'tests': ['damp', 'tps']}, 15:37:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['dromaeo_dom']}, 15:37:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:37:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['basic_compositor_video']}, 15:37:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:37:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'other-e10s': {'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['a11yr', 15:37:33 INFO - 'ts_paint', 15:37:33 INFO - 'tpaint', 15:37:33 INFO - 'sessionrestore', 15:37:33 INFO - 'sessionrestore_no_auto_restore', 15:37:33 INFO - 'tabpaint']}, 15:37:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['tsvgx', 15:37:33 INFO - 'tsvgr_opacity', 15:37:33 INFO - 'tart', 15:37:33 INFO - 'tscrollx', 15:37:33 INFO - 'cart']}, 15:37:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:37:33 INFO - 'tsvgr_opacity', 15:37:33 INFO - 'tart', 15:37:33 INFO - 'tscrollx', 15:37:33 INFO - 'cart']}, 15:37:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'talos_options': ['--disable-e10s'], 15:37:33 INFO - 'tests': ['tp5o']}, 15:37:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'tests': ['tp5o']}, 15:37:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'talos_options': ['--disable-e10s', 15:37:33 INFO - '--xperf_path', 15:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:37:33 INFO - 'tests': ['tp5n']}, 15:37:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:33 INFO - 'talos_options': ['--xperf_path', 15:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:37:33 INFO - 'tests': ['tp5n']}}, 15:37:33 INFO - 'talos.zip': {'path': '', 15:37:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:37:33 INFO - Running post-action listener: _resource_record_post_action 15:37:33 INFO - [mozharness: 2016-10-19 22:37:33.673935Z] Finished populate-webroot step (success) 15:37:33 INFO - [mozharness: 2016-10-19 22:37:33.674074Z] Running create-virtualenv step. 15:37:33 INFO - Running pre-action listener: _resource_record_pre_action 15:37:33 INFO - Running main action method: create_virtualenv 15:37:33 INFO - Creating virtualenv /builds/slave/test/build/venv 15:37:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:37:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:37:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:37:33 INFO - Using real prefix '/tools/python27' 15:37:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:37:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:37:37 INFO - Installing pip.................done. 15:37:37 INFO - Return code: 0 15:37:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:37 INFO - 'HOME': '/Users/cltbld', 15:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:37 INFO - 'LOGNAME': 'cltbld', 15:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:37 INFO - 'MOZ_NO_REMOTE': '1', 15:37:37 INFO - 'NO_EM_RESTART': '1', 15:37:37 INFO - 'PAGER': '/bin/cat', 15:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:37 INFO - 'PWD': '/builds/slave/test', 15:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:37 INFO - 'SHELL': '/bin/bash', 15:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:37 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:37 INFO - 'USER': 'cltbld', 15:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:37 INFO - 'XPC_FLAGS': '0x0', 15:37:37 INFO - 'XPC_SERVICE_NAME': '0', 15:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:37:37 INFO - Cleaning up... 15:37:37 INFO - Return code: 0 15:37:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:37 INFO - 'HOME': '/Users/cltbld', 15:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:37 INFO - 'LOGNAME': 'cltbld', 15:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:37 INFO - 'MOZ_NO_REMOTE': '1', 15:37:37 INFO - 'NO_EM_RESTART': '1', 15:37:37 INFO - 'PAGER': '/bin/cat', 15:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:37 INFO - 'PWD': '/builds/slave/test', 15:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:37 INFO - 'SHELL': '/bin/bash', 15:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:37 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:37 INFO - 'USER': 'cltbld', 15:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:37 INFO - 'XPC_FLAGS': '0x0', 15:37:37 INFO - 'XPC_SERVICE_NAME': '0', 15:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:38 INFO - Downloading/unpacking psutil>=3.1.1 15:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:37:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:37:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:37:41 INFO - Installing collected packages: psutil 15:37:41 INFO - Running setup.py install for psutil 15:37:41 INFO - building 'psutil._psutil_osx' extension 15:37:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:37:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:37:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:37:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:37:42 INFO - building 'psutil._psutil_posix' extension 15:37:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:37:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:37:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:37:42 INFO - ^ 15:37:42 INFO - 1 warning generated. 15:37:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:37:42 INFO - Successfully installed psutil 15:37:42 INFO - Cleaning up... 15:37:42 INFO - Return code: 0 15:37:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:37: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')]} 15:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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')]} 15:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:37: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 mozsystemmonitor==0.3 15:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:42 INFO - 'HOME': '/Users/cltbld', 15:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:42 INFO - 'LOGNAME': 'cltbld', 15:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:42 INFO - 'MOZ_NO_REMOTE': '1', 15:37:42 INFO - 'NO_EM_RESTART': '1', 15:37:42 INFO - 'PAGER': '/bin/cat', 15:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:42 INFO - 'PWD': '/builds/slave/test', 15:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:42 INFO - 'SHELL': '/bin/bash', 15:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:42 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:42 INFO - 'USER': 'cltbld', 15:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:42 INFO - 'XPC_FLAGS': '0x0', 15:37:42 INFO - 'XPC_SERVICE_NAME': '0', 15:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:37:45 INFO - Installing collected packages: mozsystemmonitor 15:37:45 INFO - Running setup.py install for mozsystemmonitor 15:37:45 INFO - Successfully installed mozsystemmonitor 15:37:45 INFO - Cleaning up... 15:37:45 INFO - Return code: 0 15:37:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:45 INFO - 'HOME': '/Users/cltbld', 15:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:45 INFO - 'LOGNAME': 'cltbld', 15:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:45 INFO - 'MOZ_NO_REMOTE': '1', 15:37:45 INFO - 'NO_EM_RESTART': '1', 15:37:45 INFO - 'PAGER': '/bin/cat', 15:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:45 INFO - 'PWD': '/builds/slave/test', 15:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:45 INFO - 'SHELL': '/bin/bash', 15:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:45 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:45 INFO - 'USER': 'cltbld', 15:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:45 INFO - 'XPC_FLAGS': '0x0', 15:37:45 INFO - 'XPC_SERVICE_NAME': '0', 15:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:46 INFO - Downloading/unpacking jsonschema==2.5.1 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:37:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:37:49 INFO - warning: no files found matching '*.txt' 15:37:49 INFO - no previously-included directories found matching 'build' 15:37:49 INFO - no previously-included directories found matching 'dist' 15:37:49 INFO - no previously-included directories found matching '.git*' 15:37:49 INFO - Installing collected packages: jsonschema, functools32 15:37:49 INFO - Running setup.py install for functools32 15:37:49 INFO - warning: no files found matching '*.txt' 15:37:49 INFO - no previously-included directories found matching 'build' 15:37:49 INFO - no previously-included directories found matching 'dist' 15:37:49 INFO - no previously-included directories found matching '.git*' 15:37:49 INFO - Successfully installed jsonschema functools32 15:37:49 INFO - Cleaning up... 15:37:49 INFO - Return code: 0 15:37:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:49 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:49 INFO - 'HOME': '/Users/cltbld', 15:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:49 INFO - 'LOGNAME': 'cltbld', 15:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:49 INFO - 'MOZ_NO_REMOTE': '1', 15:37:49 INFO - 'NO_EM_RESTART': '1', 15:37:49 INFO - 'PAGER': '/bin/cat', 15:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:49 INFO - 'PWD': '/builds/slave/test', 15:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:49 INFO - 'SHELL': '/bin/bash', 15:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:49 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:49 INFO - 'USER': 'cltbld', 15:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:49 INFO - 'XPC_FLAGS': '0x0', 15:37:49 INFO - 'XPC_SERVICE_NAME': '0', 15:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:37:49 INFO - Cleaning up... 15:37:49 INFO - Return code: 0 15:37:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:49 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:49 INFO - 'HOME': '/Users/cltbld', 15:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:49 INFO - 'LOGNAME': 'cltbld', 15:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:49 INFO - 'MOZ_NO_REMOTE': '1', 15:37:49 INFO - 'NO_EM_RESTART': '1', 15:37:49 INFO - 'PAGER': '/bin/cat', 15:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:49 INFO - 'PWD': '/builds/slave/test', 15:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:49 INFO - 'SHELL': '/bin/bash', 15:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:49 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:49 INFO - 'USER': 'cltbld', 15:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:49 INFO - 'XPC_FLAGS': '0x0', 15:37:49 INFO - 'XPC_SERVICE_NAME': '0', 15:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:49 INFO - Downloading/unpacking blobuploader==1.2.4 15:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:37:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:37:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:53 INFO - Downloading docopt-0.6.1.tar.gz 15:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:37:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:37:53 INFO - Running setup.py install for blobuploader 15:37:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:37:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:37:53 INFO - Running setup.py install for requests 15:37:54 INFO - Running setup.py install for docopt 15:37:54 INFO - Successfully installed blobuploader requests docopt 15:37:54 INFO - Cleaning up... 15:37:54 INFO - Return code: 0 15:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:54 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:54 INFO - 'HOME': '/Users/cltbld', 15:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:54 INFO - 'LOGNAME': 'cltbld', 15:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:54 INFO - 'MOZ_NO_REMOTE': '1', 15:37:54 INFO - 'NO_EM_RESTART': '1', 15:37:54 INFO - 'PAGER': '/bin/cat', 15:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:54 INFO - 'PWD': '/builds/slave/test', 15:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:54 INFO - 'SHELL': '/bin/bash', 15:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:54 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:54 INFO - 'USER': 'cltbld', 15:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:54 INFO - 'XPC_FLAGS': '0x0', 15:37:54 INFO - 'XPC_SERVICE_NAME': '0', 15:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:54 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-CcELDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-AcNoTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-gTCaUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-VTcS5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-du6jHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-mXiXKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ua0rvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-OWh7gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-RyNvgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-VxtTEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:55 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-1na3DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-k7kPgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Q65eKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-T8S7G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-zzfjd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-7_vIOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-T1rduG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:37:56 INFO - Running setup.py install for manifestparser 15:37:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:37:56 INFO - Running setup.py install for mozcrash 15:37:56 INFO - Running setup.py install for mozdebug 15:37:57 INFO - Running setup.py install for mozdevice 15:37:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Running setup.py install for mozfile 15:37:57 INFO - Running setup.py install for mozhttpd 15:37:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Running setup.py install for mozinfo 15:37:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Running setup.py install for mozInstall 15:37:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:37:57 INFO - Running setup.py install for mozleak 15:37:58 INFO - Running setup.py install for mozlog 15:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Running setup.py install for moznetwork 15:37:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Running setup.py install for mozprocess 15:37:58 INFO - Running setup.py install for mozprofile 15:37:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Running setup.py install for mozrunner 15:37:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:37:58 INFO - Running setup.py install for mozscreenshot 15:37:58 INFO - Running setup.py install for moztest 15:37:59 INFO - Running setup.py install for mozversion 15:37:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:37:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:37:59 INFO - Cleaning up... 15:37:59 INFO - Return code: 0 15:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:59 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:59 INFO - 'HOME': '/Users/cltbld', 15:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:59 INFO - 'LOGNAME': 'cltbld', 15:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:59 INFO - 'MOZ_NO_REMOTE': '1', 15:37:59 INFO - 'NO_EM_RESTART': '1', 15:37:59 INFO - 'PAGER': '/bin/cat', 15:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:59 INFO - 'PWD': '/builds/slave/test', 15:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:59 INFO - 'SHELL': '/bin/bash', 15:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:37:59 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:59 INFO - 'USER': 'cltbld', 15:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:59 INFO - 'XPC_FLAGS': '0x0', 15:37:59 INFO - 'XPC_SERVICE_NAME': '0', 15:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:59 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-RicYQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:59 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-l1ykAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:59 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-pC9XuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:59 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-vDoifN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:59 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-A68a_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-5Ybwyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-L5oW8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-BD6xy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-JbiySy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-TVsE9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ZV3nLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-rGwO0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-coqUPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:00 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-rTj6o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:01 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Jo_zVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:01 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-6rBRQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:01 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-yAsZlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:03 INFO - Downloading blessings-1.6.tar.gz 15:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:38:04 INFO - Installing collected packages: blessings 15:38:04 INFO - Running setup.py install for blessings 15:38:04 INFO - Successfully installed blessings 15:38:04 INFO - Cleaning up... 15:38:04 INFO - Return code: 0 15:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:04 INFO - Reading from file tmpfile_stdout 15:38:04 INFO - Current package versions: 15:38:04 INFO - blessings == 1.6 15:38:04 INFO - blobuploader == 1.2.4 15:38:04 INFO - docopt == 0.6.1 15:38:04 INFO - functools32 == 3.2.3-2 15:38:04 INFO - jsonschema == 2.5.1 15:38:04 INFO - manifestparser == 1.1 15:38:04 INFO - mozInstall == 1.12 15:38:04 INFO - mozcrash == 0.17 15:38:04 INFO - mozdebug == 0.1 15:38:04 INFO - mozdevice == 0.48 15:38:04 INFO - mozfile == 1.2 15:38:04 INFO - mozhttpd == 0.7 15:38:04 INFO - mozinfo == 0.9 15:38:04 INFO - mozleak == 0.1 15:38:04 INFO - mozlog == 3.4 15:38:04 INFO - moznetwork == 0.27 15:38:04 INFO - mozprocess == 0.23 15:38:04 INFO - mozprofile == 0.28 15:38:04 INFO - mozrunner == 6.12 15:38:04 INFO - mozscreenshot == 0.1 15:38:04 INFO - mozsystemmonitor == 0.3 15:38:04 INFO - moztest == 0.7 15:38:04 INFO - mozversion == 1.4 15:38:04 INFO - psutil == 3.1.1 15:38:04 INFO - requests == 1.2.3 15:38:04 INFO - wsgiref == 0.1.2 15:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:04 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:04 INFO - 'HOME': '/Users/cltbld', 15:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:04 INFO - 'LOGNAME': 'cltbld', 15:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:04 INFO - 'MOZ_NO_REMOTE': '1', 15:38:04 INFO - 'NO_EM_RESTART': '1', 15:38:04 INFO - 'PAGER': '/bin/cat', 15:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:04 INFO - 'PWD': '/builds/slave/test', 15:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:04 INFO - 'SHELL': '/bin/bash', 15:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:38:04 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:04 INFO - 'USER': 'cltbld', 15:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:04 INFO - 'XPC_FLAGS': '0x0', 15:38:04 INFO - 'XPC_SERVICE_NAME': '0', 15:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:38:04 INFO - Cleaning up... 15:38:04 INFO - Return code: 0 15:38:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:04 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 0x1012d0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101246570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a34aff70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, '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.Jl1dLACst9/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.WwBl8sh89L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:04 INFO - 'HOME': '/Users/cltbld', 15:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:04 INFO - 'LOGNAME': 'cltbld', 15:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:04 INFO - 'MOZ_NO_REMOTE': '1', 15:38:04 INFO - 'NO_EM_RESTART': '1', 15:38:04 INFO - 'PAGER': '/bin/cat', 15:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:04 INFO - 'PWD': '/builds/slave/test', 15:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:04 INFO - 'SHELL': '/bin/bash', 15:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:38:04 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:04 INFO - 'USER': 'cltbld', 15:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:04 INFO - 'XPC_FLAGS': '0x0', 15:38:04 INFO - 'XPC_SERVICE_NAME': '0', 15:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:38:05 INFO - Cleaning up... 15:38:05 INFO - Return code: 0 15:38:05 INFO - Running post-action listener: _resource_record_post_action 15:38:05 INFO - Running post-action listener: _start_resource_monitoring 15:38:05 INFO - Starting resource monitoring. 15:38:05 INFO - [mozharness: 2016-10-19 22:38:05.111329Z] Finished create-virtualenv step (success) 15:38:05 INFO - [mozharness: 2016-10-19 22:38:05.112288Z] Running install step. 15:38:05 INFO - Running pre-action listener: _resource_record_pre_action 15:38:05 INFO - Running main action method: install 15:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:05 INFO - Reading from file tmpfile_stdout 15:38:05 INFO - Detecting whether we're running mozinstall >=1.0... 15:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:38:05 INFO - Reading from file tmpfile_stdout 15:38:05 INFO - Output received: 15:38:05 INFO - Usage: mozinstall [options] installer 15:38:05 INFO - Options: 15:38:05 INFO - -h, --help show this help message and exit 15:38:05 INFO - -d DEST, --destination=DEST 15:38:05 INFO - Directory to install application into. [default: 15:38:05 INFO - "/builds/slave/test"] 15:38:05 INFO - --app=APP Application being installed. [default: firefox] 15:38:05 INFO - mkdir: /builds/slave/test/build/application 15:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:38:37 INFO - Reading from file tmpfile_stdout 15:38:37 INFO - Output received: 15:38:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:38:37 INFO - Running post-action listener: _resource_record_post_action 15:38:37 INFO - [mozharness: 2016-10-19 22:38:37.343048Z] Finished install step (success) 15:38:37 INFO - [mozharness: 2016-10-19 22:38:37.343184Z] Running run-tests step. 15:38:37 INFO - Running pre-action listener: _resource_record_pre_action 15:38:37 INFO - Running main action method: run_tests 15:38:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:38:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:38:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:38:37 INFO - 2016-10-19 15:38:37.358 screenresolution[1638:7555] starting screenresolution argv=screenresolution get 15:38:37 INFO - 2016-10-19 15:38:37.360 screenresolution[1638:7555] Display 0: 1600x1200x32@60 15:38:37 INFO - 2016-10-19 15:38:37.366 screenresolution[1639:7557] starting screenresolution argv=screenresolution list 15:38:37 INFO - Available Modes on Display 0 15:38:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:38:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:38:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:38:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:38:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:38:37 INFO - Intel Iris: 15:38:37 INFO - Chipset Model: Intel Iris 15:38:37 INFO - Type: GPU 15:38:37 INFO - Bus: Built-In 15:38:37 INFO - VRAM (Dynamic, Max): 1536 MB 15:38:37 INFO - Vendor: Intel (0x8086) 15:38:37 INFO - Device ID: 0x0a2e 15:38:37 INFO - Revision ID: 0x0009 15:38:37 INFO - Displays: 15:38:37 INFO - Display: 15:38:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:38:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:38:37 INFO - Display Serial Number: 1600x1200 60 15:38:37 INFO - Main Display: Yes 15:38:37 INFO - Mirror: Off 15:38:37 INFO - Online: Yes 15:38:37 INFO - Rotation: Supported 15:38:37 INFO - Return code: 0 15:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:38:37 INFO - Python 2.7.3 15:38:37 INFO - Return code: 0 15:38:37 INFO - grabbing minidump binary from tooltool 15:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:37 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 0x1010e4d30>, '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 0x100f4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010dcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:38:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:38:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:38:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:38:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:38:37 INFO - Return code: 0 15:38:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:38:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:38:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:38:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:38:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:38:37 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/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 15:38:37 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/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0168 --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 15:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jl1dLACst9/Render', 15:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:37 INFO - 'HOME': '/Users/cltbld', 15:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:37 INFO - 'LOGNAME': 'cltbld', 15:38:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:38:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:37 INFO - 'MOZ_NO_REMOTE': '1', 15:38:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:38:37 INFO - 'NO_EM_RESTART': '1', 15:38:37 INFO - 'PAGER': '/bin/cat', 15:38:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:37 INFO - 'PWD': '/builds/slave/test', 15:38:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:37 INFO - 'SHELL': '/bin/bash', 15:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwBl8sh89L/Listeners', 15:38:37 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 15:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:37 INFO - 'USER': 'cltbld', 15:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:37 INFO - 'XPC_FLAGS': '0x0', 15:38:37 INFO - 'XPC_SERVICE_NAME': '0', 15:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:37 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/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 15:38:37 INFO - mozversion application_buildid: 20161019142722 15:38:37 INFO - mozversion application_changeset: f9f623c85158de2792a8da1026fb5a2b57d7519d 15:38:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:38:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:38:37 INFO - mozversion application_name: Firefox 15:38:37 INFO - mozversion application_remotingname: firefox-dev 15:38:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:38:37 INFO - mozversion application_vendor: Mozilla 15:38:37 INFO - mozversion application_version: 51.0a2 15:38:37 INFO - mozversion platform_buildid: 20161019142722 15:38:37 INFO - mozversion platform_changeset: f9f623c85158de2792a8da1026fb5a2b57d7519d 15:38:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:38:37 INFO - mozversion platform_version: 51.0a2 15:38:37 INFO - using testdate: 1476916717 15:38:37 INFO - actual date: 1476916717 15:38:37 INFO - starting webserver on 'localhost:49272' 15:38:37 INFO - SUITE-START | Running 2 tests 15:38:37 INFO - TEST-START | dromaeo_css 15:38:37 INFO - operating with platform_type : mac_ 15:38:37 INFO - Initialising browser for dromaeo_css test... 15:38:37 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmptpFwnm/profile http://localhost:49272/getInfo.html) 15:38:40 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 15:38:40 INFO - PROCESS | 1649 | colorDepth:24 15:38:40 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 15:38:40 INFO - PROCESS | 1649 | __metrics 15:38:40 INFO - PROCESS | 1649 | 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" 15:38:40 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:41 INFO - TEST-INFO | 1649: exit 0 15:38:41 INFO - Browser initialized. 15:38:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:38:41 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmptpFwnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:53 INFO - PROCESS | 1651 | RSS: Main: 219893760 15:38:53 INFO - PROCESS | 1651 | 15:39:44 INFO - PROCESS | 1651 | 1476916784103 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:41:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 15:41:57 INFO - PROCESS | 1651 | RSS: Main: 344879104 15:41:57 INFO - PROCESS | 1651 | 15:45:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 15:45:01 INFO - PROCESS | 1651 | RSS: Main: 352366592 15:45:01 INFO - PROCESS | 1651 | 15:48:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 15:48:04 INFO - PROCESS | 1651 | RSS: Main: 316571648 15:48:04 INFO - PROCESS | 1651 | 15:51:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 15:51:06 INFO - PROCESS | 1651 | RSS: Main: 329072640 15:51:06 INFO - PROCESS | 1651 | 15:54:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 15:54:10 INFO - PROCESS | 1651 | RSS: Main: 311037952 15:54:10 INFO - PROCESS | 1651 | 15:57:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 15:57:14 INFO - PROCESS | 1651 | RSS: Main: 453701632 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | __start_tp_report 15:57:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 15:57:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 15:57:14 INFO - PROCESS | 1651 | |i|pagename|runs| 15:57:14 INFO - PROCESS | 1651 | |0;dojo.html;3197.1207917822594;3270.2151483643925;3290.572225610672;3291.687289707477;3336.0325505603378;5233.9738301308535;5573.972130139348;5603.187537807015;5637;5659.830205093848;5006.274090256919;5633.746481408336;5640.576956728241;5644.971775141129;5650.7174641267875;5109.0803655342115;5132.435432102466;5142.820001299955;5191.896162076756;5265.131253343194;5131.846044618667;5141.922871156917;5146.253793199984;5225.608079394042;5229.058769421503;5143.639945203838;5145.716985565792;5189.6107791915565;5199.09015922214;5201.635885488017;5186.974065129669;5192.870178245536;5195.220716892496;5248.790048398059;5262.710550919698;4973.452920178777;5186.792528298901;5189.584833213372;5194.454582268845;5209.296744939423;4854.635902307341;5523.088690366085;5582.7766889324375;5584.944150558524;5593.804216852391;6112.430563146515;6137.232845894263;6174.135621013062;6183.258009038944;6184.134221209034;6251.437370636619;6252.343503932113;6303.8739225215695;6306.369363063703;6316.210473690789;5570.749316280737;5614.326280846243;5676.120201368794;5728.541716662657;5734.139879018139;6364.777232796922;6384.872302553923;6392.552521323462;6400.135981642512;6404.807855764241;6084.6349219047;6091.817245482643;6095.512359011268;6107.786227482017;6112.480439162721;6074.635521868614;6119.744969117336;6125.449118208436;6135.662538560333;6238.251409830849;6103.389005355301;6113.419225173601;6125.877482450415;6126.295476020226;6130.325664176937;6109.920916985209;6124.234470691164;6185.134081228632;6199.473044791153;6201.348858369806;4936.160852655057;4936.432310284292;4939.851804445872;4944.60443164546;4960.206366981338;4443.155800397914;4445.4220951276775;4453.576910193527;4479.619232365286;4521.480029796549;5617.354004289477;5658.292713410824;5666.065099258576;5734.770609175586;5780.248567686174;4787.928181077286;5054.646174767731;6181.721822517998;6182.28903676083;6199.256089269226;5727.968965586151;5777.046787280052;5787.276590426197;5817.7382017809305;5825;4073.327900896319;4586.334981427741;5319.28189694394;5350.9732451337495;5358.169483730028;6218.160548325918;6221.96889015552;6245.96877015612;6261.279952805395;6360.363963603695;6099.695015249308;6187.3503282154725;6194.969025154845;6209;6214.067889816563;5363.222332761806;6256.7810126645345;6296.937030629635;6315.652639104894;6330.01884707871;5995.100734889801;6038.335783063947;6042.90935635957;6075.210222671025;6148.262208535004;6144.924638188389;6209.472194863487;6212.875742485216;6217.285012223652;6218.689065546795;4973.900521989468;5953.851153721018;6063.302720187235;6085.817425477243;6096.725647345791;5880.470757631833;6009.909851352146;6035.78874739382;6037.939620603738;6073.848153796191;5831.79588714393;5906.734196961061;5945.762169513171;6022.337542870193;6043.425874541911;5083.517065878736;6126.1423400724825;6137.263528376623;6143.416375444325;6152.323244443018;5933.05071188625;5961.344252132175;5980.551458640706;5995.910061348996;5997.340292567901 15:57:14 INFO - PROCESS | 1651 | |1;ext.html;461.5799622343668;462.6298960831334;492.40419092897594;503.544292415364;517.7721802406941;27846.44307113859;39619;40938.7953060235;41013.58986410135;41059.17881642373;42285.36571951416;42768.3584746229;42848.714538563894;42866.35700464495;42867.35698964518;9716.174125199348;9903.851442228372;9905.207583393347;9915.305928585001;9920.305578609501;8662.913370866305;8883.200511953923;11853.881461185407;12098.939505302505;12124.515019399214;12128.878711212863;12242.85749993752;12249.203801752901;12260.877391226108;12303.015758739324;12065.577704780335;12136;12139.453724582416;12144.514219431301;12154.33151176685;8235;8626;8843.159899809507;8855.512946787923;8953.865692014626;36694;39362.40956385656;39435.802820985715;41600.95997600084;41679.95800104991;3330.800151990864;3385.1029477188563;3580.8210629541095;3620.5474315710535;3858.074062225046;29381.11856644304;29434;30447.39105217883;30726.38547229065;31560.842195789104;2904.549794781812;3125.140586338752;3259.5925509311337;3274.3287626036845;3291.6214635317006;524497;534623;534886.3255683735;535680;536963;58024.70987645119;58342.41657583455;58475.83048339009;58479;58666;60610.09084863731;60710.08934865981;60723.392766072655;60775;60878.39121608727;15841.049537027815;16355.754663680054;16386;16387.180640967905;16401.42595009169;11565.826512602318;11830.645080647595;12799.872001279868;12887.677808054686;12898.03264755147;13601.931990339985;14934.178620175777;15293;15399.692006159814;15728.449504267295;6437.356264373619;6498.642574658439;6506.089147519351;6508.17771024114;6516.120323756232;818.2063398503442;920.5949382271913;939.0515579264855;941.9434833909987;943.3490891284991;29607.555886661718;29779.702202978126;29822.850885745866;30392.240193994883;30414;901.6303315640556;1051.363924825485;1090.7129587087313;1131.12337938097;1155.9017483513828;12129.211601246066;14870.330835112445;15388.61528461775;15472.69713239474;15644.530664080095;652636;657160;660002;660328;662642.686786563;56740;56807.715961419926;56832.14751778726;56862.7156864213;57057.42942570604;1232.7657745028416;1262.110212300326;1345.1189470896384;1360.4082224232293;1383.7163381506969;30330.876838621967;30414.087577372713;31169.68830311668;31804.681953181098;31851.68148318487;47623.80940476516;53831.19253211284;55555.999999998385;55597;59125.70437147787;607148;612838;614054;614482;614538;25198.874005629856;25229;25647.97408103655;25958.22125336243;26198.86900565485;46841;46860;46970.53029469662;47080.52919470761;47718.5228147728;36924.89225323244;37733;39842.60157398505;40874.79562602168;41910.37134443047;38563.807180963915;38942.221155577296;39006;40135.39796903107;40523;36831;37235.81382093072;38674;38736.61263387443;38737.6126238734;26283.342916427242;27527.363010106244;34072.14819629529;34913.82543087268;34940;22240;25449.745502544738;25612.103576375484;25683.614745778454;26041.95832166768 15:57:14 INFO - PROCESS | 1651 | |2;jquery.html;351.2798762536799;373.5013756634893;374.53931664053215;381.608850927799;400.03790882926575;14939.775903361458;15181.772273415894;17065.488035358943;21280.36158915231;21525.784742152573;20059.39821805348;20081.995900205005;20543.97280135991;20707.171713131494;20935.685964710505;5652.236948012017;5978.491828194608;5984.88030239395;5985.820425387224;5990.041593345066;3482.9477557836653;4315.223259813232;5620.57845661575;5842.036064049426;6373.26707428647;6561.967190164042;6645.966770166143;6654;6666.466682665399;6682.632455214961;6408.295087540367;6543.1821022372205;6597.1093902323055;6597.142371491724;6604.207495100571;5376.892462150735;5572.275604171472;5707.800226992077;5758.337791154029;5773.711314434304;23627.881860590758;23789.524209515886;24827.751722482724;26180.345491362677;26361.73638263612;2201;2294.5640328337563;2366.420227044368;2558.2581051495044;2744.67063952325;8075;9307.255419566418;9959.402435853872;10032.071203043064;10197.490125493696;1776.5825031117806;1811.1759149586906;1817.391173956726;1906.20892329683;1924.2687778644026;121700;124796;124951.9999999991;125319;128410;11217.439128043565;11451.54193832254;11549.018333441583;11553.422328883522;11843.940780296216;12500.24998500093;13196.934015330055;13229.801552976713;13469.932650336686;14340.426382944774;8512.914870851213;8560.61477233526;8693.34799889998;8785.868211976825;8825.91174088251;7090.751823686146;8647.56762161902;8693.087225841196;8852.114788521225;8882.289416846637;4395.824167033346;4474.39595654589;4477.19410506112;4540.88647783808;4587.288970209623;1566.8041494813149;1880.6238752249606;1895.6208758248129;1907.8950657713958;1947.990260048719;881.1761003461784;930.6324002019164;952.642758965388;983.6163896080391;1015.3806178231273;17477.388291409992;20521;21540.56918861614;21569.676454852877;21662.025208865638;841.6465084664455;942.4345392764424;942.7737343037621;952.5606897373802;973.7176218896583;10405.21960852939;11470.197086204053;11503;11531.308121512737;11543.538258469567;567786;571038;576567;577183;581198;60913;75132.87300690493;132015.99999999808;135654.3217283927;137473.62526374607;953.3707752883064;979.4123525884412;998.1316254858175;1000.5047501486811;1002.0931057393071;18682.626347473248;19146.80853191506;19214.615707686047;19552.413427597196;19596.216151353787;43036.78481607572;55732.442675572725;56987.71506142443;58613.4138658625;58775.11837322358;60762;75141;76933;83257.16742832494;83731;7013.2986701329455;7185.101862267216;7392.778216653509;7401;7467.813304667427;7265.527740696838;10681.03870651645;12159.392030398269;12919.741605167656;13062.54281100157;9424.198943089914;10451.372917624967;11164.441777911234;11261.549538018387;11663;9799.412035277906;10969.341839489656;11197.66407007791;11635.127365447795;11827.467763950815;11410.82883756761;11614.6515604532;11824.054075674097;11846.763064738485;11948.088305871019;7837.451378403457;7971.800704982422;8299.377546683902;8313.792155196168;8354.58227088631;8415.831683366421;9268.397554158959;10951.56193752241;11072.39101849406;11337.433128343386 15:57:14 INFO - PROCESS | 1651 | |3;mootools.html;1377.5798381493642;1540.8767298616112;1584.0258241181675;1777.448990812848;1923.28838329818;7898.447108702393;8434.15658434157;8787.384883058181;8883.644654213824;9043.186113249807;8916.955415222916;8993.190612844843;9005.909940900605;9015.549222538863;9017.909820901788;2382.7736365045293;2406.831521793475;2408.4460574067975;2413.0589070262613;2415.4806716555936;2381.023780250098;2403.9399015024587;2434.160214725917;2435.9878200608973;2438.085717855804;2380.345405013618;2407.0131246189067;2407.3379820549403;2408.8554686718767;2417.528581926525;2358.8820558971984;2376.3227480168157;2388.677528533643;2391.940201494959;2403.0267741564694;2270.375646697155;2342.906283748648;2347.260612906946;2351.6354964980455;2353.705786776653;8767.254783343424;8929.241014513775;8971.641134354619;9021;9036.8644470333;5286.233496143038;5481.068218402881;5500.7524661390335;5509.118541033416;5521.337439507245;3609.981950090259;3651.4887915691825;3700.4634328022285;3715.64701353371;3742.438634204864;954.9283803714749;1094.1356328500476;1111.377628528027;1127.143371038017;1136.5681041204373;11717.179797414185;11721.355325457096;11755.17713760037;11850.40747962607;11863.288202707865;4456.888577785517;4486.887827804266;4678.321643361762;4683.250679891201;4690.695104818176;9167.358284920125;9175.403598766059;9177.954110229539;9180.127887850644;9180.954095229481;5282.788688452496;5290.232916227125;5296.1261391870685;5298.70857102863;5312.362516498045;3893.610638936084;4366.279563871989;4438.400815889878;4560.110778398181;4937;3500.7199424046016;3826.6364695354455;3896.0454688601476;3902;3906.628870257321;1086.733954942499;1152.7406333575045;1185.25921299188;1193.176708071428;1208.1663652080038;658.3646780856496;785.077533897668;906.2342320738965;911.5260064766285;917.4770380882966;5231.843044708665;5479.287692599936;5751.424857514299;5787.102999035156;5944.552159747336;878.1043335797451;899.4468401932895;904.3579058868277;912.7033714042963;967.4533888353058;3713.2759111972905;3913.149840987685;3960.34654282046;3978.144698889753;4010.8997275068355;10631.362118272928;10800.297980631234;10961.890381096087;11119.27724697892;11122.721931951766;10815.78368432627;11058.944705276583;11061.225714199929;11066.39134847575;11085.27945683528;8258.463199891989;8412.537310447984;8453.070162282143;8469.40714150016;8472.068072512018;5601.747921343468;5677.120046392815;5751.482366587027;5854.5609079320075;5866.178734977021;10061.195104391485;10098.899011009797;10141.188704903738;10253.948730256301;10291.794164116825;9298.163165315154;9947.651832185838;10271.589136434459;10504.78990420172;10603.575856965635;5916.408359164049;7116.323949224816;7176.7488137914925;7198.964005179941;7284.271572842674;8273.669053237803;8307.376946728898;8395.874061888955;8421.4947103174;8466.534340611326;7576.7348142814735;7576.8484630308185;7602.923970760222;7617.581033043236;7631;6282.560220784501;7276.890846637199;7418.814529636802;7494.213107623621;7687.192844751445;7017.7192912282935;7053.788386348418;7119.572825630479;7123.358897699025;7135.785926422215;4253.808578613908;4782.665213435026;4977.552020318189;5045.268436076822;5138.640295179302;4292.613664770186;4939.48135445773;5038.370203724535;5053.343065401475;5097.158968770112 15:57:14 INFO - PROCESS | 1651 | |4;prototype.html;295.06611574367116;296.3406420713912;305.5996644395841;307.93995170941673;311.1660749192164;5064.493075927421;5067.047702791829;5229.385307346327;5273.762680679369;5287;4356.477222733269;4534.795934182961;4956.231784073465;5033.874153146173;5191.221316802482;4021.7130518234176;4030.415589739486;4033.6773058155422;4041.191761647675;4058.817353219112;3571.1072231942017;3752.3058234226755;3932.5870783567743;4046.898827529306;4087.9386809197886;3202.9839850800713;3996.960030399702;4020.4773379460776;4060.4315395844606;4062.2281766464275;2989.6860829612797;3677.5841301099267;3728.2543491301576;3965.841366345357;3986.983319253586;3263.2494526258856;3422.9657703422895;3448.74134439918;3536.8682021753048;3545.3868489837064;4519.932201016954;4851.539103785135;5035.748212589392;5050;5080.339555857752;3714.7771133732062;4455.732656040648;4472.84345047925;4493.438320209973;4499.605122412063;5125.642204585895;5384.300040994684;5442.836714898559;5445.754941027623;5452.4274951129955;3734.141147536082;3877.5540812806325;3877.9335682687206;3896;3909.1204478992;4560.521145279731;5038.992201559703;5721.485066344049;5726.680694318849;5792.362840087587;3434.862605495802;3849.8652547160714;3851.422286657024;3939.4681717967705;3988;3521.2710149633726;3975.0857302820514;4016.5180178378782;4031.9798401008393;4047.8583249586122;4562.429696287964;4572.474165470947;4587;4592.839250626212;4620.399348084795;5513.365962914316;5521.696306703089;5525.066226820661;5539.833804985857;5587.106063029895;1260.9243445393306;1262.7158889249845;1371.6845125621162;1373.594789537089;1376.6902446949557;804.3605333759558;827.9089300176976;829.995850020746;842.0653075086649;850.0521918061318;3714.2200137971327;3764.887053388403;3856.8650097246464;4269.5090064642345;4284.892877678083;3998.100427403869;4269.615734583902;4578.931316030262;4601.447826260804;4655.534446555385;3868.4390763339156;4157.355609880413;4291.849785257501;4302.720323178984;4329.588689074533;2297.4951406828554;2427.587310157242;2437.59779636358;2445.7431969643285;2465.249672732344;4345.521992580813;4627.334159702505;4706.458757242961;4790.281457781291;4809.254565542346;4655.37152484417;4656.883577910579;4663.533646635309;4684.969306752509;4790.8323208687525;4298.46269216348;4562.543745625411;4600.503617250846;4620.422447194101;4788.1381351356395;4413.271810151289;4439.778011099496;4575.679702420799;4587.885302867455;4593;3976.383660532622;4115.263349872302;4521.12373365063;4566.538707613532;4647.604953578849;4237.2584797659665;4303.483581970184;4619.4687610925175;5040.5967522597375;5896.970515147397;3301.290222602152;3392.69465748074;3539.6106428293383;3723.944140837835;3733.9358282890335;4328.372386003949;4412.713173643703;5429.402765695691;5744.396838331915;5816.825495234981;4907.8221226906;5090.796368145233;5533.565231298216;5542.362628297636;5680.642533348614;5303.284056652303;5472.890542189213;5480.1231802912935;5533.059379905345;5571;5422.186671999074;5436.0758671026815;5445.346558413015;5454.709022210602;5467.835964921059;4930.260460930889;5224.634275600672;5246.711430871339;5538.1786567268455;5560.610757246954;4221.683373747042;4596.448426188745;5349.358077030781;5405.9459405407015;5568.939492387681 15:57:14 INFO - PROCESS | 1651 | |5;yui.html;701.2531653788715;720.5856632436347;753.9934187859208;773.7872085176572;802.9959850200748;15092.77360839587;15546.689066218669;15620.609484762857;16350.83649163508;16362.7727920406;14682.706345873075;14760.557183284518;14938.925305373485;14950.953433259676;14969.775453368207;804.6379129391768;825.1047613339534;830.3979614779267;830.9501429914225;831.085805613826;558.9664620122805;696.7247937064857;820.1634332980357;839.6851180807197;841.4698739793921;898.2679116520048;901.342020325163;903.7740564858785;904.7059705595675;906;894.4186278918722;896.1128482801979;897.2104547997753;900.3472482450237;901.3195037746525;520.1209955175741;540.645876950598;631.902055181443;644.391050457318;666.6866572710818;12031.699207519794;14296.499622513265;14305.141691498544;14347.282635868269;14368.568942931728;13939.930300348433;14267;14314.713705725932;14513.637159071002;14524.636884077983;12476.625701228977;12630.242185468902;12688;12969;13240.536581219707;4451;4541.477730061019;4563.726176429424;4599.678022538424;4722;120200;123434;123586;123713.38143309226;126934.36532817369;10769.515371808131;10798.946005269923;11049.392283424328;11108.500117494732;11190.440477976068;22696.432589185402;22885.771142288697;22925.312240632808;22935.967881445376;22987.425314367276;7892;7900.723474678359;8083.434159608771;8236.217559331853;8269.00771907375;4377.416017858125;4380.7152535085115;4461.464624245046;4481.126180394857;4493.213687604656;2769.321516228537;3158.3209609933974;3283.3925723741186;3283.819389933529;3305.636379998198;629.7386584567445;640.57401827784;647.7862305439194;656.8325077105308;662.5362246427424;544.2598066629381;577.4831525784399;581.4708615160268;622.5673157155733;642.6240649220258;7784.026996625422;8934.955325223333;9492.240620750461;9826;10038.196944244442;613.4601550635413;622.6233128957007;643.5848877474003;675.4866301610812;691.629977961788;4376.124775045004;4750.857474275777;4755.310479980383;4786.7845946932475;4794.664373493822;128155;128767;151459.24270378798;152888;154740;106437.46781266044;106577.46711266394;108390.45804770925;113653;113654.43172784083;94141;102652.97347026583;104038.479807602;104553.47723261335;108013;8259.297959673495;9126.768970577104;9995.70012899614;10023.949880250551;10125.59497620087;54505.72747136239;62093;63266.97572947987;63722;67294;76099;93655;95325;99752;100684.49657751665;12651.620451386472;12808;12853.807192891927;13499;13578.524751633646;12676.429560669976;13934.442622294995;14305;14367.640808979859;15841.762373564636;14004.43982240699;14116.858831411966;14628.195449250394;14745.11529308245;14911;14098.034610445065;14101.153930764187;14217.218053007184;14233.928830355782;14489.710205796036;13456.46174153062;13481.056326057082;13713.520026799015;13862.306884655525;13955.953303502074;11516;11537.653870383901;11709;11846.703832403915;11925.34410607425;11521.769564608494;11657.242279251821;11658.94170529142;11931.880681193077;12071.275723456269 15:57:14 INFO - PROCESS | 1651 | __end_tp_report 15:57:14 INFO - PROCESS | 1651 | __start_cc_report 15:57:14 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1328 15:57:14 INFO - PROCESS | 1651 | __end_cc_report 15:57:14 INFO - PROCESS | 1651 | __startTimestamp1476917834244__endTimestamp 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | ------- Summary: start ------- 15:57:14 INFO - PROCESS | 1651 | Number of tests: 6 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5657.21 Median:5906.73 stddev:666.19 (11.3%) stddev-sans-first:639.67 15:57:14 INFO - PROCESS | 1651 | Values: 3197.1 3270.2 3290.6 3291.7 3336.0 5234.0 5574.0 5603.2 5637.0 5659.8 5006.3 5633.7 5640.6 5645.0 5650.7 5109.1 5132.4 5142.8 5191.9 5265.1 5131.8 5141.9 5146.3 5225.6 5229.1 5143.6 5145.7 5189.6 5199.1 5201.6 5187.0 5192.9 5195.2 5248.8 5262.7 4973.5 5186.8 5189.6 5194.5 5209.3 4854.6 5523.1 5582.8 5584.9 5593.8 6112.4 6137.2 6174.1 6183.3 6184.1 6251.4 6252.3 6303.9 6306.4 6316.2 5570.7 5614.3 5676.1 5728.5 5734.1 6364.8 6384.9 6392.6 6400.1 6404.8 6084.6 6091.8 6095.5 6107.8 6112.5 6074.6 6119.7 6125.4 6135.7 6238.3 6103.4 6113.4 6125.9 6126.3 6130.3 6109.9 6124.2 6185.1 6199.5 6201.3 4936.2 4936.4 4939.9 4944.6 4960.2 4443.2 4445.4 4453.6 4479.6 4521.5 5617.4 5658.3 5666.1 5734.8 5780.2 4787.9 5054.6 6181.7 6182.3 6199.3 5728.0 5777.0 5787.3 5817.7 5825.0 4073.3 4586.3 5319.3 5351.0 5358.2 6218.2 6222.0 6246.0 6261.3 6360.4 6099.7 6187.4 6195.0 6209.0 6214.1 5363.2 6256.8 6296.9 6315.7 6330.0 5995.1 6038.3 6042.9 6075.2 6148.3 6144.9 6209.5 6212.9 6217.3 6218.7 4973.9 5953.9 6063.3 6085.8 6096.7 5880.5 6009.9 6035.8 6037.9 6073.8 5831.8 5906.7 5945.8 6022.3 6043.4 5083.5 6126.1 6137.3 6143.4 6152.3 5933.1 5961.3 5980.6 5995.9 5997.3 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:72836.17 Median:38737.11 stddev:161526.81 (417.0%) stddev-sans-first:161888.53 15:57:14 INFO - PROCESS | 1651 | Values: 461.6 462.6 492.4 503.5 517.8 27846.4 39619.0 40938.8 41013.6 41059.2 42285.4 42768.4 42848.7 42866.4 42867.4 9716.2 9903.9 9905.2 9915.3 9920.3 8662.9 8883.2 11853.9 12098.9 12124.5 12128.9 12242.9 12249.2 12260.9 12303.0 12065.6 12136.0 12139.5 12144.5 12154.3 8235.0 8626.0 8843.2 8855.5 8953.9 36694.0 39362.4 39435.8 41601.0 41680.0 3330.8 3385.1 3580.8 3620.5 3858.1 29381.1 29434.0 30447.4 30726.4 31560.8 2904.5 3125.1 3259.6 3274.3 3291.6 524497.0 534623.0 534886.3 535680.0 536963.0 58024.7 58342.4 58475.8 58479.0 58666.0 60610.1 60710.1 60723.4 60775.0 60878.4 15841.0 16355.8 16386.0 16387.2 16401.4 11565.8 11830.6 12799.9 12887.7 12898.0 13601.9 14934.2 15293.0 15399.7 15728.4 6437.4 6498.6 6506.1 6508.2 6516.1 818.2 920.6 939.1 941.9 943.3 29607.6 29779.7 29822.9 30392.2 30414.0 901.6 1051.4 1090.7 1131.1 1155.9 12129.2 14870.3 15388.6 15472.7 15644.5 652636.0 657160.0 660002.0 660328.0 662642.7 56740.0 56807.7 56832.1 56862.7 57057.4 1232.8 1262.1 1345.1 1360.4 1383.7 30330.9 30414.1 31169.7 31804.7 31851.7 47623.8 53831.2 55556.0 55597.0 59125.7 607148.0 612838.0 614054.0 614482.0 614538.0 25198.9 25229.0 25648.0 25958.2 26198.9 46841.0 46860.0 46970.5 47080.5 47718.5 36924.9 37733.0 39842.6 40874.8 41910.4 38563.8 38942.2 39006.0 40135.4 40523.0 36831.0 37235.8 38674.0 38736.6 38737.6 26283.3 27527.4 34072.1 34913.8 34940.0 22240.0 25449.7 25612.1 25683.6 26042.0 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:33856.63 Median:374.02 stddev:96040.69 (25677.9%) stddev-sans-first:96277.16 15:57:14 INFO - PROCESS | 1651 | Values: 351.3 373.5 374.5 381.6 400.0 14939.8 15181.8 17065.5 21280.4 21525.8 20059.4 20082.0 20544.0 20707.2 20935.7 5652.2 5978.5 5984.9 5985.8 5990.0 3482.9 4315.2 5620.6 5842.0 6373.3 6562.0 6646.0 6654.0 6666.5 6682.6 6408.3 6543.2 6597.1 6597.1 6604.2 5376.9 5572.3 5707.8 5758.3 5773.7 23627.9 23789.5 24827.8 26180.3 26361.7 2201.0 2294.6 2366.4 2558.3 2744.7 8075.0 9307.3 9959.4 10032.1 10197.5 1776.6 1811.2 1817.4 1906.2 1924.3 121700.0 124796.0 124952.0 125319.0 128410.0 11217.4 11451.5 11549.0 11553.4 11843.9 12500.2 13196.9 13229.8 13469.9 14340.4 8512.9 8560.6 8693.3 8785.9 8825.9 7090.8 8647.6 8693.1 8852.1 8882.3 4395.8 4474.4 4477.2 4540.9 4587.3 1566.8 1880.6 1895.6 1907.9 1948.0 881.2 930.6 952.6 983.6 1015.4 17477.4 20521.0 21540.6 21569.7 21662.0 841.6 942.4 942.8 952.6 973.7 10405.2 11470.2 11503.0 11531.3 11543.5 567786.0 571038.0 576567.0 577183.0 581198.0 60913.0 75132.9 132016.0 135654.3 137473.6 953.4 979.4 998.1 1000.5 1002.1 18682.6 19146.8 19214.6 19552.4 19596.2 43036.8 55732.4 56987.7 58613.4 58775.1 60762.0 75141.0 76933.0 83257.2 83731.0 7013.3 7185.1 7392.8 7401.0 7467.8 7265.5 10681.0 12159.4 12919.7 13062.5 9424.2 10451.4 11164.4 11261.5 11663.0 9799.4 10969.3 11197.7 11635.1 11827.5 11410.8 11614.7 11824.1 11846.8 11948.1 7837.5 7971.8 8299.4 8313.8 8354.6 8415.8 9268.4 10951.6 11072.4 11337.4 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5702.38 Median:4958.52 stddev:3234.14 (65.2%) stddev-sans-first:3226.88 15:57:14 INFO - PROCESS | 1651 | Values: 1377.6 1540.9 1584.0 1777.4 1923.3 7898.4 8434.2 8787.4 8883.6 9043.2 8917.0 8993.2 9005.9 9015.5 9017.9 2382.8 2406.8 2408.4 2413.1 2415.5 2381.0 2403.9 2434.2 2436.0 2438.1 2380.3 2407.0 2407.3 2408.9 2417.5 2358.9 2376.3 2388.7 2391.9 2403.0 2270.4 2342.9 2347.3 2351.6 2353.7 8767.3 8929.2 8971.6 9021.0 9036.9 5286.2 5481.1 5500.8 5509.1 5521.3 3610.0 3651.5 3700.5 3715.6 3742.4 954.9 1094.1 1111.4 1127.1 1136.6 11717.2 11721.4 11755.2 11850.4 11863.3 4456.9 4486.9 4678.3 4683.3 4690.7 9167.4 9175.4 9178.0 9180.1 9181.0 5282.8 5290.2 5296.1 5298.7 5312.4 3893.6 4366.3 4438.4 4560.1 4937.0 3500.7 3826.6 3896.0 3902.0 3906.6 1086.7 1152.7 1185.3 1193.2 1208.2 658.4 785.1 906.2 911.5 917.5 5231.8 5479.3 5751.4 5787.1 5944.6 878.1 899.4 904.4 912.7 967.5 3713.3 3913.1 3960.3 3978.1 4010.9 10631.4 10800.3 10961.9 11119.3 11122.7 10815.8 11058.9 11061.2 11066.4 11085.3 8258.5 8412.5 8453.1 8469.4 8472.1 5601.7 5677.1 5751.5 5854.6 5866.2 10061.2 10098.9 10141.2 10253.9 10291.8 9298.2 9947.7 10271.6 10504.8 10603.6 5916.4 7116.3 7176.7 7199.0 7284.3 8273.7 8307.4 8395.9 8421.5 8466.5 7576.7 7576.8 7602.9 7617.6 7631.0 6282.6 7276.9 7418.8 7494.2 7687.2 7017.7 7053.8 7119.6 7123.4 7135.8 4253.8 4782.7 4977.6 5045.3 5138.6 4292.6 4939.5 5038.4 5053.3 5097.2 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4193.30 Median:4527.96 stddev:1264.89 (27.9%) stddev-sans-first:1234.14 15:57:14 INFO - PROCESS | 1651 | Values: 295.1 296.3 305.6 307.9 311.2 5064.5 5067.0 5229.4 5273.8 5287.0 4356.5 4534.8 4956.2 5033.9 5191.2 4021.7 4030.4 4033.7 4041.2 4058.8 3571.1 3752.3 3932.6 4046.9 4087.9 3203.0 3997.0 4020.5 4060.4 4062.2 2989.7 3677.6 3728.3 3965.8 3987.0 3263.2 3423.0 3448.7 3536.9 3545.4 4519.9 4851.5 5035.7 5050.0 5080.3 3714.8 4455.7 4472.8 4493.4 4499.6 5125.6 5384.3 5442.8 5445.8 5452.4 3734.1 3877.6 3877.9 3896.0 3909.1 4560.5 5039.0 5721.5 5726.7 5792.4 3434.9 3849.9 3851.4 3939.5 3988.0 3521.3 3975.1 4016.5 4032.0 4047.9 4562.4 4572.5 4587.0 4592.8 4620.4 5513.4 5521.7 5525.1 5539.8 5587.1 1260.9 1262.7 1371.7 1373.6 1376.7 804.4 827.9 830.0 842.1 850.1 3714.2 3764.9 3856.9 4269.5 4284.9 3998.1 4269.6 4578.9 4601.4 4655.5 3868.4 4157.4 4291.8 4302.7 4329.6 2297.5 2427.6 2437.6 2445.7 2465.2 4345.5 4627.3 4706.5 4790.3 4809.3 4655.4 4656.9 4663.5 4685.0 4790.8 4298.5 4562.5 4600.5 4620.4 4788.1 4413.3 4439.8 4575.7 4587.9 4593.0 3976.4 4115.3 4521.1 4566.5 4647.6 4237.3 4303.5 4619.5 5040.6 5897.0 3301.3 3392.7 3539.6 3723.9 3733.9 4328.4 4412.7 5429.4 5744.4 5816.8 4907.8 5090.8 5533.6 5542.4 5680.6 5303.3 5472.9 5480.1 5533.1 5571.0 5422.2 5436.1 5445.3 5454.7 5467.8 4930.3 5224.6 5246.7 5538.2 5560.6 4221.7 4596.4 5349.4 5405.9 5568.9 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24540.26 Median:22930.64 stddev:38383.45 (167.4%) stddev-sans-first:38449.39 15:57:14 INFO - PROCESS | 1651 | Values: 701.3 720.6 754.0 773.8 803.0 15092.8 15546.7 15620.6 16350.8 16362.8 14682.7 14760.6 14938.9 14951.0 14969.8 804.6 825.1 830.4 831.0 831.1 559.0 696.7 820.2 839.7 841.5 898.3 901.3 903.8 904.7 906.0 894.4 896.1 897.2 900.3 901.3 520.1 540.6 631.9 644.4 666.7 12031.7 14296.5 14305.1 14347.3 14368.6 13939.9 14267.0 14314.7 14513.6 14524.6 12476.6 12630.2 12688.0 12969.0 13240.5 4451.0 4541.5 4563.7 4599.7 4722.0 120200.0 123434.0 123586.0 123713.4 126934.4 10769.5 10798.9 11049.4 11108.5 11190.4 22696.4 22885.8 22925.3 22936.0 22987.4 7892.0 7900.7 8083.4 8236.2 8269.0 4377.4 4380.7 4461.5 4481.1 4493.2 2769.3 3158.3 3283.4 3283.8 3305.6 629.7 640.6 647.8 656.8 662.5 544.3 577.5 581.5 622.6 642.6 7784.0 8935.0 9492.2 9826.0 10038.2 613.5 622.6 643.6 675.5 691.6 4376.1 4750.9 4755.3 4786.8 4794.7 128155.0 128767.0 151459.2 152888.0 154740.0 106437.5 106577.5 108390.5 113653.0 113654.4 94141.0 102653.0 104038.5 104553.5 108013.0 8259.3 9126.8 9995.7 10023.9 10125.6 54505.7 62093.0 63267.0 63722.0 67294.0 76099.0 93655.0 95325.0 99752.0 100684.5 12651.6 12808.0 12853.8 13499.0 13578.5 12676.4 13934.4 14305.0 14367.6 15841.8 14004.4 14116.9 14628.2 14745.1 14911.0 14098.0 14101.2 14217.2 14233.9 14489.7 13456.5 13481.1 13713.5 13862.3 13956.0 11516.0 11537.7 11709.0 11846.7 11925.3 11521.8 11657.2 11658.9 11931.9 12071.3 15:57:14 INFO - PROCESS | 1651 | -------- Summary: end -------- 15:57:14 INFO - PROCESS | 1651 | 15:57:14 INFO - TEST-INFO | 1651: exit 0 15:57:14 INFO - TEST-OK | dromaeo_css | took 1116920ms 15:57:14 INFO - TEST-START | kraken 15:57:14 INFO - operating with platform_type : mac_ 15:57:14 INFO - Initialising browser for kraken test... 15:57:14 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpUiG5sx/profile http://localhost:49272/getInfo.html) 15:57:17 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:57:17 INFO - PROCESS | 1657 | colorDepth:24 15:57:17 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:57:17 INFO - PROCESS | 1657 | __metrics 15:57:17 INFO - PROCESS | 1657 | 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" 15:57:17 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:17 INFO - TEST-INFO | 1657: exit 0 15:57:17 INFO - Browser initialized. 15:57:17 INFO - Running cycle 1/1 for kraken test... 15:57:17 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpUiG5sx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:29 INFO - PROCESS | 1658 | RSS: Main: 219414528 15:57:29 INFO - PROCESS | 1658 | 15:57:32 INFO - PROCESS | 1658 | 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) 15:57:33 INFO - PROCESS | 1658 | RSS: Main: 269369344 15:57:33 INFO - PROCESS | 1658 | 15:57:36 INFO - PROCESS | 1658 | 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) 15:57:36 INFO - PROCESS | 1658 | RSS: Main: 279879680 15:57:36 INFO - PROCESS | 1658 | 15:57:39 INFO - PROCESS | 1658 | 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) 15:57:40 INFO - PROCESS | 1658 | RSS: Main: 377405440 15:57:40 INFO - PROCESS | 1658 | 15:57:42 INFO - PROCESS | 1658 | 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) 15:57:43 INFO - PROCESS | 1658 | RSS: Main: 279719936 15:57:43 INFO - PROCESS | 1658 | 15:57:45 INFO - PROCESS | 1658 | 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) 15:57:45 INFO - PROCESS | 1658 | RSS: Main: 279687168 15:57:45 INFO - PROCESS | 1658 | 15:57:48 INFO - PROCESS | 1658 | 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) 15:57:49 INFO - PROCESS | 1658 | RSS: Main: 317878272 15:57:49 INFO - PROCESS | 1658 | 15:57:52 INFO - PROCESS | 1658 | 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) 15:57:52 INFO - PROCESS | 1658 | RSS: Main: 319795200 15:57:52 INFO - PROCESS | 1658 | 15:57:55 INFO - PROCESS | 1658 | 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) 15:57:56 INFO - PROCESS | 1658 | RSS: Main: 318394368 15:57:56 INFO - PROCESS | 1658 | 15:57:57 INFO - PROCESS | 1658 | 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) 15:57:58 INFO - PROCESS | 1658 | RSS: Main: 289787904 15:57:58 INFO - PROCESS | 1658 | 15:58:00 INFO - PROCESS | 1658 | 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) 15:58:01 INFO - PROCESS | 1658 | RSS: Main: 294547456 15:58:01 INFO - PROCESS | 1658 | 15:58:03 INFO - PROCESS | 1658 | 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) 15:58:03 INFO - PROCESS | 1658 | RSS: Main: 297525248 15:58:03 INFO - PROCESS | 1658 | 15:58:06 INFO - PROCESS | 1658 | 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) 15:58:07 INFO - PROCESS | 1658 | RSS: Main: 308867072 15:58:07 INFO - PROCESS | 1658 | 15:58:10 INFO - PROCESS | 1658 | 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) 15:58:10 INFO - PROCESS | 1658 | RSS: Main: 308846592 15:58:10 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | 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) 15:58:12 INFO - PROCESS | 1658 | RSS: Main: 352628736 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | __start_tp_report 15:58:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 15:58:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 15:58:12 INFO - PROCESS | 1658 | |i|pagename|runs| 15:58:12 INFO - PROCESS | 1658 | |0;ai-astar;115;112;114;113;111;113;112;114;112;111 15:58:12 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;132;143;172;111;107;108;109;142;132 15:58:12 INFO - PROCESS | 1658 | |2;audio-dft;181;182;185;180;182;182;183;184;186;256 15:58:12 INFO - PROCESS | 1658 | |3;audio-fft;82;61;59;86;62;59;61;59;83;58 15:58:12 INFO - PROCESS | 1658 | |4;audio-oscillator;85;70;92;69;67;69;93;68;68;90 15:58:12 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;85;91;130;129;83;89;89;134;115 15:58:12 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;94;94;93;94;94;97;96;91;149 15:58:12 INFO - PROCESS | 1658 | |7;imaging-desaturate;88;88;86;89;88;91;89;88;88;132 15:58:12 INFO - PROCESS | 1658 | |8;json-parse-financial;58;54;54;54;58;58;57;56;57;57 15:58:12 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;76;68;73;73;73;71;70;70;71 15:58:12 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;81;83;82;83;89;101;82;83;83;83 15:58:12 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;149;149;149;137;137;139;138;140;167;138 15:58:12 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;162;166;167;164;165;166;175;165;165;165 15:58:12 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;66;68;67;66;67;67;67;67;66;67 15:58:12 INFO - PROCESS | 1658 | __end_tp_report 15:58:12 INFO - PROCESS | 1658 | __start_cc_report 15:58:12 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2032 15:58:12 INFO - PROCESS | 1658 | __end_cc_report 15:58:12 INFO - PROCESS | 1658 | __startTimestamp1476917892900__endTimestamp 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | ------- Summary: start ------- 15:58:12 INFO - PROCESS | 1658 | Number of tests: 14 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.13 15:58:12 INFO - PROCESS | 1658 | Values: 115.0 112.0 114.0 113.0 111.0 113.0 112.0 114.0 112.0 111.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:137.00 stddev:21.20 (15.5%) stddev-sans-first:22.02 15:58:12 INFO - PROCESS | 1658 | Values: 142.0 132.0 143.0 172.0 111.0 107.0 108.0 109.0 142.0 132.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:190.10 Median:183.50 stddev:23.23 (12.7%) stddev-sans-first:24.40 15:58:12 INFO - PROCESS | 1658 | Values: 181.0 182.0 185.0 180.0 182.0 182.0 183.0 184.0 186.0 256.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:11.60 (18.9%) stddev-sans-first:10.97 15:58:12 INFO - PROCESS | 1658 | Values: 82.0 61.0 59.0 86.0 62.0 59.0 61.0 59.0 83.0 58.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:11.32 (14.6%) stddev-sans-first:11.64 15:58:12 INFO - PROCESS | 1658 | Values: 85.0 70.0 92.0 69.0 67.0 69.0 93.0 68.0 68.0 90.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:103.30 Median:86.50 stddev:21.07 (24.4%) stddev-sans-first:21.60 15:58:12 INFO - PROCESS | 1658 | Values: 88.0 85.0 91.0 130.0 129.0 83.0 89.0 89.0 134.0 115.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:94.00 stddev:17.47 (18.6%) stddev-sans-first:18.37 15:58:12 INFO - PROCESS | 1658 | Values: 93.0 94.0 94.0 93.0 94.0 94.0 97.0 96.0 91.0 149.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:88.00 stddev:13.86 (15.8%) stddev-sans-first:14.60 15:58:12 INFO - PROCESS | 1658 | Values: 88.0 88.0 86.0 89.0 88.0 91.0 89.0 88.0 88.0 132.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.70 (3.0%) stddev-sans-first:1.69 15:58:12 INFO - PROCESS | 1658 | Values: 58.0 54.0 54.0 54.0 58.0 58.0 57.0 56.0 57.0 57.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:72.00 stddev:3.06 (4.2%) stddev-sans-first:2.35 15:58:12 INFO - PROCESS | 1658 | Values: 65.0 76.0 68.0 73.0 73.0 73.0 71.0 70.0 70.0 71.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:6.02 (7.3%) stddev-sans-first:6.21 15:58:12 INFO - PROCESS | 1658 | Values: 81.0 83.0 82.0 83.0 89.0 101.0 82.0 83.0 83.0 83.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:144.50 stddev:9.51 (6.6%) stddev-sans-first:9.93 15:58:12 INFO - PROCESS | 1658 | Values: 149.0 149.0 149.0 137.0 137.0 139.0 138.0 140.0 167.0 138.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.32 15:58:12 INFO - PROCESS | 1658 | Values: 162.0 166.0 167.0 164.0 165.0 166.0 175.0 165.0 165.0 165.0 15:58:12 INFO - PROCESS | 1658 | 15:58:12 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 15:58:12 INFO - PROCESS | 1658 | Values: 66.0 68.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 15:58:12 INFO - PROCESS | 1658 | -------- Summary: end -------- 15:58:12 INFO - PROCESS | 1658 | 15:58:13 INFO - TEST-INFO | 1658: exit 0 15:58:13 INFO - TEST-OK | kraken | took 58881ms 15:58:13 INFO - SUITE-END | took 1175s 15:58:14 INFO - Completed test suite (00:19:36) 15:58:14 INFO - javascript benchmark 15:58:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.1207917822594, 3270.2151483643925, 3290.572225610672, 3291.687289707477, 3336.0325505603378, 5233.9738301308535, 5573.972130139348, 5603.187537807015, 5637.0, 5659.830205093848, 5006.274090256919, 5633.746481408336, 5640.576956728241, 5644.971775141129, 5650.7174641267875, 5109.0803655342115, 5132.435432102466, 5142.820001299955, 5191.896162076756, 5265.131253343194, 5131.846044618667, 5141.922871156917, 5146.253793199984, 5225.608079394042, 5229.058769421503, 5143.639945203838, 5145.716985565792, 5189.6107791915565, 5199.09015922214, 5201.635885488017, 5186.974065129669, 5192.870178245536, 5195.220716892496, 5248.790048398059, 5262.710550919698, 4973.452920178777, 5186.792528298901, 5189.584833213372, 5194.454582268845, 5209.296744939423, 4854.635902307341, 5523.088690366085, 5582.7766889324375, 5584.944150558524, 5593.804216852391, 6112.430563146515, 6137.232845894263, 6174.135621013062, 6183.258009038944, 6184.134221209034, 6251.437370636619, 6252.343503932113, 6303.8739225215695, 6306.369363063703, 6316.210473690789, 5570.749316280737, 5614.326280846243, 5676.120201368794, 5728.541716662657, 5734.139879018139, 6364.777232796922, 6384.872302553923, 6392.552521323462, 6400.135981642512, 6404.807855764241, 6084.6349219047, 6091.817245482643, 6095.512359011268, 6107.786227482017, 6112.480439162721, 6074.635521868614, 6119.744969117336, 6125.449118208436, 6135.662538560333, 6238.251409830849, 6103.389005355301, 6113.419225173601, 6125.877482450415, 6126.295476020226, 6130.325664176937, 6109.920916985209, 6124.234470691164, 6185.134081228632, 6199.473044791153, 6201.348858369806, 4936.160852655057, 4936.432310284292, 4939.851804445872, 4944.60443164546, 4960.206366981338, 4443.155800397914, 4445.4220951276775, 4453.576910193527, 4479.619232365286, 4521.480029796549, 5617.354004289477, 5658.292713410824, 5666.065099258576, 5734.770609175586, 5780.248567686174, 4787.928181077286, 5054.646174767731, 6181.721822517998, 6182.28903676083, 6199.256089269226, 5727.968965586151, 5777.046787280052, 5787.276590426197, 5817.7382017809305, 5825.0, 4073.327900896319, 4586.334981427741, 5319.28189694394, 5350.9732451337495, 5358.169483730028, 6218.160548325918, 6221.96889015552, 6245.96877015612, 6261.279952805395, 6360.363963603695, 6099.695015249308, 6187.3503282154725, 6194.969025154845, 6209.0, 6214.067889816563, 5363.222332761806, 6256.7810126645345, 6296.937030629635, 6315.652639104894, 6330.01884707871, 5995.100734889801, 6038.335783063947, 6042.90935635957, 6075.210222671025, 6148.262208535004, 6144.924638188389, 6209.472194863487, 6212.875742485216, 6217.285012223652, 6218.689065546795, 4973.900521989468, 5953.851153721018, 6063.302720187235, 6085.817425477243, 6096.725647345791, 5880.470757631833, 6009.909851352146, 6035.78874739382, 6037.939620603738, 6073.848153796191, 5831.79588714393, 5906.734196961061, 5945.762169513171, 6022.337542870193, 6043.425874541911, 5083.517065878736, 6126.1423400724825, 6137.263528376623, 6143.416375444325, 6152.323244443018, 5933.05071188625, 5961.344252132175, 5980.551458640706, 5995.910061348996, 5997.340292567901], "value": 5615.338820826844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.5799622343668, 462.6298960831334, 492.40419092897594, 503.544292415364, 517.7721802406941, 27846.44307113859, 39619.0, 40938.7953060235, 41013.58986410135, 41059.17881642373, 42285.36571951416, 42768.3584746229, 42848.714538563894, 42866.35700464495, 42867.35698964518, 9716.174125199348, 9903.851442228372, 9905.207583393347, 9915.305928585001, 9920.305578609501, 8662.913370866305, 8883.200511953923, 11853.881461185407, 12098.939505302505, 12124.515019399214, 12128.878711212863, 12242.85749993752, 12249.203801752901, 12260.877391226108, 12303.015758739324, 12065.577704780335, 12136.0, 12139.453724582416, 12144.514219431301, 12154.33151176685, 8235.0, 8626.0, 8843.159899809507, 8855.512946787923, 8953.865692014626, 36694.0, 39362.40956385656, 39435.802820985715, 41600.95997600084, 41679.95800104991, 3330.800151990864, 3385.1029477188563, 3580.8210629541095, 3620.5474315710535, 3858.074062225046, 29381.11856644304, 29434.0, 30447.39105217883, 30726.38547229065, 31560.842195789104, 2904.549794781812, 3125.140586338752, 3259.5925509311337, 3274.3287626036845, 3291.6214635317006, 524497.0, 534623.0, 534886.3255683735, 535680.0, 536963.0, 58024.70987645119, 58342.41657583455, 58475.83048339009, 58479.0, 58666.0, 60610.09084863731, 60710.08934865981, 60723.392766072655, 60775.0, 60878.39121608727, 15841.049537027815, 16355.754663680054, 16386.0, 16387.180640967905, 16401.42595009169, 11565.826512602318, 11830.645080647595, 12799.872001279868, 12887.677808054686, 12898.03264755147, 13601.931990339985, 14934.178620175777, 15293.0, 15399.692006159814, 15728.449504267295, 6437.356264373619, 6498.642574658439, 6506.089147519351, 6508.17771024114, 6516.120323756232, 818.2063398503442, 920.5949382271913, 939.0515579264855, 941.9434833909987, 943.3490891284991, 29607.555886661718, 29779.702202978126, 29822.850885745866, 30392.240193994883, 30414.0, 901.6303315640556, 1051.363924825485, 1090.7129587087313, 1131.12337938097, 1155.9017483513828, 12129.211601246066, 14870.330835112445, 15388.61528461775, 15472.69713239474, 15644.530664080095, 652636.0, 657160.0, 660002.0, 660328.0, 662642.686786563, 56740.0, 56807.715961419926, 56832.14751778726, 56862.7156864213, 57057.42942570604, 1232.7657745028416, 1262.110212300326, 1345.1189470896384, 1360.4082224232293, 1383.7163381506969, 30330.876838621967, 30414.087577372713, 31169.68830311668, 31804.681953181098, 31851.68148318487, 47623.80940476516, 53831.19253211284, 55555.999999998385, 55597.0, 59125.70437147787, 607148.0, 612838.0, 614054.0, 614482.0, 614538.0, 25198.874005629856, 25229.0, 25647.97408103655, 25958.22125336243, 26198.86900565485, 46841.0, 46860.0, 46970.53029469662, 47080.52919470761, 47718.5228147728, 36924.89225323244, 37733.0, 39842.60157398505, 40874.79562602168, 41910.37134443047, 38563.807180963915, 38942.221155577296, 39006.0, 40135.39796903107, 40523.0, 36831.0, 37235.81382093072, 38674.0, 38736.61263387443, 38737.6126238734, 26283.342916427242, 27527.363010106244, 34072.14819629529, 34913.82543087268, 34940.0, 22240.0, 25449.745502544738, 25612.103576375484, 25683.614745778454, 26041.95832166768], "value": 19994.579544690358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2798762536799, 373.5013756634893, 374.53931664053215, 381.608850927799, 400.03790882926575, 14939.775903361458, 15181.772273415894, 17065.488035358943, 21280.36158915231, 21525.784742152573, 20059.39821805348, 20081.995900205005, 20543.97280135991, 20707.171713131494, 20935.685964710505, 5652.236948012017, 5978.491828194608, 5984.88030239395, 5985.820425387224, 5990.041593345066, 3482.9477557836653, 4315.223259813232, 5620.57845661575, 5842.036064049426, 6373.26707428647, 6561.967190164042, 6645.966770166143, 6654.0, 6666.466682665399, 6682.632455214961, 6408.295087540367, 6543.1821022372205, 6597.1093902323055, 6597.142371491724, 6604.207495100571, 5376.892462150735, 5572.275604171472, 5707.800226992077, 5758.337791154029, 5773.711314434304, 23627.881860590758, 23789.524209515886, 24827.751722482724, 26180.345491362677, 26361.73638263612, 2201.0, 2294.5640328337563, 2366.420227044368, 2558.2581051495044, 2744.67063952325, 8075.0, 9307.255419566418, 9959.402435853872, 10032.071203043064, 10197.490125493696, 1776.5825031117806, 1811.1759149586906, 1817.391173956726, 1906.20892329683, 1924.2687778644026, 121700.0, 124796.0, 124951.9999999991, 125319.0, 128410.0, 11217.439128043565, 11451.54193832254, 11549.018333441583, 11553.422328883522, 11843.940780296216, 12500.24998500093, 13196.934015330055, 13229.801552976713, 13469.932650336686, 14340.426382944774, 8512.914870851213, 8560.61477233526, 8693.34799889998, 8785.868211976825, 8825.91174088251, 7090.751823686146, 8647.56762161902, 8693.087225841196, 8852.114788521225, 8882.289416846637, 4395.824167033346, 4474.39595654589, 4477.19410506112, 4540.88647783808, 4587.288970209623, 1566.8041494813149, 1880.6238752249606, 1895.6208758248129, 1907.8950657713958, 1947.990260048719, 881.1761003461784, 930.6324002019164, 952.642758965388, 983.6163896080391, 1015.3806178231273, 17477.388291409992, 20521.0, 21540.56918861614, 21569.676454852877, 21662.025208865638, 841.6465084664455, 942.4345392764424, 942.7737343037621, 952.5606897373802, 973.7176218896583, 10405.21960852939, 11470.197086204053, 11503.0, 11531.308121512737, 11543.538258469567, 567786.0, 571038.0, 576567.0, 577183.0, 581198.0, 60913.0, 75132.87300690493, 132015.99999999808, 135654.3217283927, 137473.62526374607, 953.3707752883064, 979.4123525884412, 998.1316254858175, 1000.5047501486811, 1002.0931057393071, 18682.626347473248, 19146.80853191506, 19214.615707686047, 19552.413427597196, 19596.216151353787, 43036.78481607572, 55732.442675572725, 56987.71506142443, 58613.4138658625, 58775.11837322358, 60762.0, 75141.0, 76933.0, 83257.16742832494, 83731.0, 7013.2986701329455, 7185.101862267216, 7392.778216653509, 7401.0, 7467.813304667427, 7265.527740696838, 10681.03870651645, 12159.392030398269, 12919.741605167656, 13062.54281100157, 9424.198943089914, 10451.372917624967, 11164.441777911234, 11261.549538018387, 11663.0, 9799.412035277906, 10969.341839489656, 11197.66407007791, 11635.127365447795, 11827.467763950815, 11410.82883756761, 11614.6515604532, 11824.054075674097, 11846.763064738485, 11948.088305871019, 7837.451378403457, 7971.800704982422, 8299.377546683902, 8313.792155196168, 8354.58227088631, 8415.831683366421, 9268.397554158959, 10951.56193752241, 11072.39101849406, 11337.433128343386], "value": 9436.992654109212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.5798381493642, 1540.8767298616112, 1584.0258241181675, 1777.448990812848, 1923.28838329818, 7898.447108702393, 8434.15658434157, 8787.384883058181, 8883.644654213824, 9043.186113249807, 8916.955415222916, 8993.190612844843, 9005.909940900605, 9015.549222538863, 9017.909820901788, 2382.7736365045293, 2406.831521793475, 2408.4460574067975, 2413.0589070262613, 2415.4806716555936, 2381.023780250098, 2403.9399015024587, 2434.160214725917, 2435.9878200608973, 2438.085717855804, 2380.345405013618, 2407.0131246189067, 2407.3379820549403, 2408.8554686718767, 2417.528581926525, 2358.8820558971984, 2376.3227480168157, 2388.677528533643, 2391.940201494959, 2403.0267741564694, 2270.375646697155, 2342.906283748648, 2347.260612906946, 2351.6354964980455, 2353.705786776653, 8767.254783343424, 8929.241014513775, 8971.641134354619, 9021.0, 9036.8644470333, 5286.233496143038, 5481.068218402881, 5500.7524661390335, 5509.118541033416, 5521.337439507245, 3609.981950090259, 3651.4887915691825, 3700.4634328022285, 3715.64701353371, 3742.438634204864, 954.9283803714749, 1094.1356328500476, 1111.377628528027, 1127.143371038017, 1136.5681041204373, 11717.179797414185, 11721.355325457096, 11755.17713760037, 11850.40747962607, 11863.288202707865, 4456.888577785517, 4486.887827804266, 4678.321643361762, 4683.250679891201, 4690.695104818176, 9167.358284920125, 9175.403598766059, 9177.954110229539, 9180.127887850644, 9180.954095229481, 5282.788688452496, 5290.232916227125, 5296.1261391870685, 5298.70857102863, 5312.362516498045, 3893.610638936084, 4366.279563871989, 4438.400815889878, 4560.110778398181, 4937.0, 3500.7199424046016, 3826.6364695354455, 3896.0454688601476, 3902.0, 3906.628870257321, 1086.733954942499, 1152.7406333575045, 1185.25921299188, 1193.176708071428, 1208.1663652080038, 658.3646780856496, 785.077533897668, 906.2342320738965, 911.5260064766285, 917.4770380882966, 5231.843044708665, 5479.287692599936, 5751.424857514299, 5787.102999035156, 5944.552159747336, 878.1043335797451, 899.4468401932895, 904.3579058868277, 912.7033714042963, 967.4533888353058, 3713.2759111972905, 3913.149840987685, 3960.34654282046, 3978.144698889753, 4010.8997275068355, 10631.362118272928, 10800.297980631234, 10961.890381096087, 11119.27724697892, 11122.721931951766, 10815.78368432627, 11058.944705276583, 11061.225714199929, 11066.39134847575, 11085.27945683528, 8258.463199891989, 8412.537310447984, 8453.070162282143, 8469.40714150016, 8472.068072512018, 5601.747921343468, 5677.120046392815, 5751.482366587027, 5854.5609079320075, 5866.178734977021, 10061.195104391485, 10098.899011009797, 10141.188704903738, 10253.948730256301, 10291.794164116825, 9298.163165315154, 9947.651832185838, 10271.589136434459, 10504.78990420172, 10603.575856965635, 5916.408359164049, 7116.323949224816, 7176.7488137914925, 7198.964005179941, 7284.271572842674, 8273.669053237803, 8307.376946728898, 8395.874061888955, 8421.4947103174, 8466.534340611326, 7576.7348142814735, 7576.8484630308185, 7602.923970760222, 7617.581033043236, 7631.0, 6282.560220784501, 7276.890846637199, 7418.814529636802, 7494.213107623621, 7687.192844751445, 7017.7192912282935, 7053.788386348418, 7119.572825630479, 7123.358897699025, 7135.785926422215, 4253.808578613908, 4782.665213435026, 4977.552020318189, 5045.268436076822, 5138.640295179302, 4292.613664770186, 4939.48135445773, 5038.370203724535, 5053.343065401475, 5097.158968770112], "value": 4563.218922820312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.06611574367116, 296.3406420713912, 305.5996644395841, 307.93995170941673, 311.1660749192164, 5064.493075927421, 5067.047702791829, 5229.385307346327, 5273.762680679369, 5287.0, 4356.477222733269, 4534.795934182961, 4956.231784073465, 5033.874153146173, 5191.221316802482, 4021.7130518234176, 4030.415589739486, 4033.6773058155422, 4041.191761647675, 4058.817353219112, 3571.1072231942017, 3752.3058234226755, 3932.5870783567743, 4046.898827529306, 4087.9386809197886, 3202.9839850800713, 3996.960030399702, 4020.4773379460776, 4060.4315395844606, 4062.2281766464275, 2989.6860829612797, 3677.5841301099267, 3728.2543491301576, 3965.841366345357, 3986.983319253586, 3263.2494526258856, 3422.9657703422895, 3448.74134439918, 3536.8682021753048, 3545.3868489837064, 4519.932201016954, 4851.539103785135, 5035.748212589392, 5050.0, 5080.339555857752, 3714.7771133732062, 4455.732656040648, 4472.84345047925, 4493.438320209973, 4499.605122412063, 5125.642204585895, 5384.300040994684, 5442.836714898559, 5445.754941027623, 5452.4274951129955, 3734.141147536082, 3877.5540812806325, 3877.9335682687206, 3896.0, 3909.1204478992, 4560.521145279731, 5038.992201559703, 5721.485066344049, 5726.680694318849, 5792.362840087587, 3434.862605495802, 3849.8652547160714, 3851.422286657024, 3939.4681717967705, 3988.0, 3521.2710149633726, 3975.0857302820514, 4016.5180178378782, 4031.9798401008393, 4047.8583249586122, 4562.429696287964, 4572.474165470947, 4587.0, 4592.839250626212, 4620.399348084795, 5513.365962914316, 5521.696306703089, 5525.066226820661, 5539.833804985857, 5587.106063029895, 1260.9243445393306, 1262.7158889249845, 1371.6845125621162, 1373.594789537089, 1376.6902446949557, 804.3605333759558, 827.9089300176976, 829.995850020746, 842.0653075086649, 850.0521918061318, 3714.2200137971327, 3764.887053388403, 3856.8650097246464, 4269.5090064642345, 4284.892877678083, 3998.100427403869, 4269.615734583902, 4578.931316030262, 4601.447826260804, 4655.534446555385, 3868.4390763339156, 4157.355609880413, 4291.849785257501, 4302.720323178984, 4329.588689074533, 2297.4951406828554, 2427.587310157242, 2437.59779636358, 2445.7431969643285, 2465.249672732344, 4345.521992580813, 4627.334159702505, 4706.458757242961, 4790.281457781291, 4809.254565542346, 4655.37152484417, 4656.883577910579, 4663.533646635309, 4684.969306752509, 4790.8323208687525, 4298.46269216348, 4562.543745625411, 4600.503617250846, 4620.422447194101, 4788.1381351356395, 4413.271810151289, 4439.778011099496, 4575.679702420799, 4587.885302867455, 4593.0, 3976.383660532622, 4115.263349872302, 4521.12373365063, 4566.538707613532, 4647.604953578849, 4237.2584797659665, 4303.483581970184, 4619.4687610925175, 5040.5967522597375, 5896.970515147397, 3301.290222602152, 3392.69465748074, 3539.6106428293383, 3723.944140837835, 3733.9358282890335, 4328.372386003949, 4412.713173643703, 5429.402765695691, 5744.396838331915, 5816.825495234981, 4907.8221226906, 5090.796368145233, 5533.565231298216, 5542.362628297636, 5680.642533348614, 5303.284056652303, 5472.890542189213, 5480.1231802912935, 5533.059379905345, 5571.0, 5422.186671999074, 5436.0758671026815, 5445.346558413015, 5454.709022210602, 5467.835964921059, 4930.260460930889, 5224.634275600672, 5246.711430871339, 5538.1786567268455, 5560.610757246954, 4221.683373747042, 4596.448426188745, 5349.358077030781, 5405.9459405407015, 5568.939492387681], "value": 3801.090272358591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.2531653788715, 720.5856632436347, 753.9934187859208, 773.7872085176572, 802.9959850200748, 15092.77360839587, 15546.689066218669, 15620.609484762857, 16350.83649163508, 16362.7727920406, 14682.706345873075, 14760.557183284518, 14938.925305373485, 14950.953433259676, 14969.775453368207, 804.6379129391768, 825.1047613339534, 830.3979614779267, 830.9501429914225, 831.085805613826, 558.9664620122805, 696.7247937064857, 820.1634332980357, 839.6851180807197, 841.4698739793921, 898.2679116520048, 901.342020325163, 903.7740564858785, 904.7059705595675, 906.0, 894.4186278918722, 896.1128482801979, 897.2104547997753, 900.3472482450237, 901.3195037746525, 520.1209955175741, 540.645876950598, 631.902055181443, 644.391050457318, 666.6866572710818, 12031.699207519794, 14296.499622513265, 14305.141691498544, 14347.282635868269, 14368.568942931728, 13939.930300348433, 14267.0, 14314.713705725932, 14513.637159071002, 14524.636884077983, 12476.625701228977, 12630.242185468902, 12688.0, 12969.0, 13240.536581219707, 4451.0, 4541.477730061019, 4563.726176429424, 4599.678022538424, 4722.0, 120200.0, 123434.0, 123586.0, 123713.38143309226, 126934.36532817369, 10769.515371808131, 10798.946005269923, 11049.392283424328, 11108.500117494732, 11190.440477976068, 22696.432589185402, 22885.771142288697, 22925.312240632808, 22935.967881445376, 22987.425314367276, 7892.0, 7900.723474678359, 8083.434159608771, 8236.217559331853, 8269.00771907375, 4377.416017858125, 4380.7152535085115, 4461.464624245046, 4481.126180394857, 4493.213687604656, 2769.321516228537, 3158.3209609933974, 3283.3925723741186, 3283.819389933529, 3305.636379998198, 629.7386584567445, 640.57401827784, 647.7862305439194, 656.8325077105308, 662.5362246427424, 544.2598066629381, 577.4831525784399, 581.4708615160268, 622.5673157155733, 642.6240649220258, 7784.026996625422, 8934.955325223333, 9492.240620750461, 9826.0, 10038.196944244442, 613.4601550635413, 622.6233128957007, 643.5848877474003, 675.4866301610812, 691.629977961788, 4376.124775045004, 4750.857474275777, 4755.310479980383, 4786.7845946932475, 4794.664373493822, 128155.0, 128767.0, 151459.24270378798, 152888.0, 154740.0, 106437.46781266044, 106577.46711266394, 108390.45804770925, 113653.0, 113654.43172784083, 94141.0, 102652.97347026583, 104038.479807602, 104553.47723261335, 108013.0, 8259.297959673495, 9126.768970577104, 9995.70012899614, 10023.949880250551, 10125.59497620087, 54505.72747136239, 62093.0, 63266.97572947987, 63722.0, 67294.0, 76099.0, 93655.0, 95325.0, 99752.0, 100684.49657751665, 12651.620451386472, 12808.0, 12853.807192891927, 13499.0, 13578.524751633646, 12676.429560669976, 13934.442622294995, 14305.0, 14367.640808979859, 15841.762373564636, 14004.43982240699, 14116.858831411966, 14628.195449250394, 14745.11529308245, 14911.0, 14098.034610445065, 14101.153930764187, 14217.218053007184, 14233.928830355782, 14489.710205796036, 13456.46174153062, 13481.056326057082, 13713.520026799015, 13862.306884655525, 13955.953303502074, 11516.0, 11537.653870383901, 11709.0, 11846.703832403915, 11925.34410607425, 11521.769564608494, 11657.242279251821, 11658.94170529142, 11931.880681193077, 12071.275723456269], "value": 7833.612163298121, "unit": "score"}], "name": "dromaeo_css", "value": 7239.672215218769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 114.0, 113.0, 111.0, 113.0, 112.0, 114.0, 112.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 143.0, 172.0, 111.0, 107.0, 108.0, 109.0, 142.0, 132.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 185.0, 180.0, 182.0, 182.0, 183.0, 184.0, 186.0, 256.0], "value": 190.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 86.0, 62.0, 59.0, 61.0, 59.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 92.0, 69.0, 67.0, 69.0, 93.0, 68.0, 68.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 91.0, 130.0, 129.0, 83.0, 89.0, 89.0, 134.0, 115.0], "value": 103.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 97.0, 96.0, 91.0, 149.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 89.0, 88.0, 91.0, 89.0, 88.0, 88.0, 132.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 58.0, 58.0, 57.0, 56.0, 57.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 68.0, 73.0, 73.0, 73.0, 71.0, 70.0, 70.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 83.0, 89.0, 101.0, 82.0, 83.0, 83.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 137.0, 137.0, 139.0, 138.0, 140.0, 167.0, 138.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 167.0, 164.0, 165.0, 166.0, 175.0, 165.0, 165.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1461.6, "alertThreshold": 2.0}]} 15:58:14 INFO - Return code: 0 15:58:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:58:14 INFO - # TBPL SUCCESS # 15:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:58:14 INFO - 2016-10-19 15:58:14.223 screenresolution[1662:9830] starting screenresolution argv=screenresolution get 15:58:14 INFO - 2016-10-19 15:58:14.226 screenresolution[1662:9830] Display 0: 1600x1200x32@60 15:58:14 INFO - 2016-10-19 15:58:14.232 screenresolution[1663:9833] starting screenresolution argv=screenresolution list 15:58:14 INFO - Available Modes on Display 0 15:58:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:58:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:58:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:58:14 INFO - Intel Iris: 15:58:14 INFO - Chipset Model: Intel Iris 15:58:14 INFO - Type: GPU 15:58:14 INFO - Bus: Built-In 15:58:14 INFO - VRAM (Dynamic, Max): 1536 MB 15:58:14 INFO - Vendor: Intel (0x8086) 15:58:14 INFO - Device ID: 0x0a2e 15:58:14 INFO - Revision ID: 0x0009 15:58:14 INFO - Displays: 15:58:14 INFO - Display: 15:58:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:58:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:58:14 INFO - Display Serial Number: 1600x1200 60 15:58:14 INFO - Main Display: Yes 15:58:14 INFO - Mirror: Off 15:58:14 INFO - Online: Yes 15:58:14 INFO - Rotation: Supported 15:58:14 INFO - Return code: 0 15:58:14 INFO - Running post-action listener: _resource_record_post_action 15:58:14 INFO - [mozharness: 2016-10-19 22:58:14.464939Z] Finished run-tests step (success) 15:58:14 INFO - Running post-run listener: _resource_record_post_run 15:58:14 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38020096; Write bytes: 660075008; Read time: 376; Write time: 2033 15:58:14 INFO - TinderboxPrint: CPU usage
53.5% 15:58:14 INFO - TinderboxPrint: I/O read bytes / time
38,020,096 / 376 15:58:14 INFO - TinderboxPrint: I/O write bytes / time
660,075,008 / 2,033 15:58:14 INFO - TinderboxPrint: CPU idle
2,246.4 (46.5%) 15:58:14 INFO - TinderboxPrint: CPU system
969.9 (20.1%) 15:58:14 INFO - TinderboxPrint: CPU user
1,617.4 (33.5%) 15:58:14 INFO - TinderboxPrint: Swap in / out
401,395,712 / 0 15:58:14 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 368146944; Write bytes: 358716928; Read time: 27844; Write time: 712 15:58:14 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 29105152; Write bytes: 290950144; Read time: 281; Write time: 1285 15:58:14 INFO - Running post-run listener: _upload_blobber_files 15:58:14 INFO - Blob upload gear active. 15:58:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:58:14 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 15:58:14 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'] 15:58:14 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 15:58:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:16 INFO - (blobuploader) - INFO - Done attempting. 15:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:17 INFO - (blobuploader) - INFO - Done attempting. 15:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:58:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:19 INFO - (blobuploader) - INFO - Done attempting. 15:58:19 INFO - (blobuploader) - INFO - Iteration through files over. 15:58:19 INFO - Return code: 0 15:58:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:58:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:58:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8db5f4e626a0a5ceb0ff21df85310d883a149cfa09cbfefb7e070c36688d2d08027bf3edb5b26524cd3a04c0bafc644597e1a683019393d97e29ce335e7551ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aac4d3440034ecaed827107640ec5784fb3bf194e39c1b08af1e13ab260190cb0e39574b58f95506c4dbd56c71e35201ef91a698d0517b86e85c843d5c7b863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf668255643a2cd970b022ebfd14b1ebbfba77645d8e7c53fb31ea9221bb76b8e83cd9d8bb76de39fd10b32ad429313aeafaf77cd37d39de839cb277a669f17"} 15:58:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:58:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:58:19 INFO - Contents: 15:58:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8db5f4e626a0a5ceb0ff21df85310d883a149cfa09cbfefb7e070c36688d2d08027bf3edb5b26524cd3a04c0bafc644597e1a683019393d97e29ce335e7551ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aac4d3440034ecaed827107640ec5784fb3bf194e39c1b08af1e13ab260190cb0e39574b58f95506c4dbd56c71e35201ef91a698d0517b86e85c843d5c7b863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf668255643a2cd970b022ebfd14b1ebbfba77645d8e7c53fb31ea9221bb76b8e83cd9d8bb76de39fd10b32ad429313aeafaf77cd37d39de839cb277a669f17"} 15:58:19 INFO - Running post-run listener: copy_logs_to_upload_dir 15:58:19 INFO - Copying logs to upload dir... 15:58:19 INFO - mkdir: /builds/slave/test/build/upload/logs 15:58:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.434988 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-19 15:58:19.753738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:19.758671) ========= 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.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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/8db5f4e626a0a5ceb0ff21df85310d883a149cfa09cbfefb7e070c36688d2d08027bf3edb5b26524cd3a04c0bafc644597e1a683019393d97e29ce335e7551ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aac4d3440034ecaed827107640ec5784fb3bf194e39c1b08af1e13ab260190cb0e39574b58f95506c4dbd56c71e35201ef91a698d0517b86e85c843d5c7b863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf668255643a2cd970b022ebfd14b1ebbfba77645d8e7c53fb31ea9221bb76b8e83cd9d8bb76de39fd10b32ad429313aeafaf77cd37d39de839cb277a669f17"} build_url:https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011027 build_url: 'https://queue.taskcluster.net/v1/task/LAk8x99mRgKTVZUq7Ue1HA/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/8db5f4e626a0a5ceb0ff21df85310d883a149cfa09cbfefb7e070c36688d2d08027bf3edb5b26524cd3a04c0bafc644597e1a683019393d97e29ce335e7551ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aac4d3440034ecaed827107640ec5784fb3bf194e39c1b08af1e13ab260190cb0e39574b58f95506c4dbd56c71e35201ef91a698d0517b86e85c843d5c7b863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf668255643a2cd970b022ebfd14b1ebbfba77645d8e7c53fb31ea9221bb76b8e83cd9d8bb76de39fd10b32ad429313aeafaf77cd37d39de839cb277a669f17"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:19.803545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:19.803871) ========= 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.Jl1dLACst9/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.WwBl8sh89L/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.005267 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:19.854910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:58:19.855245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:58:19.855563) ========= ========= Total master_lag: 0.22 =========