builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1477307825.62 results: success (0) buildid: 20161024021422 builduid: 31df18ef723e4d4c9c4f5879544a06ca revision: 4e2043b472d20feba39a349b220742f463983a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:05.616865) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:05.617307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:05.617586) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:05.753848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:05.754097) ========= 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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-24 04:17:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-10-24 04:17:06 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.467653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:06.243578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:06.243859) ========= 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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.019775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:06.291950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 04:17:06.292292) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4e2043b472d20feba39a349b220742f463983a67 --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 4e2043b472d20feba39a349b220742f463983a67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-24 04:17:06,412 truncating revision to first 12 chars 2016-10-24 04:17:06,412 Setting DEBUG logging. 2016-10-24 04:17:06,412 attempt 1/10 2016-10-24 04:17:06,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4e2043b472d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 04:17:07,174 unpacking tar archive at: mozilla-aurora-4e2043b472d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 04:17:07.365289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:07.365587) ========= script_repo_revision: 4e2043b472d20feba39a349b220742f463983a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:07.365948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:07.366208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 04:17:07.384280) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-24 04:17:07.384627) ========= /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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:07 INFO - MultiFileLogger online at 20161024 04:17:07 in /builds/slave/test 04:17:07 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 04:17:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:07 INFO - {'append_to_log': False, 04:17:07 INFO - 'base_work_dir': '/builds/slave/test', 04:17:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:17:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:07 INFO - 'branch': 'Mozilla-Aurora', 04:17:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:07 INFO - 'config_files': ('talos/mac_config.py',), 04:17:07 INFO - 'default_actions': ('clobber', 04:17:07 INFO - 'read-buildbot-config', 04:17:07 INFO - 'download-and-extract', 04:17:07 INFO - 'populate-webroot', 04:17:07 INFO - 'create-virtualenv', 04:17:07 INFO - 'install', 04:17:07 INFO - 'run-tests'), 04:17:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:07 INFO - 'download_minidump_stackwalk': True, 04:17:07 INFO - 'download_symbols': 'ondemand', 04:17:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:07 INFO - 'installer_path': 'installer.exe', 04:17:07 INFO - 'log_level': 'info', 04:17:07 INFO - 'log_name': 'talos', 04:17:07 INFO - 'log_to_console': True, 04:17:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:17:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:17:07 INFO - 'opt_config_files': (), 04:17:07 INFO - 'pip_index': False, 04:17:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:17:07 INFO - 'cmd': ('bash', 04:17:07 INFO - '-c', 04:17:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:17:07 INFO - 'enabled': True, 04:17:07 INFO - 'halt_on_failure': False, 04:17:07 INFO - 'name': 'check_screen_resolution'},), 04:17:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:17:07 INFO - 'cmd': ('bash', 04:17:07 INFO - '-c', 04:17:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:17:07 INFO - 'enabled': True, 04:17:07 INFO - 'halt_on_failure': False, 04:17:07 INFO - 'name': 'check_screen_resolution'},), 04:17:07 INFO - 'run_cmd_checks_enabled': True, 04:17:07 INFO - 'sps_profile': False, 04:17:07 INFO - 'sps_profile_interval': 0, 04:17:07 INFO - 'suite': 'dromaeojs', 04:17:07 INFO - 'system_bits': '32', 04:17:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:07 INFO - 'title': 't-yosemite-r7-0036', 04:17:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:07 INFO - 'use_talos_json': True, 04:17:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:07 INFO - 'work_dir': 'build'} 04:17:07 INFO - [mozharness: 2016-10-24 11:17:07.628542Z] Running clobber step. 04:17:07 INFO - Running pre-action listener: _resource_record_pre_action 04:17:07 INFO - Running main action method: clobber 04:17:07 INFO - rmtree: /builds/slave/test/build 04:17:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:09 INFO - Running post-action listener: _resource_record_post_action 04:17:09 INFO - [mozharness: 2016-10-24 11:17:09.155779Z] Finished clobber step (success) 04:17:09 INFO - [mozharness: 2016-10-24 11:17:09.155901Z] Running read-buildbot-config step. 04:17:09 INFO - Running pre-action listener: _resource_record_pre_action 04:17:09 INFO - Running main action method: read_buildbot_config 04:17:09 INFO - Using buildbot properties: 04:17:09 INFO - { 04:17:09 INFO - "project": "", 04:17:09 INFO - "product": "firefox", 04:17:09 INFO - "script_repo_revision": "production", 04:17:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:17:09 INFO - "repository": "", 04:17:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:17:09 INFO - "buildid": "20161024021422", 04:17:09 INFO - "pgo_build": "False", 04:17:09 INFO - "basedir": "/builds/slave/test", 04:17:09 INFO - "buildnumber": 50, 04:17:09 INFO - "slavename": "t-yosemite-r7-0036", 04:17:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:17:09 INFO - "platform": "yosemite_r7", 04:17:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:17:09 INFO - "branch": "mozilla-aurora", 04:17:09 INFO - "repo_path": "releases/mozilla-aurora", 04:17:09 INFO - "revision": "4e2043b472d20feba39a349b220742f463983a67", 04:17:09 INFO - "stage_platform": "macosx64", 04:17:09 INFO - "builduid": "31df18ef723e4d4c9c4f5879544a06ca", 04:17:09 INFO - "slavebuilddir": "test" 04:17:09 INFO - } 04:17:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 04:17:09 INFO - Running post-action listener: _resource_record_post_action 04:17:09 INFO - [mozharness: 2016-10-24 11:17:09.159392Z] Finished read-buildbot-config step (success) 04:17:09 INFO - [mozharness: 2016-10-24 11:17:09.159529Z] Running download-and-extract step. 04:17:09 INFO - Running pre-action listener: _resource_record_pre_action 04:17:09 INFO - Running main action method: download_and_extract 04:17:09 INFO - mkdir: /builds/slave/test/build/tests 04:17:09 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')]} 04:17:09 INFO - trying https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 04:17:09 INFO - Downloading https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/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 04:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/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 04:17:10 INFO - Downloaded 1199 bytes. 04:17:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 04:17:10 INFO - Using the following test package requirements: 04:17:10 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:17:10 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 04:17:10 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 04:17:10 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'jsshell-mac.zip'], 04:17:10 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 04:17:10 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:17:10 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 04:17:10 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 04:17:10 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 04:17:10 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:17:10 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 04:17:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:17:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:17:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:17:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:17:10 INFO - Expected file size: 16436629 04:17:18 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 04:17:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:17:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:17:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:17:19 INFO - Expected file size: 16436629 04:17:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 04:17:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:17:25 INFO - Fetch https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 04:17:26 INFO - Expected file size: 14414081 04:17:27 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')]} 04:17:27 INFO - trying https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:17:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 04:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/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 04:17:32 INFO - Downloaded 115431161 bytes. 04:17:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:17:32 INFO - mkdir: /builds/slave/test/properties 04:17:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:17:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:17:32 INFO - Contents: 04:17:32 INFO - build_url:https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:17:32 INFO - Running post-action listener: _resource_record_post_action 04:17:32 INFO - Running post-action listener: set_extra_try_arguments 04:17:32 INFO - [mozharness: 2016-10-24 11:17:32.831820Z] Finished download-and-extract step (success) 04:17:32 INFO - [mozharness: 2016-10-24 11:17:32.831969Z] Running populate-webroot step. 04:17:32 INFO - Running pre-action listener: _resource_record_pre_action 04:17:32 INFO - Running main action method: populate_webroot 04:17:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:17:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:17:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:17:32 INFO - '--tppagecycles', 04:17:32 INFO - '7'], 04:17:32 INFO - 'tests': ['tsvgm']}}, 04:17:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:17:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:17:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:17:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:17:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['damp', 'tps']}, 04:17:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'tests': ['damp', 'tps']}, 04:17:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['dromaeo_dom']}, 04:17:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:17:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['basic_compositor_video']}, 04:17:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:17:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['a11yr', 04:17:32 INFO - 'ts_paint', 04:17:32 INFO - 'tpaint', 04:17:32 INFO - 'sessionrestore', 04:17:32 INFO - 'sessionrestore_no_auto_restore', 04:17:32 INFO - 'tabpaint']}, 04:17:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['tsvgx', 04:17:32 INFO - 'tsvgr_opacity', 04:17:32 INFO - 'tart', 04:17:32 INFO - 'tscrollx', 04:17:32 INFO - 'cart']}, 04:17:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:17:32 INFO - 'tsvgr_opacity', 04:17:32 INFO - 'tart', 04:17:32 INFO - 'tscrollx', 04:17:32 INFO - 'cart']}, 04:17:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'talos_options': ['--disable-e10s'], 04:17:32 INFO - 'tests': ['tp5o']}, 04:17:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'tests': ['tp5o']}, 04:17:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'talos_options': ['--disable-e10s', 04:17:32 INFO - '--xperf_path', 04:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:32 INFO - 'tests': ['tp5n']}, 04:17:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:32 INFO - 'talos_options': ['--xperf_path', 04:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:32 INFO - 'tests': ['tp5n']}}, 04:17:32 INFO - 'talos.zip': {'path': '', 04:17:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:17:32 INFO - Running post-action listener: _resource_record_post_action 04:17:32 INFO - [mozharness: 2016-10-24 11:17:32.850777Z] Finished populate-webroot step (success) 04:17:32 INFO - [mozharness: 2016-10-24 11:17:32.850889Z] Running create-virtualenv step. 04:17:32 INFO - Running pre-action listener: _resource_record_pre_action 04:17:32 INFO - Running main action method: create_virtualenv 04:17:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:17:32 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 04:17:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:17:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:17:32 INFO - Using real prefix '/tools/python27' 04:17:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:36 INFO - Installing pip.................done. 04:17:36 INFO - Return code: 0 04:17:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:36 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')]} 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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')]} 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:36 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 04:17:36 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 04:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:36 INFO - 'HOME': '/Users/cltbld', 04:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:36 INFO - 'LOGNAME': 'cltbld', 04:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:36 INFO - 'MOZ_NO_REMOTE': '1', 04:17:36 INFO - 'NO_EM_RESTART': '1', 04:17:36 INFO - 'PAGER': '/bin/cat', 04:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:36 INFO - 'PWD': '/builds/slave/test', 04:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:36 INFO - 'SHELL': '/bin/bash', 04:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:36 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:36 INFO - 'USER': 'cltbld', 04:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:36 INFO - 'XPC_FLAGS': '0x0', 04:17:36 INFO - 'XPC_SERVICE_NAME': '0', 04:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:36 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 04:17:36 INFO - Cleaning up... 04:17:36 INFO - Return code: 0 04:17:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:17:36 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')]} 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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')]} 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:36 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 04:17:36 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 04:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:36 INFO - 'HOME': '/Users/cltbld', 04:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:36 INFO - 'LOGNAME': 'cltbld', 04:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:36 INFO - 'MOZ_NO_REMOTE': '1', 04:17:36 INFO - 'NO_EM_RESTART': '1', 04:17:36 INFO - 'PAGER': '/bin/cat', 04:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:36 INFO - 'PWD': '/builds/slave/test', 04:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:36 INFO - 'SHELL': '/bin/bash', 04:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:36 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:36 INFO - 'USER': 'cltbld', 04:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:36 INFO - 'XPC_FLAGS': '0x0', 04:17:36 INFO - 'XPC_SERVICE_NAME': '0', 04:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:37 INFO - Downloading/unpacking psutil>=3.1.1 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:40 INFO - Installing collected packages: psutil 04:17:40 INFO - Running setup.py install for psutil 04:17:41 INFO - building 'psutil._psutil_osx' extension 04:17: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 04:17: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:17: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:17:41 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 04:17:41 INFO - building 'psutil._psutil_posix' extension 04:17:41 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 04:17:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:17:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:17:41 INFO - ^ 04:17:41 INFO - 1 warning generated. 04:17:41 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 04:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:41 INFO - Successfully installed psutil 04:17:41 INFO - Cleaning up... 04:17:41 INFO - Return code: 0 04:17:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:17:41 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')]} 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:41 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')]} 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:41 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:41 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 04:17:41 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 04:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:41 INFO - 'HOME': '/Users/cltbld', 04:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:41 INFO - 'LOGNAME': 'cltbld', 04:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:41 INFO - 'MOZ_NO_REMOTE': '1', 04:17:41 INFO - 'NO_EM_RESTART': '1', 04:17:41 INFO - 'PAGER': '/bin/cat', 04:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:41 INFO - 'PWD': '/builds/slave/test', 04:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:41 INFO - 'SHELL': '/bin/bash', 04:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:41 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:41 INFO - 'USER': 'cltbld', 04:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:41 INFO - 'XPC_FLAGS': '0x0', 04:17:41 INFO - 'XPC_SERVICE_NAME': '0', 04:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:17:44 INFO - Installing collected packages: mozsystemmonitor 04:17:44 INFO - Running setup.py install for mozsystemmonitor 04:17:44 INFO - Successfully installed mozsystemmonitor 04:17:44 INFO - Cleaning up... 04:17:44 INFO - Return code: 0 04:17:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:17:44 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')]} 04:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:44 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')]} 04:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:44 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:44 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 04:17:44 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 04:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:44 INFO - 'HOME': '/Users/cltbld', 04:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:44 INFO - 'LOGNAME': 'cltbld', 04:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:44 INFO - 'MOZ_NO_REMOTE': '1', 04:17:44 INFO - 'NO_EM_RESTART': '1', 04:17:44 INFO - 'PAGER': '/bin/cat', 04:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:44 INFO - 'PWD': '/builds/slave/test', 04:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:44 INFO - 'SHELL': '/bin/bash', 04:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:44 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:44 INFO - 'USER': 'cltbld', 04:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:44 INFO - 'XPC_FLAGS': '0x0', 04:17:44 INFO - 'XPC_SERVICE_NAME': '0', 04:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:17:47 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 04:17:47 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 04:17:47 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 04:17:47 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 04:17:47 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 04:17:47 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 04:17:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:48 INFO - warning: no files found matching '*.txt' 04:17:48 INFO - no previously-included directories found matching 'build' 04:17:48 INFO - no previously-included directories found matching 'dist' 04:17:48 INFO - no previously-included directories found matching '.git*' 04:17:48 INFO - Installing collected packages: jsonschema, functools32 04:17:48 INFO - Running setup.py install for functools32 04:17:48 INFO - warning: no files found matching '*.txt' 04:17:48 INFO - no previously-included directories found matching 'build' 04:17:48 INFO - no previously-included directories found matching 'dist' 04:17:48 INFO - no previously-included directories found matching '.git*' 04:17:48 INFO - Successfully installed jsonschema functools32 04:17:48 INFO - Cleaning up... 04:17:48 INFO - Return code: 0 04:17:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:48 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:48 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 04:17:48 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 04:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:48 INFO - 'HOME': '/Users/cltbld', 04:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:48 INFO - 'LOGNAME': 'cltbld', 04:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:48 INFO - 'MOZ_NO_REMOTE': '1', 04:17:48 INFO - 'NO_EM_RESTART': '1', 04:17:48 INFO - 'PAGER': '/bin/cat', 04:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:48 INFO - 'PWD': '/builds/slave/test', 04:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:48 INFO - 'SHELL': '/bin/bash', 04:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:48 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:48 INFO - 'USER': 'cltbld', 04:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:48 INFO - 'XPC_FLAGS': '0x0', 04:17:48 INFO - 'XPC_SERVICE_NAME': '0', 04:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:17:48 INFO - Cleaning up... 04:17:48 INFO - Return code: 0 04:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:48 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:48 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 04:17:48 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 04:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:48 INFO - 'HOME': '/Users/cltbld', 04:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:48 INFO - 'LOGNAME': 'cltbld', 04:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:48 INFO - 'MOZ_NO_REMOTE': '1', 04:17:48 INFO - 'NO_EM_RESTART': '1', 04:17:48 INFO - 'PAGER': '/bin/cat', 04:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:48 INFO - 'PWD': '/builds/slave/test', 04:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:48 INFO - 'SHELL': '/bin/bash', 04:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:48 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:48 INFO - 'USER': 'cltbld', 04:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:48 INFO - 'XPC_FLAGS': '0x0', 04:17:48 INFO - 'XPC_SERVICE_NAME': '0', 04:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:51 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 04:17:51 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 04:17:51 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 04:17:51 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 04:17:51 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 04:17:51 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 04:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:52 INFO - Downloading docopt-0.6.1.tar.gz 04:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:52 INFO - Running setup.py install for blobuploader 04:17:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:52 INFO - Running setup.py install for requests 04:17:53 INFO - Running setup.py install for docopt 04:17:53 INFO - Successfully installed blobuploader requests docopt 04:17:53 INFO - Cleaning up... 04:17:53 INFO - Return code: 0 04:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:53 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:53 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 04:17:53 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 04:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:53 INFO - 'HOME': '/Users/cltbld', 04:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:53 INFO - 'LOGNAME': 'cltbld', 04:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:53 INFO - 'MOZ_NO_REMOTE': '1', 04:17:53 INFO - 'NO_EM_RESTART': '1', 04:17:53 INFO - 'PAGER': '/bin/cat', 04:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:53 INFO - 'PWD': '/builds/slave/test', 04:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:53 INFO - 'SHELL': '/bin/bash', 04:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:53 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:53 INFO - 'USER': 'cltbld', 04:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:53 INFO - 'XPC_FLAGS': '0x0', 04:17:53 INFO - 'XPC_SERVICE_NAME': '0', 04:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RExQ0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QNV0OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2q91TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-y0mm7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-e1ZPQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-FznFO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oNcu3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-wptN2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QgK6_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DHxGFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-3Ifh45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-uJpk8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yKa8NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Rv6kJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-9AWhH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-964IVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:55 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-jVc2OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:55 INFO - Running setup.py install for manifestparser 04:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:55 INFO - Running setup.py install for mozcrash 04:17:56 INFO - Running setup.py install for mozdebug 04:17:56 INFO - Running setup.py install for mozdevice 04:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Running setup.py install for mozfile 04:17:56 INFO - Running setup.py install for mozhttpd 04:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Running setup.py install for mozinfo 04:17:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Running setup.py install for mozInstall 04:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:56 INFO - Running setup.py install for mozleak 04:17:57 INFO - Running setup.py install for mozlog 04:17:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Running setup.py install for moznetwork 04:17:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Running setup.py install for mozprocess 04:17:57 INFO - Running setup.py install for mozprofile 04:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Running setup.py install for mozrunner 04:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Running setup.py install for mozscreenshot 04:17:58 INFO - Running setup.py install for moztest 04:17:58 INFO - Running setup.py install for mozversion 04:17:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:58 INFO - Cleaning up... 04:17:58 INFO - Return code: 0 04:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:58 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:17:58 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 04:17:58 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 04:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:58 INFO - 'HOME': '/Users/cltbld', 04:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:58 INFO - 'LOGNAME': 'cltbld', 04:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:58 INFO - 'MOZ_NO_REMOTE': '1', 04:17:58 INFO - 'NO_EM_RESTART': '1', 04:17:58 INFO - 'PAGER': '/bin/cat', 04:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:58 INFO - 'PWD': '/builds/slave/test', 04:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:58 INFO - 'SHELL': '/bin/bash', 04:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:17:58 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:58 INFO - 'USER': 'cltbld', 04:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:58 INFO - 'XPC_FLAGS': '0x0', 04:17:58 INFO - 'XPC_SERVICE_NAME': '0', 04:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-XYbOuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:58 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)) 04:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-AkWAra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:58 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)) 04:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yflGHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:58 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)) 04:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-D8lhRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17: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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yvHawz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IJ3YMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-bkp2bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dNyDjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-OJ6J9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Df25E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JEDHxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yk3JYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:59 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)) 04:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-TANQZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18: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)) 04:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RQOCH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:00 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)) 04:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ZS_KxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:00 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)) 04:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Y34N2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:00 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)) 04:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rfo7FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:00 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)) 04:18:00 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)) 04:18:00 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)) 04:18:00 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)) 04:18:00 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)) 04:18:00 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)) 04:18:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:03 INFO - Downloading blessings-1.6.tar.gz 04:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:03 INFO - Installing collected packages: blessings 04:18:03 INFO - Running setup.py install for blessings 04:18:03 INFO - Successfully installed blessings 04:18:03 INFO - Cleaning up... 04:18:03 INFO - Return code: 0 04:18:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:03 INFO - Reading from file tmpfile_stdout 04:18:03 INFO - Current package versions: 04:18:03 INFO - blessings == 1.6 04:18:03 INFO - blobuploader == 1.2.4 04:18:03 INFO - docopt == 0.6.1 04:18:03 INFO - functools32 == 3.2.3-2 04:18:03 INFO - jsonschema == 2.5.1 04:18:03 INFO - manifestparser == 1.1 04:18:03 INFO - mozInstall == 1.12 04:18:03 INFO - mozcrash == 0.17 04:18:03 INFO - mozdebug == 0.1 04:18:03 INFO - mozdevice == 0.48 04:18:03 INFO - mozfile == 1.2 04:18:03 INFO - mozhttpd == 0.7 04:18:03 INFO - mozinfo == 0.9 04:18:03 INFO - mozleak == 0.1 04:18:03 INFO - mozlog == 3.4 04:18:03 INFO - moznetwork == 0.27 04:18:03 INFO - mozprocess == 0.23 04:18:03 INFO - mozprofile == 0.28 04:18:03 INFO - mozrunner == 6.12 04:18:03 INFO - mozscreenshot == 0.1 04:18:03 INFO - mozsystemmonitor == 0.3 04:18:03 INFO - moztest == 0.7 04:18:03 INFO - mozversion == 1.4 04:18:03 INFO - psutil == 3.1.1 04:18:03 INFO - requests == 1.2.3 04:18:03 INFO - wsgiref == 0.1.2 04:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:03 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')]} 04:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 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')]} 04:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:18:03 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 04:18:03 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 04:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:03 INFO - 'HOME': '/Users/cltbld', 04:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:03 INFO - 'LOGNAME': 'cltbld', 04:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:03 INFO - 'MOZ_NO_REMOTE': '1', 04:18:03 INFO - 'NO_EM_RESTART': '1', 04:18:03 INFO - 'PAGER': '/bin/cat', 04:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:03 INFO - 'PWD': '/builds/slave/test', 04:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:03 INFO - 'SHELL': '/bin/bash', 04:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:18:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:03 INFO - 'USER': 'cltbld', 04:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:03 INFO - 'XPC_FLAGS': '0x0', 04:18:03 INFO - 'XPC_SERVICE_NAME': '0', 04:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 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)) 04:18:03 INFO - Cleaning up... 04:18:03 INFO - Return code: 0 04:18:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18:03 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')]} 04:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 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')]} 04:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 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 0x10e496490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e40c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa268d60d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, '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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:18:03 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 04:18:03 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 04:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:03 INFO - 'HOME': '/Users/cltbld', 04:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:03 INFO - 'LOGNAME': 'cltbld', 04:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:03 INFO - 'MOZ_NO_REMOTE': '1', 04:18:03 INFO - 'NO_EM_RESTART': '1', 04:18:03 INFO - 'PAGER': '/bin/cat', 04:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:03 INFO - 'PWD': '/builds/slave/test', 04:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:03 INFO - 'SHELL': '/bin/bash', 04:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:18:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:03 INFO - 'USER': 'cltbld', 04:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:03 INFO - 'XPC_FLAGS': '0x0', 04:18:03 INFO - 'XPC_SERVICE_NAME': '0', 04:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:18:04 INFO - Cleaning up... 04:18:04 INFO - Return code: 0 04:18:04 INFO - Running post-action listener: _resource_record_post_action 04:18:04 INFO - Running post-action listener: _start_resource_monitoring 04:18:04 INFO - Starting resource monitoring. 04:18:04 INFO - [mozharness: 2016-10-24 11:18:04.260344Z] Finished create-virtualenv step (success) 04:18:04 INFO - [mozharness: 2016-10-24 11:18:04.261297Z] Running install step. 04:18:04 INFO - Running pre-action listener: _resource_record_pre_action 04:18:04 INFO - Running main action method: install 04:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:04 INFO - Reading from file tmpfile_stdout 04:18:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:04 INFO - Reading from file tmpfile_stdout 04:18:04 INFO - Output received: 04:18:04 INFO - Usage: mozinstall [options] installer 04:18:04 INFO - Options: 04:18:04 INFO - -h, --help show this help message and exit 04:18:04 INFO - -d DEST, --destination=DEST 04:18:04 INFO - Directory to install application into. [default: 04:18:04 INFO - "/builds/slave/test"] 04:18:04 INFO - --app=APP Application being installed. [default: firefox] 04:18:04 INFO - mkdir: /builds/slave/test/build/application 04:18:04 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'] 04:18:04 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 04:18:36 INFO - Reading from file tmpfile_stdout 04:18:36 INFO - Output received: 04:18:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:18:36 INFO - Running post-action listener: _resource_record_post_action 04:18:36 INFO - [mozharness: 2016-10-24 11:18:36.764942Z] Finished install step (success) 04:18:36 INFO - [mozharness: 2016-10-24 11:18:36.765107Z] Running run-tests step. 04:18:36 INFO - Running pre-action listener: _resource_record_pre_action 04:18:36 INFO - Running main action method: run_tests 04:18:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:18:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:18:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:18:36 INFO - 2016-10-24 04:18:36.780 screenresolution[1967:17176] starting screenresolution argv=screenresolution get 04:18:36 INFO - 2016-10-24 04:18:36.782 screenresolution[1967:17176] Display 0: 1600x1200x32@60 04:18:36 INFO - 2016-10-24 04:18:36.788 screenresolution[1968:17178] starting screenresolution argv=screenresolution list 04:18:36 INFO - Available Modes on Display 0 04:18:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:18:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:18:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:18:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:18:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:18:37 INFO - Intel Iris: 04:18:37 INFO - Chipset Model: Intel Iris 04:18:37 INFO - Type: GPU 04:18:37 INFO - Bus: Built-In 04:18:37 INFO - VRAM (Dynamic, Max): 1536 MB 04:18:37 INFO - Vendor: Intel (0x8086) 04:18:37 INFO - Device ID: 0x0a2e 04:18:37 INFO - Revision ID: 0x0009 04:18:37 INFO - Displays: 04:18:37 INFO - Display: 04:18:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:18:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:18:37 INFO - Display Serial Number: 1600x1200 60 04:18:37 INFO - Main Display: Yes 04:18:37 INFO - Mirror: Off 04:18:37 INFO - Online: Yes 04:18:37 INFO - Rotation: Supported 04:18:37 INFO - Return code: 0 04:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:37 INFO - Python 2.7.3 04:18:37 INFO - Return code: 0 04:18:37 INFO - grabbing minidump binary from tooltool 04:18: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')]} 04:18: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 0x10e2aad30>, '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 0x10e110db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18: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 04:18: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 04:18: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 04:18:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:37 INFO - Return code: 0 04:18:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:18:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:18:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18: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/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 04:18: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/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 04:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xyvjiU3cqO/Render', 04:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:37 INFO - 'HOME': '/Users/cltbld', 04:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:37 INFO - 'LOGNAME': 'cltbld', 04:18:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:37 INFO - 'MOZ_NO_REMOTE': '1', 04:18:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:37 INFO - 'NO_EM_RESTART': '1', 04:18:37 INFO - 'PAGER': '/bin/cat', 04:18:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:37 INFO - 'PWD': '/builds/slave/test', 04:18:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:37 INFO - 'SHELL': '/bin/bash', 04:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDzvNxf1iE/Listeners', 04:18:37 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:37 INFO - 'USER': 'cltbld', 04:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:37 INFO - 'XPC_FLAGS': '0x0', 04:18:37 INFO - 'XPC_SERVICE_NAME': '0', 04:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18: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/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 04:18:37 INFO - mozversion application_buildid: 20161024021422 04:18:37 INFO - mozversion application_changeset: 4e2043b472d20feba39a349b220742f463983a67 04:18:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:18:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:37 INFO - mozversion application_name: Firefox 04:18:37 INFO - mozversion application_remotingname: firefox-dev 04:18:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:18:37 INFO - mozversion application_vendor: Mozilla 04:18:37 INFO - mozversion application_version: 51.0a2 04:18:37 INFO - mozversion platform_buildid: 20161024021422 04:18:37 INFO - mozversion platform_changeset: 4e2043b472d20feba39a349b220742f463983a67 04:18:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:18:37 INFO - mozversion platform_version: 51.0a2 04:18:37 INFO - using testdate: 1477307917 04:18:37 INFO - actual date: 1477307917 04:18:37 INFO - starting webserver on 'localhost:51591' 04:18:37 INFO - SUITE-START | Running 2 tests 04:18:37 INFO - TEST-START | dromaeo_css 04:18:37 INFO - operating with platform_type : mac_ 04:18:37 INFO - Initialising browser for dromaeo_css test... 04:18:37 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpNRk0qF/profile http://localhost:51591/getInfo.html) 04:18:39 INFO - PROCESS | 1978 | __metrics Screen width/height:1600/1200 04:18:39 INFO - PROCESS | 1978 | colorDepth:24 04:18:39 INFO - PROCESS | 1978 | Browser inner width/height: 1024/689 04:18:39 INFO - PROCESS | 1978 | __metrics 04:18:39 INFO - PROCESS | 1978 | 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" 04:18:39 INFO - PROCESS | 1978 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:40 INFO - TEST-INFO | 1978: exit 0 04:18:40 INFO - Browser initialized. 04:18:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:18:40 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpNRk0qF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:52 INFO - PROCESS | 1980 | RSS: Main: 219459584 04:18:52 INFO - PROCESS | 1980 | 04:19:44 INFO - PROCESS | 1980 | 1477307984434 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] 04:21:55 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51591/tests/dromaeo/cssquery-ext.html) 04:21:56 INFO - PROCESS | 1980 | RSS: Main: 344494080 04:21:56 INFO - PROCESS | 1980 | 04:25:00 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-ext.html (next: http://localhost:51591/tests/dromaeo/cssquery-jquery.html) 04:25:00 INFO - PROCESS | 1980 | RSS: Main: 351666176 04:25:00 INFO - PROCESS | 1980 | 04:28:02 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51591/tests/dromaeo/cssquery-mootools.html) 04:28:03 INFO - PROCESS | 1980 | RSS: Main: 323592192 04:28:03 INFO - PROCESS | 1980 | 04:31:05 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51591/tests/dromaeo/cssquery-prototype.html) 04:31:06 INFO - PROCESS | 1980 | RSS: Main: 321810432 04:31:06 INFO - PROCESS | 1980 | 04:34:09 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51591/tests/dromaeo/cssquery-yui.html) 04:34:10 INFO - PROCESS | 1980 | RSS: Main: 315482112 04:34:10 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51591/tests/dromaeo/cssquery-yui.html (next: http://localhost:51591/tests/dromaeo/cssquery-dojo.html) 04:37:13 INFO - PROCESS | 1980 | RSS: Main: 358674432 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | __start_tp_report 04:37:13 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 04:37:13 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 04:37:13 INFO - PROCESS | 1980 | |i|pagename|runs| 04:37:13 INFO - PROCESS | 1980 | |0;dojo.html;3256.2836176041274;3284.6551112133225;3305.933881322372;3319.468884978404;3355.110895612663;5514.944850551493;5576.079946808782;5583.497485226324;5596.776128954837;5613.635113717605;5543.334799824027;5608.46719561641;5617.747201375938;5620.213170156181;5665.3201615806165;5023.196288593826;5095.949040509585;5116.334876466073;5170.327857378536;5202.06362854686;5070.847874563769;5097.541221290083;5106.795728170869;5200.115980283342;5225.947740522584;5130;5167.224916262572;5167.612429067816;5174.741262936857;5182.37811462625;4453.732776033448;5117.744112794346;5157.638965272433;5159.535641792238;5220;4936.580390666798;5149.562287205592;5151.922721159186;5152.201408781645;5167.741612919339;5520.282363292787;5540.141278101901;5545.805896793633;5546.889062218774;5607.775688972436;6092.482139018189;6109.847253818646;6139.693015349259;6150.600210986317;6186.133941248228;6152.692365381713;6195;6203.038529028008;6230.657313847737;6238.656873871935;5555.638883472602;5611.466910643482;5633.464820842013;5660;5715.485606295411;6143.266246520345;6177.536684748662;6190.659513726789;6196.845078872974;6211.627302361872;6030.125631783367;6059.48494377974;6068.362821903636;6072.726727297282;6097.634141951408;6018.398160184034;6048.879022419527;6127.050307202391;6170.907436388457;6176.135341052256;6105.877882442326;6112.327643959161;6114.633122012693;6128.264608247039;6128.4790792783115;6041.214642096499;6077.24034495688;6110.816675499742;6130.478909292671;6141.355157708465;4822.855314340575;4829.710217386968;4833.661643684979;4849.660523763303;4849.878753031202;4329.631981281564;4332.588404101605;4337.110892267141;4346.978265108717;4359.585839345257;5560.77756889728;5611.971940140274;5626.549876009909;5636.436356364331;5693.715314234271;6119.654885717031;6177.444030037318;6186.845328866814;6186.969065154645;6191.659458729723;5688.089905615082;5725.942740572625;5728.942710572841;5729.169270455844;5754.5971781975695;5155.690658560498;5231.921521177185;5269.4730526947;5284.630075894727;5287.920681189786;6150.138980542728;6160.7535698571555;6178.752849885954;6208.068789681403;6273.466755325849;6211.627302361872;6211.9068213975925;6219.346968568416;6234.625922444668;6243.781467648792;6206.06908963659;6250.1874756281395;6254.562180647311;6264.31092579825;6275.497960163085;5892.793752218823;5973.731182096729;6009.519238460825;6011.218541589566;6011.308699499614;5541.667499950016;6040.546958978182;6117.766507567632;6171.876562468815;6197.690115494297;5818.650880946987;6031.60794548353;6044;6049.637021778707;6058.333583305921;4446.73319600825;5737.282839645044;5797.623154494944;5957.702114894151;5963.016102343065;4797.520247975314;5712.171735098304;5740.655560666206;5773.16289138081;5826.621269617462;5961.2846458425265;5966.075258334965;5989.490893273946;5997.70011499432;6000.8499787503915;5752.07966725322;5752.712364381848;5773.595848290579;5800.622959507618;5807.622504537191 04:37:13 INFO - PROCESS | 1980 | |1;ext.html;423.28887469052;453.6982906367266;519.729740534922;527.8733104055026;542.6554138122291;30245.24386890326;40018.599814001886;40883.386749198784;41058.178836423256;41086.38370424446;41180.17639647205;41813;42135.94660133498;42286.15427691444;42368;9690.612375504972;9913.008699130101;9913.801723965516;9916.057974492413;9917.008299170098;8786.121387861227;8995.505247211433;9003.549822508881;9099.22656574192;9099.63601455941;10333.948330258338;11974.221675591103;12185.207961482476;12241;12448.93775531121;9454.243660507143;12196.512139514409;12320.445579948924;12334.136610437274;12409.62771116868;8735.912640873574;8961.820763584758;11871.52513899443;11936.104792140537;11940.283582985048;32287.677123228703;32556.02331930046;32590.837045814857;39102.41346379807;39568.20863582712;3304.438245498271;3381.6980462522106;3465.705415039725;3603.747737658365;3727.2918145552258;29456.969006084684;30551;30736.770529178804;31551;31814;3209.117492689529;3270.887898114652;3273.0508152635707;3366.9831650841834;3371.022403502981;500158;505109;506918.99999999633;507090;508854;49092.75453622709;50027.499725002286;57035;57299;57419.13871291934;58992.7050364754;60172.39827601668;60179.699101504215;63482.36517634857;63634;16234;16441;16455.917720411322;16462;16515.752263716055;12846.48614055446;12937.09440339186;12955.287459189834;12978.610641680765;13013.544525941546;13481.662958426117;13719.725605488034;13757.79363309551;15133.243337833064;15267.847321526864;5823.737931793079;6146.692665366714;6255.404007336904;6286.527241452852;6362.554621176566;826.3843436639622;930.5486838883136;938.1041105743998;993.3592832622918;1041.6354276003337;28462.573061404095;29042.709572904423;29199.708002920124;29910.850445747634;30162.84918575393;865.7575878753959;929.307665788978;1020.9183265338755;1059.9152067834555;1105.9391733454738;14724.705505889822;14758.48345307909;15285.770713439308;15442.305096270695;15499.225038748018;665312;670087;670768;671766;673047;49135.50864491381;50114.24828627573;55935;57096.42903570911;57596.71201643965;1154.417019405195;1303.1008604063165;1336.5923393364922;1359.8028285898688;1362.8637136286688;28560.000799943806;29651.110466686034;30666.386672266875;31459;32378.352432950738;47640;48089.27866082082;48136.75931620319;48235.5176448231;48316;534923;538717;539451;541041;541408;37739.81130094442;38206.42690359702;38552.036199094124;38641.42037869378;38888.611113888495;38597.6140238594;40927.795361023;44695.10609787851;45565.772171140256;46904.53095469002;38021.619783801805;38206.426903595915;38719.03202419962;38806.41790373203;38933.80533097316;33687.326253474304;38016.619833801306;38286.6171338283;38489.615103848606;38583.80708096441;36236.91289261326;36834.44748328724;37331.81334093312;37527.06182345354;37836;30123.548146778256;31807.84096079505;31915.042548723577;32924.01227963165;34056;25012;25145.119920802685;25184.11855585046;25347;25827.870860645577 04:37:13 INFO - PROCESS | 1980 | |2;jquery.html;353.7240952057396;368.13121034358915;373.8224343436868;380.3154322220005;400.2854903996367;15519.767203491943;15827.44603938861;17323.480295591122;21288.4677883053;21449.171052565816;20328.390148295537;20373.592528149427;20693.896530517362;20818.687719684218;20977.58044839106;5762.222100016496;5791.189233507313;5885.941140588582;6025.879482410371;6032.728527216286;5756.769729210827;5774.7401366938375;5779.653220806744;5923.17075609415;5926.051831706928;4134.317837556815;4370.038591509879;5881.411858814127;6308.3060863305;6537.869242615145;6407.647579383132;6596.076549283104;6656.70044847983;6656.934890417534;6669.399754022113;5786.363500015037;5789.218455508537;5795.420457954213;5796.3913789052385;5807.30312362515;25652.48695026089;26476;26602.866985665143;26666.600001;26831.06091286815;2316.8030717389042;2414.4929564791414;2449.35092200567;2488.701355837293;3040.890075122564;15042.097474151586;15591;15829.15075286448;16543.2555535;16544.83455165445;1840.3098837935775;1848.7319338695813;1886.7075603281514;1888.8394486468667;1889.763779527559;125456.37271813674;126239;128488;129073.41853162978;131405.34297328547;9265.814683706289;10672.78654426907;11130.554777808797;11236.157288203418;11394.37330946806;13938.93030534841;13957.511487097903;13959.511417100353;13966.882649388024;13977.65055873591;8725.65097396097;8824.647014119491;8834.77913052166;8884.111588841193;8965.282777377794;9019;9038.774030649287;9045.592948317342;9192.080791920887;9208.217301529312;6172.642018755867;6289.308176100625;6570.342965703487;6754.662266886636;6755.2231493378895;1579.439299048844;1775.7070083436347;1777.2713187593024;1810.7374430707737;1814.319630138698;912.6714382822179;933.7665583604099;939.8637197606308;995.0745806400117;1027.3733022856052;20950.58098838015;22704;22830.42923926915;22855.885720571292;22861;943.495230051919;950.3252690589759;960.1166926427703;980.3578655980344;1021.6934919524113;9594.904050959542;10026.64906728261;11645.41772911368;11668.824967625493;11925.344106074075;599355;602390;614221.9288903527;626865;628922;74241;76883;102636;125396.74603254034;131838.02242966363;952.3809523809579;979.3927764785878;994.2848586188911;994.5876854866108;997.2620261006803;19460.31888883882;20004.599908001466;20048.897310648055;20052.298169563994;20117;46441;53583;57666.7116664414;58750;60736.481587960654;71566.64216679092;72155;81297;81542;83076.01896489726;7217.819554511179;7368.742094026683;7408.851822963618;8192.54940978252;8254.174582541698;9140.994490605895;12244.938775306067;12339.814902776645;12414.068944829354;12717.682057948625;11280;11432.82850757256;11528.59649912249;11539.519003414307;11676.416179191176;8712.651493940424;10559.366438013743;11307.208495405243;11390.886091139315;11639.709007274885;11525.884741152817;11537.769244614892;11596.710082248012;12095.879041209475;12177.086718495972;7464.440166987389;7596.696132154652;7607.315341619281;7654.693812247448;7807.141214466517;9692.806143877224;11282.887171128184;11669.35818529955;11734.765304693688;11874.109441792072 04:37:13 INFO - PROCESS | 1980 | |3;mootools.html;1366.8769810717033;1516.1585320147321;1540.5686407805813;1743.3288184049138;1900.7243949627295;7904.960475197623;8425.368097392697;8810;9048;9055.547222638874;8946.91053089469;8959.820803583942;9045;9059.456432614032;9071.818563628723;2400.9759902401015;2433.6592876997147;2435.7807797298237;2437.1591800828687;2437.9882348825304;2381.6070348392495;2408.060856266049;2421.1767998880377;2422.794062504689;2427.1383658801137;2257.446925503254;2394.568977584034;2415.2995631267;2422.588160012802;2423.6364545318165;2012.2051789543195;2184.6722991551237;2369.988150059256;2395.8562486250707;2401.171595799455;2337.2403968710237;2367.0176876596192;2368.7157541095007;2374.1453076892303;2377.227401094634;8893.15515026078;9129.634814607407;9130.360874738772;9142.908570914338;9195.816083678288;5351.57187425005;5547.029269877796;5555.805546805843;5593.105103183511;5596.804111856106;3630.7458477906557;3631.3840341048244;3704.9996500944594;3713.721470889694;3766.5856755756845;1090.1278976818514;1094.3762055628295;1097.4951522299752;1105.38098664748;1120.78705046041;12028.51885924562;12090.214136081215;12104.576339828063;12161;12178.51285948561;4497.617702495259;4573.405457290597;4753.191957367256;4754.548317909793;4758.881027974328;8088.11030786613;9269.073092690676;9274.30442716799;9286.90713092874;9316.767080823034;4598.701084429501;5347.81282655113;5349.732513374316;5354.223637572531;5355.491228333302;4390.401591445978;4460.30865215892;4644.8374306899095;4871.2206047032305;5039.84880453587;3539.823008849547;3572.6605972432576;3781.640744129303;3888.8055597220027;3914.530256369254;1019.23557332001;1154.8440960470398;1181.3207405741732;1194.9522019119138;1196.443653701033;859.7807559072521;869.6477926439802;902.1069141549818;912.3339961827903;917.9082091790767;4757.3577567028005;5686.431356864363;5741.224934633855;5776.104703770922;5819.563532735062;433.7378229352569;442.35637147949654;448.9416375871116;460.4612603254134;463.79129391773836;3862.5558060823364;3867.16855875988;3890.533136023695;3981.402789581586;3998.900027499336;8329.625166867505;10793.784124317626;11045.723856903642;11222.158338124673;11225.045871101049;11154.553817847358;11163.776724465466;11199.104071674246;11203.663890083311;11229;8255.504669719836;8387.245147936716;8430.325573954191;8471.152884711602;8496.490210587384;5613.410591887793;5711.571632127524;5747.166660834239;5829.358770535153;5850.736716847837;10149.64476243328;10249.180065594586;10398.58405663765;10433.956604339506;10479.266451348332;9958.50207489637;10351.378917264989;10369.222308326755;10384.065434110966;10546.630867919586;6979.022936788752;7188.568685878864;7441.144268409203;7590.582517961565;7617.733379331697;7957.045154581488;8171.428000040178;8308.003039635283;8452.535110568977;8547.829043418973;7455.478116531791;7596.886046709415;7604.733834315773;7613.5431874087735;7720.498167619311;7404.259574042768;7419.961205431352;7468.887966680612;7479.775606731807;7501.962490187514;6940.201876784033;7077.504574679929;7088.787336379917;7098;7098.041764361745;4904.329362972913;4973.254011898244;5010.198368261061;5013.498650134958;5065.949340506548;4919.655624106422;4962.305277261258;4992;5100.26046223303;5202.03762303975 04:37:13 INFO - PROCESS | 1980 | |4;prototype.html;301.60489758416475;307.9184016235698;311.3694768094609;314.35400252481173;319.2529481014426;3943.9211215775704;5072.72100034498;5176.352955880515;5181.974090129549;5195.220716892468;5006.72463014535;5085.4151772546165;5091.287219789232;5092.210707340369;5124.6668966517245;3672.8530858765616;3696.20531585709;3861;3905.5508616509037;3946.52641682997;3875.593062728415;3896.5129358830145;3929.2337994091163;3935.783531905744;3958.7030972677167;3848.8460461581503;3866.6520013198806;3889.727719059667;3916.4321173429835;3938.921221575567;3221.7100460958627;3512.8770493032875;3596.9280614387826;3884.242572698325;3915.7650540967634;2953.3207362306575;3081.6764239754953;3353.564036675217;3356.1777364545596;3381.442062059757;4918.827841025547;4926.187179115442;4934.728589927553;4958.305837182797;4962.305277261186;3671.761335513183;3880.573136954961;4281.657467402601;4368.191884501377;4401.691881568291;4840.322354870321;5068.69587824728;5235.136202526579;5278.683279003234;5306.151015837486;3026.44010857992;3302.702756751904;3739.8504059837574;3749.4000959846294;3782.5082739244;4708.741019243906;5182.611304152204;5582.190582365534;5602.131669591179;5655.971720141414;3433.776804507699;3648.1973965727498;3716.201016781405;3799.696024318048;3809.5047643806683;3611.981940090283;3654.666046892865;3844.38489841624;3853.6512220722525;3859.7877116758846;3678.9264214715554;3728.496652951871;4405.361222622766;4405.537418571068;4476.6418686505;3955.980220098939;4474.172278128557;5282.894342113136;5383.973080134652;5399.622026458189;1304.230504002643;1323.1597935310954;1327.9004074694437;1329.4017692038622;1330.4545136494185;784.4626430894855;814.4054839966857;822.6544851162527;824.3611201319026;825.9587020649063;4181.393697913785;4201.962048406521;4779;4966.690488922596;5028.823991160365;4425.389020477869;4689.366935463669;5246.449122842123;5456.399796022434;5488.1493368527945;5073.949260507421;5086.4659210783075;5090.949090509048;5091.159958606789;5158.380994280636;2673.585594232897;2831.7876159288135;2833.206702123409;2850.232855629523;2887.9422411552073;4734.976325118352;5643.463870932255;5667.064934285797;5677.744501497443;5691.971540142273;4843.007183527368;5277.8416647500635;5335.279737235501;5573.331200255914;5680.711063147297;5258.92111618326;5456.099743542351;5696.487316141484;5766.452187042224;5801.3328467225965;4543.183226399521;5423.647462914898;5444.265024221838;5450.465533526929;5535.916961245665;4253.3832594273035;4392.758398287997;5013.674111182761;5257.922125964092;5429.538489228302;4594.678372514026;5220.425753167225;5275.709835959059;5651.321841379061;5843.970780146072;3666.6699997000396;3696.7597106188014;3816.904577385588;3822.6750726188584;3832.789196594214;4697.600703940203;5270.7101109439345;5299.205119232146;5507.834764957058;5520.199571062254;4052.230076285496;4452.866414007585;4999.500149955072;5282.4908168619595;5319.255304257485;4256.723312984646;5295.7087360195555;5307.41618421981;5312.1766126250495;5366.055948877493;4262.616364527207;5076.340075790271;5106.7701953412925;5235.712035838065;5258.8948221036135;4430.645548356059;4610.631149508098;5097.311862898609;5245.082110630548;5272.68002079084;4874.098291816025;5080.009398167322;5149.819756308511;5178.32681751385;5238.580913526985 04:37:13 INFO - PROCESS | 1980 | |5;yui.html;719.8596273726624;784.1805313447447;790.0440467034891;804.0632662947662;804.6781287485005;14715.48495802647;17041.57396065099;17342.91328543357;17393.304267829273;17446.65106697865;16501.33994640213;16580.17099145041;16599.917000414982;16602.916985415057;16604.750928736077;681.4684546054061;841.1588411588397;872.8036191856813;877.368294827723;879.560219890055;704.8977898204757;713.4114355656604;715.5277516838887;716.7849645106447;718.285306120411;888.2760550151638;909.1272378516599;913.3332667152982;918.3892711346946;923.7090316550265;905.0677801864091;906.9841777209567;907.9591418386188;909.3679892474732;915.812258487012;540.0656863625949;676.0467740485891;677.1670844860848;680.7617333933133;684.4455990647591;12526.060545459035;12803.935980320131;12814.487420503168;12819.551315703906;14998.62503437412;13566.186028838203;14214.786778198335;14478.493252736103;14483.275836208253;14525.491607793676;11414.60048898293;11798.233114847508;11831.053515718722;11880.881191188064;11922.523099076026;3290.7495151842145;3691.9446208306895;3795.221979494197;3795.278897009587;3824.8525442367177;128488;128862.45427170637;131290;132701.33649331692;133531;10713.78572428547;11042.392668403154;11090.5563777448;11246.83129753038;11269.66191014271;22550.661740073912;22655.433614159778;22702.886485567797;22897.771022289562;22938.65592016121;7427.888581671279;8006.599670016476;8083.959580202061;8128.552929588929;8249.29880960113;4310.741355518679;4371.540988196257;4494.325851122358;4527.864164075083;4662.184117779375;3625.456181572785;3744.063984003999;3744.850205991784;3745.887623371303;3748.2503499299705;618.0296933813959;637.1080487317699;656.9638669873203;665.6472069803012;669.5614372585867;626.896562067263;657.2572992518519;669.6917228889272;671.5701950751522;694.5173104692292;8903.866442003375;9506.904930950603;9523.952380238194;9713.320067595341;9996.800063998679;576.6338375131821;676.681959479044;684.3908921060261;687.8521117959663;697.7522979342361;3980.980095099506;4681.250999840077;4691.997697179015;4917.213245880714;4957.182064959241;165455;170096;171100.1444992767;171691.141544294;176541.11729441272;136792;140779.59220407868;143205;146266;147474.26262868618;123933;125095;127433.92856251783;128047.67690100113;129633;9306.627734890528;9322.95338523303;9366.344355895295;9372.203362714246;9377.296702747457;65821;67020;69125.30874691189;69424.65287673731;70052.64973675099;59175.70412148084;76933.07667308362;87938.120618793;87989.56005219933;90812.82155124539;10888;13141.145825521311;13612.455501779817;13945.860541394457;13987.580372588838;13949.093308934887;14593.635159121108;15128.167950762814;15401.614959626098;16147.273372698022;14208.573742787732;14408.711825763636;14412.927935360256;14954.850451495346;15076.944613877362;11698.152635218761;14115.22366269865;14305.71388572202;14576.489822856149;14862.628434288798;11734.70663233426;13302.46790128384;13550.525731599346;13717.245551494763;13799.862001379857;11059.838716934606;11498.597549085742;11609.142537194008;11674.591389301333;11984;10052.296339256181;10126.39241645474;11558.167421487033;11801.70495737579;11897.46461409256 04:37:13 INFO - PROCESS | 1980 | __end_tp_report 04:37:13 INFO - PROCESS | 1980 | __start_cc_report 04:37:13 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,1251 04:37:13 INFO - PROCESS | 1980 | __end_cc_report 04:37:13 INFO - PROCESS | 1980 | __startTimestamp1477309033767__endTimestamp 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | ------- Summary: start ------- 04:37:13 INFO - PROCESS | 1980 | Number of tests: 6 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#0] dojo.html Cycles:165 Average:5626.57 Median:5754.60 stddev:643.18 (11.2%) stddev-sans-first:617.69 04:37:13 INFO - PROCESS | 1980 | Values: 3256.3 3284.7 3305.9 3319.5 3355.1 5514.9 5576.1 5583.5 5596.8 5613.6 5543.3 5608.5 5617.7 5620.2 5665.3 5023.2 5095.9 5116.3 5170.3 5202.1 5070.8 5097.5 5106.8 5200.1 5225.9 5130.0 5167.2 5167.6 5174.7 5182.4 4453.7 5117.7 5157.6 5159.5 5220.0 4936.6 5149.6 5151.9 5152.2 5167.7 5520.3 5540.1 5545.8 5546.9 5607.8 6092.5 6109.8 6139.7 6150.6 6186.1 6152.7 6195.0 6203.0 6230.7 6238.7 5555.6 5611.5 5633.5 5660.0 5715.5 6143.3 6177.5 6190.7 6196.8 6211.6 6030.1 6059.5 6068.4 6072.7 6097.6 6018.4 6048.9 6127.1 6170.9 6176.1 6105.9 6112.3 6114.6 6128.3 6128.5 6041.2 6077.2 6110.8 6130.5 6141.4 4822.9 4829.7 4833.7 4849.7 4849.9 4329.6 4332.6 4337.1 4347.0 4359.6 5560.8 5612.0 5626.5 5636.4 5693.7 6119.7 6177.4 6186.8 6187.0 6191.7 5688.1 5725.9 5728.9 5729.2 5754.6 5155.7 5231.9 5269.5 5284.6 5287.9 6150.1 6160.8 6178.8 6208.1 6273.5 6211.6 6211.9 6219.3 6234.6 6243.8 6206.1 6250.2 6254.6 6264.3 6275.5 5892.8 5973.7 6009.5 6011.2 6011.3 5541.7 6040.5 6117.8 6171.9 6197.7 5818.7 6031.6 6044.0 6049.6 6058.3 4446.7 5737.3 5797.6 5957.7 5963.0 4797.5 5712.2 5740.7 5773.2 5826.6 5961.3 5966.1 5989.5 5997.7 6000.8 5752.1 5752.7 5773.6 5800.6 5807.6 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#1] ext.html Cycles:180 Average:69998.76 Median:38246.52 stddev:154008.37 (402.7%) stddev-sans-first:154351.81 04:37:13 INFO - PROCESS | 1980 | Values: 423.3 453.7 519.7 527.9 542.7 30245.2 40018.6 40883.4 41058.2 41086.4 41180.2 41813.0 42135.9 42286.2 42368.0 9690.6 9913.0 9913.8 9916.1 9917.0 8786.1 8995.5 9003.5 9099.2 9099.6 10333.9 11974.2 12185.2 12241.0 12448.9 9454.2 12196.5 12320.4 12334.1 12409.6 8735.9 8961.8 11871.5 11936.1 11940.3 32287.7 32556.0 32590.8 39102.4 39568.2 3304.4 3381.7 3465.7 3603.7 3727.3 29457.0 30551.0 30736.8 31551.0 31814.0 3209.1 3270.9 3273.1 3367.0 3371.0 500158.0 505109.0 506919.0 507090.0 508854.0 49092.8 50027.5 57035.0 57299.0 57419.1 58992.7 60172.4 60179.7 63482.4 63634.0 16234.0 16441.0 16455.9 16462.0 16515.8 12846.5 12937.1 12955.3 12978.6 13013.5 13481.7 13719.7 13757.8 15133.2 15267.8 5823.7 6146.7 6255.4 6286.5 6362.6 826.4 930.5 938.1 993.4 1041.6 28462.6 29042.7 29199.7 29910.9 30162.8 865.8 929.3 1020.9 1059.9 1105.9 14724.7 14758.5 15285.8 15442.3 15499.2 665312.0 670087.0 670768.0 671766.0 673047.0 49135.5 50114.2 55935.0 57096.4 57596.7 1154.4 1303.1 1336.6 1359.8 1362.9 28560.0 29651.1 30666.4 31459.0 32378.4 47640.0 48089.3 48136.8 48235.5 48316.0 534923.0 538717.0 539451.0 541041.0 541408.0 37739.8 38206.4 38552.0 38641.4 38888.6 38597.6 40927.8 44695.1 45565.8 46904.5 38021.6 38206.4 38719.0 38806.4 38933.8 33687.3 38016.6 38286.6 38489.6 38583.8 36236.9 36834.4 37331.8 37527.1 37836.0 30123.5 31807.8 31915.0 32924.0 34056.0 25012.0 25145.1 25184.1 25347.0 25827.9 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#2] jquery.html Cycles:180 Average:35366.38 Median:360.93 stddev:102128.14 (28296.0%) stddev-sans-first:102380.80 04:37:13 INFO - PROCESS | 1980 | Values: 353.7 368.1 373.8 380.3 400.3 15519.8 15827.4 17323.5 21288.5 21449.2 20328.4 20373.6 20693.9 20818.7 20977.6 5762.2 5791.2 5885.9 6025.9 6032.7 5756.8 5774.7 5779.7 5923.2 5926.1 4134.3 4370.0 5881.4 6308.3 6537.9 6407.6 6596.1 6656.7 6656.9 6669.4 5786.4 5789.2 5795.4 5796.4 5807.3 25652.5 26476.0 26602.9 26666.6 26831.1 2316.8 2414.5 2449.4 2488.7 3040.9 15042.1 15591.0 15829.2 16543.3 16544.8 1840.3 1848.7 1886.7 1888.8 1889.8 125456.4 126239.0 128488.0 129073.4 131405.3 9265.8 10672.8 11130.6 11236.2 11394.4 13938.9 13957.5 13959.5 13966.9 13977.7 8725.7 8824.6 8834.8 8884.1 8965.3 9019.0 9038.8 9045.6 9192.1 9208.2 6172.6 6289.3 6570.3 6754.7 6755.2 1579.4 1775.7 1777.3 1810.7 1814.3 912.7 933.8 939.9 995.1 1027.4 20950.6 22704.0 22830.4 22855.9 22861.0 943.5 950.3 960.1 980.4 1021.7 9594.9 10026.6 11645.4 11668.8 11925.3 599355.0 602390.0 614221.9 626865.0 628922.0 74241.0 76883.0 102636.0 125396.7 131838.0 952.4 979.4 994.3 994.6 997.3 19460.3 20004.6 20048.9 20052.3 20117.0 46441.0 53583.0 57666.7 58750.0 60736.5 71566.6 72155.0 81297.0 81542.0 83076.0 7217.8 7368.7 7408.9 8192.5 8254.2 9141.0 12244.9 12339.8 12414.1 12717.7 11280.0 11432.8 11528.6 11539.5 11676.4 8712.7 10559.4 11307.2 11390.9 11639.7 11525.9 11537.8 11596.7 12095.9 12177.1 7464.4 7596.7 7607.3 7654.7 7807.1 9692.8 11282.9 11669.4 11734.8 11874.1 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#3] mootools.html Cycles:180 Average:5730.69 Median:4755.95 stddev:3285.68 (69.1%) stddev-sans-first:3278.53 04:37:13 INFO - PROCESS | 1980 | Values: 1366.9 1516.2 1540.6 1743.3 1900.7 7905.0 8425.4 8810.0 9048.0 9055.5 8946.9 8959.8 9045.0 9059.5 9071.8 2401.0 2433.7 2435.8 2437.2 2438.0 2381.6 2408.1 2421.2 2422.8 2427.1 2257.4 2394.6 2415.3 2422.6 2423.6 2012.2 2184.7 2370.0 2395.9 2401.2 2337.2 2367.0 2368.7 2374.1 2377.2 8893.2 9129.6 9130.4 9142.9 9195.8 5351.6 5547.0 5555.8 5593.1 5596.8 3630.7 3631.4 3705.0 3713.7 3766.6 1090.1 1094.4 1097.5 1105.4 1120.8 12028.5 12090.2 12104.6 12161.0 12178.5 4497.6 4573.4 4753.2 4754.5 4758.9 8088.1 9269.1 9274.3 9286.9 9316.8 4598.7 5347.8 5349.7 5354.2 5355.5 4390.4 4460.3 4644.8 4871.2 5039.8 3539.8 3572.7 3781.6 3888.8 3914.5 1019.2 1154.8 1181.3 1195.0 1196.4 859.8 869.6 902.1 912.3 917.9 4757.4 5686.4 5741.2 5776.1 5819.6 433.7 442.4 448.9 460.5 463.8 3862.6 3867.2 3890.5 3981.4 3998.9 8329.6 10793.8 11045.7 11222.2 11225.0 11154.6 11163.8 11199.1 11203.7 11229.0 8255.5 8387.2 8430.3 8471.2 8496.5 5613.4 5711.6 5747.2 5829.4 5850.7 10149.6 10249.2 10398.6 10434.0 10479.3 9958.5 10351.4 10369.2 10384.1 10546.6 6979.0 7188.6 7441.1 7590.6 7617.7 7957.0 8171.4 8308.0 8452.5 8547.8 7455.5 7596.9 7604.7 7613.5 7720.5 7404.3 7420.0 7468.9 7479.8 7502.0 6940.2 7077.5 7088.8 7098.0 7098.0 4904.3 4973.3 5010.2 5013.5 5065.9 4919.7 4962.3 4992.0 5100.3 5202.0 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#4] prototype.html Cycles:180 Average:4276.49 Median:4809.66 stddev:1302.46 (27.1%) stddev-sans-first:1271.49 04:37:13 INFO - PROCESS | 1980 | Values: 301.6 307.9 311.4 314.4 319.3 3943.9 5072.7 5176.4 5182.0 5195.2 5006.7 5085.4 5091.3 5092.2 5124.7 3672.9 3696.2 3861.0 3905.6 3946.5 3875.6 3896.5 3929.2 3935.8 3958.7 3848.8 3866.7 3889.7 3916.4 3938.9 3221.7 3512.9 3596.9 3884.2 3915.8 2953.3 3081.7 3353.6 3356.2 3381.4 4918.8 4926.2 4934.7 4958.3 4962.3 3671.8 3880.6 4281.7 4368.2 4401.7 4840.3 5068.7 5235.1 5278.7 5306.2 3026.4 3302.7 3739.9 3749.4 3782.5 4708.7 5182.6 5582.2 5602.1 5656.0 3433.8 3648.2 3716.2 3799.7 3809.5 3612.0 3654.7 3844.4 3853.7 3859.8 3678.9 3728.5 4405.4 4405.5 4476.6 3956.0 4474.2 5282.9 5384.0 5399.6 1304.2 1323.2 1327.9 1329.4 1330.5 784.5 814.4 822.7 824.4 826.0 4181.4 4202.0 4779.0 4966.7 5028.8 4425.4 4689.4 5246.4 5456.4 5488.1 5073.9 5086.5 5090.9 5091.2 5158.4 2673.6 2831.8 2833.2 2850.2 2887.9 4735.0 5643.5 5667.1 5677.7 5692.0 4843.0 5277.8 5335.3 5573.3 5680.7 5258.9 5456.1 5696.5 5766.5 5801.3 4543.2 5423.6 5444.3 5450.5 5535.9 4253.4 4392.8 5013.7 5257.9 5429.5 4594.7 5220.4 5275.7 5651.3 5844.0 3666.7 3696.8 3816.9 3822.7 3832.8 4697.6 5270.7 5299.2 5507.8 5520.2 4052.2 4452.9 4999.5 5282.5 5319.3 4256.7 5295.7 5307.4 5312.2 5366.1 4262.6 5076.3 5106.8 5235.7 5258.9 4430.6 4610.6 5097.3 5245.1 5272.7 4874.1 5080.0 5149.8 5178.3 5238.6 04:37:13 INFO - PROCESS | 1980 | 04:37:13 INFO - PROCESS | 1980 | [#5] yui.html Cycles:180 Average:26934.81 Median:3458.10 stddev:44652.44 (1291.2%) stddev-sans-first:44734.32 04:37:13 INFO - PROCESS | 1980 | Values: 719.9 784.2 790.0 804.1 804.7 14715.5 17041.6 17342.9 17393.3 17446.7 16501.3 16580.2 16599.9 16602.9 16604.8 681.5 841.2 872.8 877.4 879.6 704.9 713.4 715.5 716.8 718.3 888.3 909.1 913.3 918.4 923.7 905.1 907.0 908.0 909.4 915.8 540.1 676.0 677.2 680.8 684.4 12526.1 12803.9 12814.5 12819.6 14998.6 13566.2 14214.8 14478.5 14483.3 14525.5 11414.6 11798.2 11831.1 11880.9 11922.5 3290.7 3691.9 3795.2 3795.3 3824.9 128488.0 128862.5 131290.0 132701.3 133531.0 10713.8 11042.4 11090.6 11246.8 11269.7 22550.7 22655.4 22702.9 22897.8 22938.7 7427.9 8006.6 8084.0 8128.6 8249.3 4310.7 4371.5 4494.3 4527.9 4662.2 3625.5 3744.1 3744.9 3745.9 3748.3 618.0 637.1 657.0 665.6 669.6 626.9 657.3 669.7 671.6 694.5 8903.9 9506.9 9524.0 9713.3 9996.8 576.6 676.7 684.4 687.9 697.8 3981.0 4681.3 4692.0 4917.2 4957.2 165455.0 170096.0 171100.1 171691.1 176541.1 136792.0 140779.6 143205.0 146266.0 147474.3 123933.0 125095.0 127433.9 128047.7 129633.0 9306.6 9323.0 9366.3 9372.2 9377.3 65821.0 67020.0 69125.3 69424.7 70052.6 59175.7 76933.1 87938.1 87989.6 90812.8 10888.0 13141.1 13612.5 13945.9 13987.6 13949.1 14593.6 15128.2 15401.6 16147.3 14208.6 14408.7 14412.9 14954.9 15076.9 11698.2 14115.2 14305.7 14576.5 14862.6 11734.7 13302.5 13550.5 13717.2 13799.9 11059.8 11498.6 11609.1 11674.6 11984.0 10052.3 10126.4 11558.2 11801.7 11897.5 04:37:13 INFO - PROCESS | 1980 | -------- Summary: end -------- 04:37:13 INFO - PROCESS | 1980 | 04:37:14 INFO - TEST-INFO | 1980: exit 0 04:37:14 INFO - TEST-OK | dromaeo_css | took 1116983ms 04:37:14 INFO - TEST-START | kraken 04:37:14 INFO - operating with platform_type : mac_ 04:37:14 INFO - Initialising browser for kraken test... 04:37:14 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpZQGkBg/profile http://localhost:51591/getInfo.html) 04:37:16 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 04:37:16 INFO - PROCESS | 1984 | colorDepth:24 04:37:16 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 04:37:16 INFO - PROCESS | 1984 | __metrics 04:37:16 INFO - PROCESS | 1984 | 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" 04:37:16 INFO - PROCESS | 1984 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:17 INFO - TEST-INFO | 1984: exit 0 04:37:17 INFO - Browser initialized. 04:37:17 INFO - Running cycle 1/1 for kraken test... 04:37:17 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpZQGkBg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:29 INFO - PROCESS | 1985 | RSS: Main: 219926528 04:37:29 INFO - PROCESS | 1985 | 04:37:32 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51591/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:33 INFO - PROCESS | 1985 | RSS: Main: 270159872 04:37:33 INFO - PROCESS | 1985 | 04:37:35 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51591/tests/kraken/driver.html?testName=audio-dft) 04:37:36 INFO - PROCESS | 1985 | RSS: Main: 280567808 04:37:36 INFO - PROCESS | 1985 | 04:37:39 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51591/tests/kraken/driver.html?testName=audio-fft) 04:37:40 INFO - PROCESS | 1985 | RSS: Main: 377610240 04:37:40 INFO - PROCESS | 1985 | 04:37:42 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51591/tests/kraken/driver.html?testName=audio-oscillator) 04:37:42 INFO - PROCESS | 1985 | RSS: Main: 280715264 04:37:42 INFO - PROCESS | 1985 | 04:37:44 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:45 INFO - PROCESS | 1985 | RSS: Main: 281608192 04:37:45 INFO - PROCESS | 1985 | 04:37:48 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51591/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:48 INFO - PROCESS | 1985 | RSS: Main: 320741376 04:37:48 INFO - PROCESS | 1985 | 04:37:51 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51591/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:52 INFO - PROCESS | 1985 | RSS: Main: 319381504 04:37:52 INFO - PROCESS | 1985 | 04:37:54 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51591/tests/kraken/driver.html?testName=json-parse-financial) 04:37:55 INFO - PROCESS | 1985 | RSS: Main: 315572224 04:37:55 INFO - PROCESS | 1985 | 04:37:57 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:57 INFO - PROCESS | 1985 | RSS: Main: 290410496 04:37:57 INFO - PROCESS | 1985 | 04:37:59 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:00 INFO - PROCESS | 1985 | RSS: Main: 295227392 04:38:00 INFO - PROCESS | 1985 | 04:38:02 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:03 INFO - PROCESS | 1985 | RSS: Main: 298819584 04:38:03 INFO - PROCESS | 1985 | 04:38:05 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:06 INFO - PROCESS | 1985 | RSS: Main: 308748288 04:38:06 INFO - PROCESS | 1985 | 04:38:09 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:10 INFO - PROCESS | 1985 | RSS: Main: 308572160 04:38:10 INFO - PROCESS | 1985 | 04:38:11 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:51591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51591/tests/kraken/driver.html?testName=ai-astar) 04:38:12 INFO - PROCESS | 1985 | RSS: Main: 352485376 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | __start_tp_report 04:38:12 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 04:38:12 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 04:38:12 INFO - PROCESS | 1985 | |i|pagename|runs| 04:38:12 INFO - PROCESS | 1985 | |0;ai-astar;115;114;115;114;112;115;114;114;114;115 04:38:12 INFO - PROCESS | 1985 | |1;audio-beat-detection;152;142;138;143;109;109;105;107;139;114 04:38:12 INFO - PROCESS | 1985 | |2;audio-dft;186;185;183;185;183;183;181;183;183;183 04:38:12 INFO - PROCESS | 1985 | |3;audio-fft;82;58;59;89;59;58;58;58;82;57 04:38:12 INFO - PROCESS | 1985 | |4;audio-oscillator;89;73;94;74;68;69;93;68;90;107 04:38:12 INFO - PROCESS | 1985 | |5;imaging-gaussian-blur;89;86;88;86;88;85;89;86;94;130 04:38:12 INFO - PROCESS | 1985 | |6;imaging-darkroom;94;93;93;93;93;94;95;94;94;93 04:38:12 INFO - PROCESS | 1985 | |7;imaging-desaturate;83;84;86;91;115;83;83;84;83;84 04:38:12 INFO - PROCESS | 1985 | |8;json-parse-financial;58;55;55;55;55;58;57;57;57;57 04:38:12 INFO - PROCESS | 1985 | |9;json-stringify-tinderbox;61;92;112;98;72;69;69;70;70;72 04:38:12 INFO - PROCESS | 1985 | |10;stanford-crypto-aes;83;81;82;85;80;82;82;81;82;83 04:38:12 INFO - PROCESS | 1985 | |11;stanford-crypto-ccm;139;122;154;149;150;138;141;140;171;139 04:38:12 INFO - PROCESS | 1985 | |12;stanford-crypto-pbkdf2;166;164;163;164;173;163;160;162;166;225 04:38:12 INFO - PROCESS | 1985 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;66;66;67;66;66 04:38:12 INFO - PROCESS | 1985 | __end_tp_report 04:38:12 INFO - PROCESS | 1985 | __start_cc_report 04:38:12 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,1992 04:38:12 INFO - PROCESS | 1985 | __end_cc_report 04:38:12 INFO - PROCESS | 1985 | __startTimestamp1477309092173__endTimestamp 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | ------- Summary: start ------- 04:38:12 INFO - PROCESS | 1985 | Number of tests: 14 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:38:12 INFO - PROCESS | 1985 | Values: 115.0 114.0 115.0 114.0 112.0 115.0 114.0 114.0 114.0 115.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:138.50 stddev:18.43 (13.3%) stddev-sans-first:16.94 04:38:12 INFO - PROCESS | 1985 | Values: 152.0 142.0 138.0 143.0 109.0 109.0 105.0 107.0 139.0 114.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.00 stddev:1.43 (0.8%) stddev-sans-first:1.20 04:38:12 INFO - PROCESS | 1985 | Values: 186.0 185.0 183.0 185.0 183.0 183.0 181.0 183.0 183.0 183.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#3] audio-fft Cycles:10 Average:66.00 Median:59.00 stddev:12.81 (21.7%) stddev-sans-first:12.20 04:38:12 INFO - PROCESS | 1985 | Values: 82.0 58.0 59.0 89.0 59.0 58.0 58.0 58.0 82.0 57.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:81.50 stddev:13.77 (16.9%) stddev-sans-first:14.40 04:38:12 INFO - PROCESS | 1985 | Values: 89.0 73.0 94.0 74.0 68.0 69.0 93.0 68.0 90.0 107.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:88.00 stddev:13.56 (15.4%) stddev-sans-first:14.34 04:38:12 INFO - PROCESS | 1985 | Values: 89.0 86.0 88.0 86.0 88.0 85.0 89.0 86.0 94.0 130.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:38:12 INFO - PROCESS | 1985 | Values: 94.0 93.0 93.0 93.0 93.0 94.0 95.0 94.0 94.0 93.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#7] imaging-desaturate Cycles:10 Average:87.60 Median:84.00 stddev:9.94 (11.8%) stddev-sans-first:10.40 04:38:12 INFO - PROCESS | 1985 | Values: 83.0 84.0 86.0 91.0 115.0 83.0 83.0 84.0 83.0 84.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.20 04:38:12 INFO - PROCESS | 1985 | Values: 58.0 55.0 55.0 55.0 55.0 58.0 57.0 57.0 57.0 57.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:71.00 stddev:16.33 (23.0%) stddev-sans-first:16.05 04:38:12 INFO - PROCESS | 1985 | Values: 61.0 92.0 112.0 98.0 72.0 69.0 69.0 70.0 70.0 72.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.37 (1.7%) stddev-sans-first:1.41 04:38:12 INFO - PROCESS | 1985 | Values: 83.0 81.0 82.0 85.0 80.0 82.0 82.0 81.0 82.0 83.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:145.00 stddev:12.84 (8.9%) stddev-sans-first:13.48 04:38:12 INFO - PROCESS | 1985 | Values: 139.0 122.0 154.0 149.0 150.0 138.0 141.0 140.0 171.0 139.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:165.00 stddev:19.43 (11.8%) stddev-sans-first:20.53 04:38:12 INFO - PROCESS | 1985 | Values: 166.0 164.0 163.0 164.0 173.0 163.0 160.0 162.0 166.0 225.0 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - PROCESS | 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:38:12 INFO - PROCESS | 1985 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 04:38:12 INFO - PROCESS | 1985 | -------- Summary: end -------- 04:38:12 INFO - PROCESS | 1985 | 04:38:12 INFO - TEST-INFO | 1985: exit 0 04:38:13 INFO - TEST-OK | kraken | took 58652ms 04:38:13 INFO - SUITE-END | took 1175s 04:38:13 INFO - Completed test suite (00:19:35) 04:38:13 INFO - javascript benchmark 04:38:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.2836176041274, 3284.6551112133225, 3305.933881322372, 3319.468884978404, 3355.110895612663, 5514.944850551493, 5576.079946808782, 5583.497485226324, 5596.776128954837, 5613.635113717605, 5543.334799824027, 5608.46719561641, 5617.747201375938, 5620.213170156181, 5665.3201615806165, 5023.196288593826, 5095.949040509585, 5116.334876466073, 5170.327857378536, 5202.06362854686, 5070.847874563769, 5097.541221290083, 5106.795728170869, 5200.115980283342, 5225.947740522584, 5130.0, 5167.224916262572, 5167.612429067816, 5174.741262936857, 5182.37811462625, 4453.732776033448, 5117.744112794346, 5157.638965272433, 5159.535641792238, 5220.0, 4936.580390666798, 5149.562287205592, 5151.922721159186, 5152.201408781645, 5167.741612919339, 5520.282363292787, 5540.141278101901, 5545.805896793633, 5546.889062218774, 5607.775688972436, 6092.482139018189, 6109.847253818646, 6139.693015349259, 6150.600210986317, 6186.133941248228, 6152.692365381713, 6195.0, 6203.038529028008, 6230.657313847737, 6238.656873871935, 5555.638883472602, 5611.466910643482, 5633.464820842013, 5660.0, 5715.485606295411, 6143.266246520345, 6177.536684748662, 6190.659513726789, 6196.845078872974, 6211.627302361872, 6030.125631783367, 6059.48494377974, 6068.362821903636, 6072.726727297282, 6097.634141951408, 6018.398160184034, 6048.879022419527, 6127.050307202391, 6170.907436388457, 6176.135341052256, 6105.877882442326, 6112.327643959161, 6114.633122012693, 6128.264608247039, 6128.4790792783115, 6041.214642096499, 6077.24034495688, 6110.816675499742, 6130.478909292671, 6141.355157708465, 4822.855314340575, 4829.710217386968, 4833.661643684979, 4849.660523763303, 4849.878753031202, 4329.631981281564, 4332.588404101605, 4337.110892267141, 4346.978265108717, 4359.585839345257, 5560.77756889728, 5611.971940140274, 5626.549876009909, 5636.436356364331, 5693.715314234271, 6119.654885717031, 6177.444030037318, 6186.845328866814, 6186.969065154645, 6191.659458729723, 5688.089905615082, 5725.942740572625, 5728.942710572841, 5729.169270455844, 5754.5971781975695, 5155.690658560498, 5231.921521177185, 5269.4730526947, 5284.630075894727, 5287.920681189786, 6150.138980542728, 6160.7535698571555, 6178.752849885954, 6208.068789681403, 6273.466755325849, 6211.627302361872, 6211.9068213975925, 6219.346968568416, 6234.625922444668, 6243.781467648792, 6206.06908963659, 6250.1874756281395, 6254.562180647311, 6264.31092579825, 6275.497960163085, 5892.793752218823, 5973.731182096729, 6009.519238460825, 6011.218541589566, 6011.308699499614, 5541.667499950016, 6040.546958978182, 6117.766507567632, 6171.876562468815, 6197.690115494297, 5818.650880946987, 6031.60794548353, 6044.0, 6049.637021778707, 6058.333583305921, 4446.73319600825, 5737.282839645044, 5797.623154494944, 5957.702114894151, 5963.016102343065, 4797.520247975314, 5712.171735098304, 5740.655560666206, 5773.16289138081, 5826.621269617462, 5961.2846458425265, 5966.075258334965, 5989.490893273946, 5997.70011499432, 6000.8499787503915, 5752.07966725322, 5752.712364381848, 5773.595848290579, 5800.622959507618, 5807.622504537191], "value": 5585.453310609925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.28887469052, 453.6982906367266, 519.729740534922, 527.8733104055026, 542.6554138122291, 30245.24386890326, 40018.599814001886, 40883.386749198784, 41058.178836423256, 41086.38370424446, 41180.17639647205, 41813.0, 42135.94660133498, 42286.15427691444, 42368.0, 9690.612375504972, 9913.008699130101, 9913.801723965516, 9916.057974492413, 9917.008299170098, 8786.121387861227, 8995.505247211433, 9003.549822508881, 9099.22656574192, 9099.63601455941, 10333.948330258338, 11974.221675591103, 12185.207961482476, 12241.0, 12448.93775531121, 9454.243660507143, 12196.512139514409, 12320.445579948924, 12334.136610437274, 12409.62771116868, 8735.912640873574, 8961.820763584758, 11871.52513899443, 11936.104792140537, 11940.283582985048, 32287.677123228703, 32556.02331930046, 32590.837045814857, 39102.41346379807, 39568.20863582712, 3304.438245498271, 3381.6980462522106, 3465.705415039725, 3603.747737658365, 3727.2918145552258, 29456.969006084684, 30551.0, 30736.770529178804, 31551.0, 31814.0, 3209.117492689529, 3270.887898114652, 3273.0508152635707, 3366.9831650841834, 3371.022403502981, 500158.0, 505109.0, 506918.99999999633, 507090.0, 508854.0, 49092.75453622709, 50027.499725002286, 57035.0, 57299.0, 57419.13871291934, 58992.7050364754, 60172.39827601668, 60179.699101504215, 63482.36517634857, 63634.0, 16234.0, 16441.0, 16455.917720411322, 16462.0, 16515.752263716055, 12846.48614055446, 12937.09440339186, 12955.287459189834, 12978.610641680765, 13013.544525941546, 13481.662958426117, 13719.725605488034, 13757.79363309551, 15133.243337833064, 15267.847321526864, 5823.737931793079, 6146.692665366714, 6255.404007336904, 6286.527241452852, 6362.554621176566, 826.3843436639622, 930.5486838883136, 938.1041105743998, 993.3592832622918, 1041.6354276003337, 28462.573061404095, 29042.709572904423, 29199.708002920124, 29910.850445747634, 30162.84918575393, 865.7575878753959, 929.307665788978, 1020.9183265338755, 1059.9152067834555, 1105.9391733454738, 14724.705505889822, 14758.48345307909, 15285.770713439308, 15442.305096270695, 15499.225038748018, 665312.0, 670087.0, 670768.0, 671766.0, 673047.0, 49135.50864491381, 50114.24828627573, 55935.0, 57096.42903570911, 57596.71201643965, 1154.417019405195, 1303.1008604063165, 1336.5923393364922, 1359.8028285898688, 1362.8637136286688, 28560.000799943806, 29651.110466686034, 30666.386672266875, 31459.0, 32378.352432950738, 47640.0, 48089.27866082082, 48136.75931620319, 48235.5176448231, 48316.0, 534923.0, 538717.0, 539451.0, 541041.0, 541408.0, 37739.81130094442, 38206.42690359702, 38552.036199094124, 38641.42037869378, 38888.611113888495, 38597.6140238594, 40927.795361023, 44695.10609787851, 45565.772171140256, 46904.53095469002, 38021.619783801805, 38206.426903595915, 38719.03202419962, 38806.41790373203, 38933.80533097316, 33687.326253474304, 38016.619833801306, 38286.6171338283, 38489.615103848606, 38583.80708096441, 36236.91289261326, 36834.44748328724, 37331.81334093312, 37527.06182345354, 37836.0, 30123.548146778256, 31807.84096079505, 31915.042548723577, 32924.01227963165, 34056.0, 25012.0, 25145.119920802685, 25184.11855585046, 25347.0, 25827.870860645577], "value": 19795.103061661182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7240952057396, 368.13121034358915, 373.8224343436868, 380.3154322220005, 400.2854903996367, 15519.767203491943, 15827.44603938861, 17323.480295591122, 21288.4677883053, 21449.171052565816, 20328.390148295537, 20373.592528149427, 20693.896530517362, 20818.687719684218, 20977.58044839106, 5762.222100016496, 5791.189233507313, 5885.941140588582, 6025.879482410371, 6032.728527216286, 5756.769729210827, 5774.7401366938375, 5779.653220806744, 5923.17075609415, 5926.051831706928, 4134.317837556815, 4370.038591509879, 5881.411858814127, 6308.3060863305, 6537.869242615145, 6407.647579383132, 6596.076549283104, 6656.70044847983, 6656.934890417534, 6669.399754022113, 5786.363500015037, 5789.218455508537, 5795.420457954213, 5796.3913789052385, 5807.30312362515, 25652.48695026089, 26476.0, 26602.866985665143, 26666.600001, 26831.06091286815, 2316.8030717389042, 2414.4929564791414, 2449.35092200567, 2488.701355837293, 3040.890075122564, 15042.097474151586, 15591.0, 15829.15075286448, 16543.2555535, 16544.83455165445, 1840.3098837935775, 1848.7319338695813, 1886.7075603281514, 1888.8394486468667, 1889.763779527559, 125456.37271813674, 126239.0, 128488.0, 129073.41853162978, 131405.34297328547, 9265.814683706289, 10672.78654426907, 11130.554777808797, 11236.157288203418, 11394.37330946806, 13938.93030534841, 13957.511487097903, 13959.511417100353, 13966.882649388024, 13977.65055873591, 8725.65097396097, 8824.647014119491, 8834.77913052166, 8884.111588841193, 8965.282777377794, 9019.0, 9038.774030649287, 9045.592948317342, 9192.080791920887, 9208.217301529312, 6172.642018755867, 6289.308176100625, 6570.342965703487, 6754.662266886636, 6755.2231493378895, 1579.439299048844, 1775.7070083436347, 1777.2713187593024, 1810.7374430707737, 1814.319630138698, 912.6714382822179, 933.7665583604099, 939.8637197606308, 995.0745806400117, 1027.3733022856052, 20950.58098838015, 22704.0, 22830.42923926915, 22855.885720571292, 22861.0, 943.495230051919, 950.3252690589759, 960.1166926427703, 980.3578655980344, 1021.6934919524113, 9594.904050959542, 10026.64906728261, 11645.41772911368, 11668.824967625493, 11925.344106074075, 599355.0, 602390.0, 614221.9288903527, 626865.0, 628922.0, 74241.0, 76883.0, 102636.0, 125396.74603254034, 131838.02242966363, 952.3809523809579, 979.3927764785878, 994.2848586188911, 994.5876854866108, 997.2620261006803, 19460.31888883882, 20004.599908001466, 20048.897310648055, 20052.298169563994, 20117.0, 46441.0, 53583.0, 57666.7116664414, 58750.0, 60736.481587960654, 71566.64216679092, 72155.0, 81297.0, 81542.0, 83076.01896489726, 7217.819554511179, 7368.742094026683, 7408.851822963618, 8192.54940978252, 8254.174582541698, 9140.994490605895, 12244.938775306067, 12339.814902776645, 12414.068944829354, 12717.682057948625, 11280.0, 11432.82850757256, 11528.59649912249, 11539.519003414307, 11676.416179191176, 8712.651493940424, 10559.366438013743, 11307.208495405243, 11390.886091139315, 11639.709007274885, 11525.884741152817, 11537.769244614892, 11596.710082248012, 12095.879041209475, 12177.086718495972, 7464.440166987389, 7596.696132154652, 7607.315341619281, 7654.693812247448, 7807.141214466517, 9692.806143877224, 11282.887171128184, 11669.35818529955, 11734.765304693688, 11874.109441792072], "value": 9807.49494488528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.8769810717033, 1516.1585320147321, 1540.5686407805813, 1743.3288184049138, 1900.7243949627295, 7904.960475197623, 8425.368097392697, 8810.0, 9048.0, 9055.547222638874, 8946.91053089469, 8959.820803583942, 9045.0, 9059.456432614032, 9071.818563628723, 2400.9759902401015, 2433.6592876997147, 2435.7807797298237, 2437.1591800828687, 2437.9882348825304, 2381.6070348392495, 2408.060856266049, 2421.1767998880377, 2422.794062504689, 2427.1383658801137, 2257.446925503254, 2394.568977584034, 2415.2995631267, 2422.588160012802, 2423.6364545318165, 2012.2051789543195, 2184.6722991551237, 2369.988150059256, 2395.8562486250707, 2401.171595799455, 2337.2403968710237, 2367.0176876596192, 2368.7157541095007, 2374.1453076892303, 2377.227401094634, 8893.15515026078, 9129.634814607407, 9130.360874738772, 9142.908570914338, 9195.816083678288, 5351.57187425005, 5547.029269877796, 5555.805546805843, 5593.105103183511, 5596.804111856106, 3630.7458477906557, 3631.3840341048244, 3704.9996500944594, 3713.721470889694, 3766.5856755756845, 1090.1278976818514, 1094.3762055628295, 1097.4951522299752, 1105.38098664748, 1120.78705046041, 12028.51885924562, 12090.214136081215, 12104.576339828063, 12161.0, 12178.51285948561, 4497.617702495259, 4573.405457290597, 4753.191957367256, 4754.548317909793, 4758.881027974328, 8088.11030786613, 9269.073092690676, 9274.30442716799, 9286.90713092874, 9316.767080823034, 4598.701084429501, 5347.81282655113, 5349.732513374316, 5354.223637572531, 5355.491228333302, 4390.401591445978, 4460.30865215892, 4644.8374306899095, 4871.2206047032305, 5039.84880453587, 3539.823008849547, 3572.6605972432576, 3781.640744129303, 3888.8055597220027, 3914.530256369254, 1019.23557332001, 1154.8440960470398, 1181.3207405741732, 1194.9522019119138, 1196.443653701033, 859.7807559072521, 869.6477926439802, 902.1069141549818, 912.3339961827903, 917.9082091790767, 4757.3577567028005, 5686.431356864363, 5741.224934633855, 5776.104703770922, 5819.563532735062, 433.7378229352569, 442.35637147949654, 448.9416375871116, 460.4612603254134, 463.79129391773836, 3862.5558060823364, 3867.16855875988, 3890.533136023695, 3981.402789581586, 3998.900027499336, 8329.625166867505, 10793.784124317626, 11045.723856903642, 11222.158338124673, 11225.045871101049, 11154.553817847358, 11163.776724465466, 11199.104071674246, 11203.663890083311, 11229.0, 8255.504669719836, 8387.245147936716, 8430.325573954191, 8471.152884711602, 8496.490210587384, 5613.410591887793, 5711.571632127524, 5747.166660834239, 5829.358770535153, 5850.736716847837, 10149.64476243328, 10249.180065594586, 10398.58405663765, 10433.956604339506, 10479.266451348332, 9958.50207489637, 10351.378917264989, 10369.222308326755, 10384.065434110966, 10546.630867919586, 6979.022936788752, 7188.568685878864, 7441.144268409203, 7590.582517961565, 7617.733379331697, 7957.045154581488, 8171.428000040178, 8308.003039635283, 8452.535110568977, 8547.829043418973, 7455.478116531791, 7596.886046709415, 7604.733834315773, 7613.5431874087735, 7720.498167619311, 7404.259574042768, 7419.961205431352, 7468.887966680612, 7479.775606731807, 7501.962490187514, 6940.201876784033, 7077.504574679929, 7088.787336379917, 7098.0, 7098.041764361745, 4904.329362972913, 4973.254011898244, 5010.198368261061, 5013.498650134958, 5065.949340506548, 4919.655624106422, 4962.305277261258, 4992.0, 5100.26046223303, 5202.03762303975], "value": 4503.923346625163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.60489758416475, 307.9184016235698, 311.3694768094609, 314.35400252481173, 319.2529481014426, 3943.9211215775704, 5072.72100034498, 5176.352955880515, 5181.974090129549, 5195.220716892468, 5006.72463014535, 5085.4151772546165, 5091.287219789232, 5092.210707340369, 5124.6668966517245, 3672.8530858765616, 3696.20531585709, 3861.0, 3905.5508616509037, 3946.52641682997, 3875.593062728415, 3896.5129358830145, 3929.2337994091163, 3935.783531905744, 3958.7030972677167, 3848.8460461581503, 3866.6520013198806, 3889.727719059667, 3916.4321173429835, 3938.921221575567, 3221.7100460958627, 3512.8770493032875, 3596.9280614387826, 3884.242572698325, 3915.7650540967634, 2953.3207362306575, 3081.6764239754953, 3353.564036675217, 3356.1777364545596, 3381.442062059757, 4918.827841025547, 4926.187179115442, 4934.728589927553, 4958.305837182797, 4962.305277261186, 3671.761335513183, 3880.573136954961, 4281.657467402601, 4368.191884501377, 4401.691881568291, 4840.322354870321, 5068.69587824728, 5235.136202526579, 5278.683279003234, 5306.151015837486, 3026.44010857992, 3302.702756751904, 3739.8504059837574, 3749.4000959846294, 3782.5082739244, 4708.741019243906, 5182.611304152204, 5582.190582365534, 5602.131669591179, 5655.971720141414, 3433.776804507699, 3648.1973965727498, 3716.201016781405, 3799.696024318048, 3809.5047643806683, 3611.981940090283, 3654.666046892865, 3844.38489841624, 3853.6512220722525, 3859.7877116758846, 3678.9264214715554, 3728.496652951871, 4405.361222622766, 4405.537418571068, 4476.6418686505, 3955.980220098939, 4474.172278128557, 5282.894342113136, 5383.973080134652, 5399.622026458189, 1304.230504002643, 1323.1597935310954, 1327.9004074694437, 1329.4017692038622, 1330.4545136494185, 784.4626430894855, 814.4054839966857, 822.6544851162527, 824.3611201319026, 825.9587020649063, 4181.393697913785, 4201.962048406521, 4779.0, 4966.690488922596, 5028.823991160365, 4425.389020477869, 4689.366935463669, 5246.449122842123, 5456.399796022434, 5488.1493368527945, 5073.949260507421, 5086.4659210783075, 5090.949090509048, 5091.159958606789, 5158.380994280636, 2673.585594232897, 2831.7876159288135, 2833.206702123409, 2850.232855629523, 2887.9422411552073, 4734.976325118352, 5643.463870932255, 5667.064934285797, 5677.744501497443, 5691.971540142273, 4843.007183527368, 5277.8416647500635, 5335.279737235501, 5573.331200255914, 5680.711063147297, 5258.92111618326, 5456.099743542351, 5696.487316141484, 5766.452187042224, 5801.3328467225965, 4543.183226399521, 5423.647462914898, 5444.265024221838, 5450.465533526929, 5535.916961245665, 4253.3832594273035, 4392.758398287997, 5013.674111182761, 5257.922125964092, 5429.538489228302, 4594.678372514026, 5220.425753167225, 5275.709835959059, 5651.321841379061, 5843.970780146072, 3666.6699997000396, 3696.7597106188014, 3816.904577385588, 3822.6750726188584, 3832.789196594214, 4697.600703940203, 5270.7101109439345, 5299.205119232146, 5507.834764957058, 5520.199571062254, 4052.230076285496, 4452.866414007585, 4999.500149955072, 5282.4908168619595, 5319.255304257485, 4256.723312984646, 5295.7087360195555, 5307.41618421981, 5312.1766126250495, 5366.055948877493, 4262.616364527207, 5076.340075790271, 5106.7701953412925, 5235.712035838065, 5258.8948221036135, 4430.645548356059, 4610.631149508098, 5097.311862898609, 5245.082110630548, 5272.68002079084, 4874.098291816025, 5080.009398167322, 5149.819756308511, 5178.32681751385, 5238.580913526985], "value": 3871.827855111559, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8596273726624, 784.1805313447447, 790.0440467034891, 804.0632662947662, 804.6781287485005, 14715.48495802647, 17041.57396065099, 17342.91328543357, 17393.304267829273, 17446.65106697865, 16501.33994640213, 16580.17099145041, 16599.917000414982, 16602.916985415057, 16604.750928736077, 681.4684546054061, 841.1588411588397, 872.8036191856813, 877.368294827723, 879.560219890055, 704.8977898204757, 713.4114355656604, 715.5277516838887, 716.7849645106447, 718.285306120411, 888.2760550151638, 909.1272378516599, 913.3332667152982, 918.3892711346946, 923.7090316550265, 905.0677801864091, 906.9841777209567, 907.9591418386188, 909.3679892474732, 915.812258487012, 540.0656863625949, 676.0467740485891, 677.1670844860848, 680.7617333933133, 684.4455990647591, 12526.060545459035, 12803.935980320131, 12814.487420503168, 12819.551315703906, 14998.62503437412, 13566.186028838203, 14214.786778198335, 14478.493252736103, 14483.275836208253, 14525.491607793676, 11414.60048898293, 11798.233114847508, 11831.053515718722, 11880.881191188064, 11922.523099076026, 3290.7495151842145, 3691.9446208306895, 3795.221979494197, 3795.278897009587, 3824.8525442367177, 128488.0, 128862.45427170637, 131290.0, 132701.33649331692, 133531.0, 10713.78572428547, 11042.392668403154, 11090.5563777448, 11246.83129753038, 11269.66191014271, 22550.661740073912, 22655.433614159778, 22702.886485567797, 22897.771022289562, 22938.65592016121, 7427.888581671279, 8006.599670016476, 8083.959580202061, 8128.552929588929, 8249.29880960113, 4310.741355518679, 4371.540988196257, 4494.325851122358, 4527.864164075083, 4662.184117779375, 3625.456181572785, 3744.063984003999, 3744.850205991784, 3745.887623371303, 3748.2503499299705, 618.0296933813959, 637.1080487317699, 656.9638669873203, 665.6472069803012, 669.5614372585867, 626.896562067263, 657.2572992518519, 669.6917228889272, 671.5701950751522, 694.5173104692292, 8903.866442003375, 9506.904930950603, 9523.952380238194, 9713.320067595341, 9996.800063998679, 576.6338375131821, 676.681959479044, 684.3908921060261, 687.8521117959663, 697.7522979342361, 3980.980095099506, 4681.250999840077, 4691.997697179015, 4917.213245880714, 4957.182064959241, 165455.0, 170096.0, 171100.1444992767, 171691.141544294, 176541.11729441272, 136792.0, 140779.59220407868, 143205.0, 146266.0, 147474.26262868618, 123933.0, 125095.0, 127433.92856251783, 128047.67690100113, 129633.0, 9306.627734890528, 9322.95338523303, 9366.344355895295, 9372.203362714246, 9377.296702747457, 65821.0, 67020.0, 69125.30874691189, 69424.65287673731, 70052.64973675099, 59175.70412148084, 76933.07667308362, 87938.120618793, 87989.56005219933, 90812.82155124539, 10888.0, 13141.145825521311, 13612.455501779817, 13945.860541394457, 13987.580372588838, 13949.093308934887, 14593.635159121108, 15128.167950762814, 15401.614959626098, 16147.273372698022, 14208.573742787732, 14408.711825763636, 14412.927935360256, 14954.850451495346, 15076.944613877362, 11698.152635218761, 14115.22366269865, 14305.71388572202, 14576.489822856149, 14862.628434288798, 11734.70663233426, 13302.46790128384, 13550.525731599346, 13717.245551494763, 13799.862001379857, 11059.838716934606, 11498.597549085742, 11609.142537194008, 11674.591389301333, 11984.0, 10052.296339256181, 10126.39241645474, 11558.167421487033, 11801.70495737579, 11897.46461409256], "value": 8013.220392036725, "unit": "score"}], "name": "dromaeo_css", "value": 7301.684230877295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 112.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 142.0, 138.0, 143.0, 109.0, 109.0, 105.0, 107.0, 139.0, 114.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 183.0, 185.0, 183.0, 183.0, 181.0, 183.0, 183.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 89.0, 59.0, 58.0, 58.0, 58.0, 82.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 94.0, 74.0, 68.0, 69.0, 93.0, 68.0, 90.0, 107.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 94.0, 130.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 91.0, 115.0, 83.0, 83.0, 84.0, 83.0, 84.0], "value": 87.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 55.0, 55.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 92.0, 112.0, 98.0, 72.0, 69.0, 69.0, 70.0, 70.0, 72.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 85.0, 80.0, 82.0, 82.0, 81.0, 82.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 122.0, 154.0, 149.0, 150.0, 138.0, 141.0, 140.0, 171.0, 139.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 164.0, 173.0, 163.0, 160.0, 162.0, 166.0, 225.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1443.4999999999998, "alertThreshold": 2.0}]} 04:38:13 INFO - Return code: 0 04:38:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:38:13 INFO - # TBPL SUCCESS # 04:38:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:13 INFO - 2016-10-24 04:38:13.480 screenresolution[1989:19294] starting screenresolution argv=screenresolution get 04:38:13 INFO - 2016-10-24 04:38:13.483 screenresolution[1989:19294] Display 0: 1600x1200x32@60 04:38:13 INFO - 2016-10-24 04:38:13.489 screenresolution[1990:19297] starting screenresolution argv=screenresolution list 04:38:13 INFO - Available Modes on Display 0 04:38:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:13 INFO - Intel Iris: 04:38:13 INFO - Chipset Model: Intel Iris 04:38:13 INFO - Type: GPU 04:38:13 INFO - Bus: Built-In 04:38:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:13 INFO - Vendor: Intel (0x8086) 04:38:13 INFO - Device ID: 0x0a2e 04:38:13 INFO - Revision ID: 0x0009 04:38:13 INFO - Displays: 04:38:13 INFO - Display: 04:38:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:13 INFO - Display Serial Number: 1600x1200 60 04:38:13 INFO - Main Display: Yes 04:38:13 INFO - Mirror: Off 04:38:13 INFO - Online: Yes 04:38:13 INFO - Rotation: Supported 04:38:13 INFO - Return code: 0 04:38:13 INFO - Running post-action listener: _resource_record_post_action 04:38:13 INFO - [mozharness: 2016-10-24 11:38:13.724223Z] Finished run-tests step (success) 04:38:13 INFO - Running post-run listener: _resource_record_post_run 04:38:13 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1527808; Write bytes: 663990784; Read time: 12; Write time: 2104 04:38:13 INFO - TinderboxPrint: CPU usage
53.4% 04:38:13 INFO - TinderboxPrint: I/O read bytes / time
1,527,808 / 12 04:38:13 INFO - TinderboxPrint: I/O write bytes / time
663,990,784 / 2,104 04:38:13 INFO - TinderboxPrint: CPU idle
2,254.5 (46.6%) 04:38:13 INFO - TinderboxPrint: CPU system
974.8 (20.2%) 04:38:13 INFO - TinderboxPrint: CPU user
1,608.3 (33.2%) 04:38:13 INFO - TinderboxPrint: Swap in / out
364,601,344 / 0 04:38:13 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358412800; Write bytes: 356075008; Read time: 27479; Write time: 976 04:38:13 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 692224; Write bytes: 296885248; Read time: 8; Write time: 1091 04:38:14 INFO - Running post-run listener: _upload_blobber_files 04:38:14 INFO - Blob upload gear active. 04:38:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:38: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 04:38: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'] 04:38: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 04:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:15 INFO - (blobuploader) - INFO - Done attempting. 04:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:38:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:16 INFO - (blobuploader) - INFO - Done attempting. 04:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:19 INFO - (blobuploader) - INFO - Done attempting. 04:38:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:38:19 INFO - Return code: 0 04:38:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:38:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:38:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d48a77769aae884901a77d8fe440bed2014279a35b91378ef7e96424dcfae938e95ee8cb262968dd5fe92a9de2af8471c3e70b0728ff27f78551ae8eefa9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ca76501c62b0c3f39e9b2967dda200c1ed691f299d2bc9a2189c0e0f9b3aa9b08a286a68f33aca8119b846f10b646499b811d6f3b990d817068e5e5f8dc12c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eadaf995aac40083abf80de15d1a20f9308d82df186cca208f9bc8bb863cd55f0fd3d57a4514ff79ab45e8d337c9ee8e6b0cba39fcbd7c30599408d274bd974"} 04:38:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:38:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:38:19 INFO - Contents: 04:38:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d48a77769aae884901a77d8fe440bed2014279a35b91378ef7e96424dcfae938e95ee8cb262968dd5fe92a9de2af8471c3e70b0728ff27f78551ae8eefa9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ca76501c62b0c3f39e9b2967dda200c1ed691f299d2bc9a2189c0e0f9b3aa9b08a286a68f33aca8119b846f10b646499b811d6f3b990d817068e5e5f8dc12c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eadaf995aac40083abf80de15d1a20f9308d82df186cca208f9bc8bb863cd55f0fd3d57a4514ff79ab45e8d337c9ee8e6b0cba39fcbd7c30599408d274bd974"} 04:38:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:38:19 INFO - Copying logs to upload dir... 04:38:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:38:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.743861 ========= master_lag: 1.68 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-24 04:38:20.806384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 04:38:20.809879) ========= 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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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/25d48a77769aae884901a77d8fe440bed2014279a35b91378ef7e96424dcfae938e95ee8cb262968dd5fe92a9de2af8471c3e70b0728ff27f78551ae8eefa9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ca76501c62b0c3f39e9b2967dda200c1ed691f299d2bc9a2189c0e0f9b3aa9b08a286a68f33aca8119b846f10b646499b811d6f3b990d817068e5e5f8dc12c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eadaf995aac40083abf80de15d1a20f9308d82df186cca208f9bc8bb863cd55f0fd3d57a4514ff79ab45e8d337c9ee8e6b0cba39fcbd7c30599408d274bd974"} build_url:https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011764 build_url: 'https://queue.taskcluster.net/v1/task/YEXpWL_OQheabw17a09UOQ/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/25d48a77769aae884901a77d8fe440bed2014279a35b91378ef7e96424dcfae938e95ee8cb262968dd5fe92a9de2af8471c3e70b0728ff27f78551ae8eefa9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ca76501c62b0c3f39e9b2967dda200c1ed691f299d2bc9a2189c0e0f9b3aa9b08a286a68f33aca8119b846f10b646499b811d6f3b990d817068e5e5f8dc12c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9eadaf995aac40083abf80de15d1a20f9308d82df186cca208f9bc8bb863cd55f0fd3d57a4514ff79ab45e8d337c9ee8e6b0cba39fcbd7c30599408d274bd974"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 04:38:20.946671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:38:20.946987) ========= 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.xyvjiU3cqO/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.pDzvNxf1iE/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005477 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:38:21.212365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 04:38:21.212683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 04:38:21.214618) ========= ========= Total master_lag: 2.13 =========