builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0099 starttime: 1479484987.26 results: success (0) buildid: 20161118040828 builduid: 1aa1d4ab7c794f94a737edcf8e37d62f revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.258333) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.258808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.259108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.284087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.284482) ========= 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.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-11-18 08:03:07-- 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% 237M=0s 2016-11-18 08:03:07 (237 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.398996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.399324) ========= 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.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.027242 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:07.447081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 08:03:07.447430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-11-18 08:03:07,553 truncating revision to first 12 chars 2016-11-18 08:03:07,554 Setting DEBUG logging. 2016-11-18 08:03:07,554 attempt 1/10 2016-11-18 08:03:07,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11b5acda902f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 08:03:08,727 unpacking tar archive at: mozilla-beta-11b5acda902f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.972016 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 08:03:09.443218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:09.443809) ========= script_repo_revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:09.444394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:09.444804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:09.464455) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-11-18 08:03:09.464973) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:09 INFO - MultiFileLogger online at 20161118 08:03:09 in /builds/slave/test 08:03:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:03:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:09 INFO - {'append_to_log': False, 08:03:09 INFO - 'base_work_dir': '/builds/slave/test', 08:03:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:03:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:09 INFO - 'branch': 'Mozilla-Beta', 08:03:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:09 INFO - 'config_files': ('talos/mac_config.py',), 08:03:09 INFO - 'default_actions': ('clobber', 08:03:09 INFO - 'read-buildbot-config', 08:03:09 INFO - 'download-and-extract', 08:03:09 INFO - 'populate-webroot', 08:03:09 INFO - 'create-virtualenv', 08:03:09 INFO - 'install', 08:03:09 INFO - 'run-tests'), 08:03:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:09 INFO - 'download_minidump_stackwalk': True, 08:03:09 INFO - 'download_symbols': 'ondemand', 08:03:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:09 INFO - 'installer_path': 'installer.exe', 08:03:09 INFO - 'log_level': 'info', 08:03:09 INFO - 'log_name': 'talos', 08:03:09 INFO - 'log_to_console': True, 08:03:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:03:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:03:09 INFO - 'opt_config_files': (), 08:03:09 INFO - 'pip_index': False, 08:03:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'run_cmd_checks_enabled': True, 08:03:09 INFO - 'sps_profile': False, 08:03:09 INFO - 'sps_profile_interval': 0, 08:03:09 INFO - 'suite': 'dromaeojs', 08:03:09 INFO - 'system_bits': '32', 08:03:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:09 INFO - 'title': 't-yosemite-r7-0099', 08:03:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:09 INFO - 'use_talos_json': True, 08:03:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:09 INFO - 'work_dir': 'build'} 08:03:09 INFO - [mozharness: 2016-11-18 16:03:09.676293Z] Running clobber step. 08:03:09 INFO - Running pre-action listener: _resource_record_pre_action 08:03:09 INFO - Running main action method: clobber 08:03:09 INFO - rmtree: /builds/slave/test/build 08:03:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:12 INFO - Running post-action listener: _resource_record_post_action 08:03:12 INFO - [mozharness: 2016-11-18 16:03:12.043262Z] Finished clobber step (success) 08:03:12 INFO - [mozharness: 2016-11-18 16:03:12.043400Z] Running read-buildbot-config step. 08:03:12 INFO - Running pre-action listener: _resource_record_pre_action 08:03:12 INFO - Running main action method: read_buildbot_config 08:03:12 INFO - Using buildbot properties: 08:03:12 INFO - { 08:03:12 INFO - "project": "", 08:03:12 INFO - "product": "firefox", 08:03:12 INFO - "script_repo_revision": "production", 08:03:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:03:12 INFO - "repository": "", 08:03:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:03:12 INFO - "buildid": "20161118040828", 08:03:12 INFO - "pgo_build": "False", 08:03:12 INFO - "basedir": "/builds/slave/test", 08:03:12 INFO - "buildnumber": 71, 08:03:12 INFO - "slavename": "t-yosemite-r7-0099", 08:03:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:03:12 INFO - "platform": "yosemite_r7", 08:03:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:03:12 INFO - "branch": "mozilla-beta", 08:03:12 INFO - "repo_path": "releases/mozilla-beta", 08:03:12 INFO - "revision": "11b5acda902f5ecb13ab2d451d36c7a9063f2b26", 08:03:12 INFO - "stage_platform": "macosx64", 08:03:12 INFO - "builduid": "1aa1d4ab7c794f94a737edcf8e37d62f", 08:03:12 INFO - "slavebuilddir": "test" 08:03:12 INFO - } 08:03:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:03:12 INFO - Running post-action listener: _resource_record_post_action 08:03:12 INFO - [mozharness: 2016-11-18 16:03:12.046809Z] Finished read-buildbot-config step (success) 08:03:12 INFO - [mozharness: 2016-11-18 16:03:12.046984Z] Running download-and-extract step. 08:03:12 INFO - Running pre-action listener: _resource_record_pre_action 08:03:12 INFO - Running main action method: download_and_extract 08:03:12 INFO - mkdir: /builds/slave/test/build/tests 08:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:12 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:03:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 08:03:13 INFO - Downloaded 1165 bytes. 08:03:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:03:13 INFO - Using the following test package requirements: 08:03:13 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:13 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:03:13 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:03:13 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:03:13 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:03:13 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:13 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:03:13 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:03:13 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:03:13 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:13 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:03:13 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:13 INFO - Expected file size: 16231139 08:03:20 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:03:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:21 INFO - Expected file size: 16231139 08:03:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:03:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:03:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:03:28 INFO - Expected file size: 14414089 08:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:29 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:29 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 08:03:31 INFO - Downloaded 86009518 bytes. 08:03:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:31 INFO - mkdir: /builds/slave/test/properties 08:03:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:31 INFO - Contents: 08:03:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:32 INFO - Running post-action listener: _resource_record_post_action 08:03:32 INFO - Running post-action listener: set_extra_try_arguments 08:03:32 INFO - [mozharness: 2016-11-18 16:03:32.143323Z] Finished download-and-extract step (success) 08:03:32 INFO - [mozharness: 2016-11-18 16:03:32.143425Z] Running populate-webroot step. 08:03:32 INFO - Running pre-action listener: _resource_record_pre_action 08:03:32 INFO - Running main action method: populate_webroot 08:03:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:32 INFO - '--tppagecycles', 08:03:32 INFO - '7'], 08:03:32 INFO - 'tests': ['tsvgm']}}, 08:03:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['damp', 'tps']}, 08:03:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'tests': ['damp', 'tps']}, 08:03:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['dromaeo_dom']}, 08:03:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['basic_compositor_video']}, 08:03:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tsvgx', 08:03:32 INFO - 'tsvgr_opacity', 08:03:32 INFO - 'tart', 08:03:32 INFO - 'tscrollx', 08:03:32 INFO - 'cart']}, 08:03:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:32 INFO - 'tsvgr_opacity', 08:03:32 INFO - 'tart', 08:03:32 INFO - 'tscrollx', 08:03:32 INFO - 'cart']}, 08:03:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tp5o']}, 08:03:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'tests': ['tp5o']}, 08:03:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s', 08:03:32 INFO - '--xperf_path', 08:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:32 INFO - 'tests': ['tp5n']}, 08:03:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:32 INFO - 'talos_options': ['--xperf_path', 08:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:32 INFO - 'tests': ['tp5n']}}, 08:03:32 INFO - 'talos.zip': {'path': '', 08:03:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:32 INFO - Running post-action listener: _resource_record_post_action 08:03:32 INFO - [mozharness: 2016-11-18 16:03:32.162366Z] Finished populate-webroot step (success) 08:03:32 INFO - [mozharness: 2016-11-18 16:03:32.162473Z] Running create-virtualenv step. 08:03:32 INFO - Running pre-action listener: _resource_record_pre_action 08:03:32 INFO - Running main action method: create_virtualenv 08:03:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03: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 08:03:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:32 INFO - Using real prefix '/tools/python27' 08:03:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:35 INFO - Installing pip.................done. 08:03:35 INFO - Return code: 0 08:03:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:35 INFO - 'HOME': '/Users/cltbld', 08:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:35 INFO - 'LOGNAME': 'cltbld', 08:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:35 INFO - 'MOZ_NO_REMOTE': '1', 08:03:35 INFO - 'NO_EM_RESTART': '1', 08:03:35 INFO - 'PAGER': '/bin/cat', 08:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:35 INFO - 'PWD': '/builds/slave/test', 08:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:35 INFO - 'SHELL': '/bin/bash', 08:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:35 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:35 INFO - 'USER': 'cltbld', 08:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:35 INFO - 'XPC_FLAGS': '0x0', 08:03:35 INFO - 'XPC_SERVICE_NAME': '0', 08:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03: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 08:03:36 INFO - Cleaning up... 08:03:36 INFO - Return code: 0 08:03:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03: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 08:03: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 08:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:36 INFO - 'HOME': '/Users/cltbld', 08:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:36 INFO - 'LOGNAME': 'cltbld', 08:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:36 INFO - 'MOZ_NO_REMOTE': '1', 08:03:36 INFO - 'NO_EM_RESTART': '1', 08:03:36 INFO - 'PAGER': '/bin/cat', 08:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:36 INFO - 'PWD': '/builds/slave/test', 08:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:36 INFO - 'SHELL': '/bin/bash', 08:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:36 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:36 INFO - 'USER': 'cltbld', 08:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:36 INFO - 'XPC_FLAGS': '0x0', 08:03:36 INFO - 'XPC_SERVICE_NAME': '0', 08:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:36 INFO - Downloading/unpacking psutil>=3.1.1 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:39 INFO - Installing collected packages: psutil 08:03:39 INFO - Running setup.py install for psutil 08:03:39 INFO - building 'psutil._psutil_osx' extension 08:03:39 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 INFO - building 'psutil._psutil_posix' extension 08:03:40 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 08:03:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:03:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:03:40 INFO - ^ 08:03:40 INFO - 1 warning generated. 08:03:40 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 08:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:40 INFO - Successfully installed psutil 08:03:40 INFO - Cleaning up... 08:03:40 INFO - Return code: 0 08:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:40 INFO - 'HOME': '/Users/cltbld', 08:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:40 INFO - 'LOGNAME': 'cltbld', 08:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:40 INFO - 'MOZ_NO_REMOTE': '1', 08:03:40 INFO - 'NO_EM_RESTART': '1', 08:03:40 INFO - 'PAGER': '/bin/cat', 08:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:40 INFO - 'PWD': '/builds/slave/test', 08:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:40 INFO - 'SHELL': '/bin/bash', 08:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:40 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:40 INFO - 'USER': 'cltbld', 08:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:40 INFO - 'XPC_FLAGS': '0x0', 08:03:40 INFO - 'XPC_SERVICE_NAME': '0', 08:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:43 INFO - Installing collected packages: mozsystemmonitor 08:03:43 INFO - Running setup.py install for mozsystemmonitor 08:03:43 INFO - Successfully installed mozsystemmonitor 08:03:43 INFO - Cleaning up... 08:03:43 INFO - Return code: 0 08:03:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:43 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 08:03:43 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 08:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:43 INFO - 'HOME': '/Users/cltbld', 08:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:43 INFO - 'LOGNAME': 'cltbld', 08:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:43 INFO - 'MOZ_NO_REMOTE': '1', 08:03:43 INFO - 'NO_EM_RESTART': '1', 08:03:43 INFO - 'PAGER': '/bin/cat', 08:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:43 INFO - 'PWD': '/builds/slave/test', 08:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:43 INFO - 'SHELL': '/bin/bash', 08:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:43 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:43 INFO - 'USER': 'cltbld', 08:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:43 INFO - 'XPC_FLAGS': '0x0', 08:03:43 INFO - 'XPC_SERVICE_NAME': '0', 08:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:47 INFO - warning: no files found matching '*.txt' 08:03:47 INFO - no previously-included directories found matching 'build' 08:03:47 INFO - no previously-included directories found matching 'dist' 08:03:47 INFO - no previously-included directories found matching '.git*' 08:03:47 INFO - Installing collected packages: jsonschema, functools32 08:03:47 INFO - Running setup.py install for functools32 08:03:47 INFO - warning: no files found matching '*.txt' 08:03:47 INFO - no previously-included directories found matching 'build' 08:03:47 INFO - no previously-included directories found matching 'dist' 08:03:47 INFO - no previously-included directories found matching '.git*' 08:03:47 INFO - Successfully installed jsonschema functools32 08:03:47 INFO - Cleaning up... 08:03:47 INFO - Return code: 0 08:03:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:47 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 08:03:47 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 08:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:47 INFO - 'HOME': '/Users/cltbld', 08:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:47 INFO - 'LOGNAME': 'cltbld', 08:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:47 INFO - 'MOZ_NO_REMOTE': '1', 08:03:47 INFO - 'NO_EM_RESTART': '1', 08:03:47 INFO - 'PAGER': '/bin/cat', 08:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:47 INFO - 'PWD': '/builds/slave/test', 08:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:47 INFO - 'SHELL': '/bin/bash', 08:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:47 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:47 INFO - 'USER': 'cltbld', 08:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:47 INFO - 'XPC_FLAGS': '0x0', 08:03:47 INFO - 'XPC_SERVICE_NAME': '0', 08:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:47 INFO - Cleaning up... 08:03:47 INFO - Return code: 0 08:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:47 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:47 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 08:03:47 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 08:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:47 INFO - 'HOME': '/Users/cltbld', 08:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:47 INFO - 'LOGNAME': 'cltbld', 08:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:47 INFO - 'MOZ_NO_REMOTE': '1', 08:03:47 INFO - 'NO_EM_RESTART': '1', 08:03:47 INFO - 'PAGER': '/bin/cat', 08:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:47 INFO - 'PWD': '/builds/slave/test', 08:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:47 INFO - 'SHELL': '/bin/bash', 08:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:47 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:47 INFO - 'USER': 'cltbld', 08:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:47 INFO - 'XPC_FLAGS': '0x0', 08:03:47 INFO - 'XPC_SERVICE_NAME': '0', 08:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:51 INFO - Downloading docopt-0.6.1.tar.gz 08:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:51 INFO - Running setup.py install for blobuploader 08:03:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:51 INFO - Running setup.py install for requests 08:03:52 INFO - Running setup.py install for docopt 08:03:52 INFO - Successfully installed blobuploader requests docopt 08:03:52 INFO - Cleaning up... 08:03:52 INFO - Return code: 0 08:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:52 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 08:03:52 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 08:03:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:52 INFO - 'HOME': '/Users/cltbld', 08:03:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:52 INFO - 'LOGNAME': 'cltbld', 08:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:52 INFO - 'MOZ_NO_REMOTE': '1', 08:03:52 INFO - 'NO_EM_RESTART': '1', 08:03:52 INFO - 'PAGER': '/bin/cat', 08:03:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:52 INFO - 'PWD': '/builds/slave/test', 08:03:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:52 INFO - 'SHELL': '/bin/bash', 08:03:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:52 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:52 INFO - 'USER': 'cltbld', 08:03:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:52 INFO - 'XPC_FLAGS': '0x0', 08:03:52 INFO - 'XPC_SERVICE_NAME': '0', 08:03:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:52 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-NpbynZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-AR4MPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-YuvOG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-M3niqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Nlx2kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-nNkoXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-wNJeE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ItpOzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-egqDKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Q6sipg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:53 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-rSdiLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-X95FBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-svMiQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-fd6a8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-1CMkOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-v0Th0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:54 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-xgzDYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:54 INFO - Running setup.py install for manifestparser 08:03:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:54 INFO - Running setup.py install for mozcrash 08:03:54 INFO - Running setup.py install for mozdebug 08:03:55 INFO - Running setup.py install for mozdevice 08:03:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozfile 08:03:55 INFO - Running setup.py install for mozhttpd 08:03:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozinfo 08:03:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozInstall 08:03:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:55 INFO - Running setup.py install for mozleak 08:03:55 INFO - Running setup.py install for mozlog 08:03:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for moznetwork 08:03:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozprocess 08:03:56 INFO - Running setup.py install for mozprofile 08:03:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozrunner 08:03:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozscreenshot 08:03:56 INFO - Running setup.py install for moztest 08:03:57 INFO - Running setup.py install for mozversion 08:03:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:57 INFO - Cleaning up... 08:03:57 INFO - Return code: 0 08:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:57 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:03:57 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 08:03:57 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 08:03:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:03:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:57 INFO - 'HOME': '/Users/cltbld', 08:03:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:57 INFO - 'LOGNAME': 'cltbld', 08:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:57 INFO - 'MOZ_NO_REMOTE': '1', 08:03:57 INFO - 'NO_EM_RESTART': '1', 08:03:57 INFO - 'PAGER': '/bin/cat', 08:03:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:57 INFO - 'PWD': '/builds/slave/test', 08:03:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:57 INFO - 'SHELL': '/bin/bash', 08:03:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:03:57 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:03:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:57 INFO - 'USER': 'cltbld', 08:03:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:57 INFO - 'XPC_FLAGS': '0x0', 08:03:57 INFO - 'XPC_SERVICE_NAME': '0', 08:03:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-jwUDIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 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)) 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-RzhONn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 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)) 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-080Wrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 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)) 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:57 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-UqaDQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-zGLDNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-c7QE1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-zE8V9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-_j_mpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-gw0TYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-tB8aAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Oz23pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-dqC8mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-SWyx_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 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)) 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:58 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-0WIZFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:59 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)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Y1MxHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:59 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)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-9EDmNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:59 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)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-GpEP9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:59 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)) 08:03:59 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)) 08:03:59 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)) 08:03:59 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)) 08:03:59 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)) 08:03:59 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)) 08:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:04:01 INFO - Downloading blessings-1.6.tar.gz 08:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:02 INFO - Installing collected packages: blessings 08:04:02 INFO - Running setup.py install for blessings 08:04:02 INFO - Successfully installed blessings 08:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:02 INFO - Reading from file tmpfile_stdout 08:04:02 INFO - Current package versions: 08:04:02 INFO - blessings == 1.6 08:04:02 INFO - blobuploader == 1.2.4 08:04:02 INFO - docopt == 0.6.1 08:04:02 INFO - functools32 == 3.2.3-2 08:04:02 INFO - jsonschema == 2.5.1 08:04:02 INFO - manifestparser == 1.1 08:04:02 INFO - mozInstall == 1.12 08:04:02 INFO - mozcrash == 0.17 08:04:02 INFO - mozdebug == 0.1 08:04:02 INFO - mozdevice == 0.48 08:04:02 INFO - mozfile == 1.2 08:04:02 INFO - mozhttpd == 0.7 08:04:02 INFO - mozinfo == 0.9 08:04:02 INFO - mozleak == 0.1 08:04:02 INFO - mozlog == 3.4 08:04:02 INFO - moznetwork == 0.27 08:04:02 INFO - mozprocess == 0.23 08:04:02 INFO - mozprofile == 0.28 08:04:02 INFO - mozrunner == 6.12 08:04:02 INFO - mozscreenshot == 0.1 08:04:02 INFO - mozsystemmonitor == 0.3 08:04:02 INFO - moztest == 0.7 08:04:02 INFO - mozversion == 1.4 08:04:02 INFO - psutil == 3.1.1 08:04:02 INFO - requests == 1.2.3 08:04:02 INFO - wsgiref == 0.1.2 08:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:02 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')]} 08:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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')]} 08:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:04:02 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 08:04:02 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 08:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:02 INFO - 'HOME': '/Users/cltbld', 08:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:02 INFO - 'LOGNAME': 'cltbld', 08:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:02 INFO - 'MOZ_NO_REMOTE': '1', 08:04:02 INFO - 'NO_EM_RESTART': '1', 08:04:02 INFO - 'PAGER': '/bin/cat', 08:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:02 INFO - 'PWD': '/builds/slave/test', 08:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:02 INFO - 'SHELL': '/bin/bash', 08:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:04:02 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:02 INFO - 'USER': 'cltbld', 08:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:02 INFO - 'XPC_FLAGS': '0x0', 08:04:02 INFO - 'XPC_SERVICE_NAME': '0', 08:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 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)) 08:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04:02 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')]} 08:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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')]} 08:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:02 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 0x102c18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6e2dcddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, '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.FY7F7pg2F8/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.wb9nOURkGt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 08:04:02 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 08:04:02 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 08:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:02 INFO - 'HOME': '/Users/cltbld', 08:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:02 INFO - 'LOGNAME': 'cltbld', 08:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:02 INFO - 'MOZ_NO_REMOTE': '1', 08:04:02 INFO - 'NO_EM_RESTART': '1', 08:04:02 INFO - 'PAGER': '/bin/cat', 08:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:02 INFO - 'PWD': '/builds/slave/test', 08:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:02 INFO - 'SHELL': '/bin/bash', 08:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:04:02 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:02 INFO - 'USER': 'cltbld', 08:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:02 INFO - 'XPC_FLAGS': '0x0', 08:04:02 INFO - 'XPC_SERVICE_NAME': '0', 08:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:03 INFO - Cleaning up... 08:04:03 INFO - Return code: 0 08:04:03 INFO - Running post-action listener: _resource_record_post_action 08:04:03 INFO - Running post-action listener: _start_resource_monitoring 08:04:03 INFO - Starting resource monitoring. 08:04:03 INFO - [mozharness: 2016-11-18 16:04:03.153370Z] Finished create-virtualenv step (success) 08:04:03 INFO - [mozharness: 2016-11-18 16:04:03.154349Z] Running install step. 08:04:03 INFO - Running pre-action listener: _resource_record_pre_action 08:04:03 INFO - Running main action method: install 08:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:03 INFO - Reading from file tmpfile_stdout 08:04:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:03 INFO - Reading from file tmpfile_stdout 08:04:03 INFO - Output received: 08:04:03 INFO - Usage: mozinstall [options] installer 08:04:03 INFO - Options: 08:04:03 INFO - -h, --help show this help message and exit 08:04:03 INFO - -d DEST, --destination=DEST 08:04:03 INFO - Directory to install application into. [default: 08:04:03 INFO - "/builds/slave/test"] 08:04:03 INFO - --app=APP Application being installed. [default: firefox] 08:04:03 INFO - mkdir: /builds/slave/test/build/application 08:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:04:25 INFO - Reading from file tmpfile_stdout 08:04:25 INFO - Output received: 08:04:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:04:25 INFO - Running post-action listener: _resource_record_post_action 08:04:25 INFO - [mozharness: 2016-11-18 16:04:25.188186Z] Finished install step (success) 08:04:25 INFO - [mozharness: 2016-11-18 16:04:25.188306Z] Running run-tests step. 08:04:25 INFO - Running pre-action listener: _resource_record_pre_action 08:04:25 INFO - Running main action method: run_tests 08:04:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:04:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:04:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:04:25 INFO - 2016-11-18 08:04:25.200 screenresolution[1626:7410] starting screenresolution argv=screenresolution get 08:04:25 INFO - 2016-11-18 08:04:25.202 screenresolution[1626:7410] Display 0: 1600x1200x32@60 08:04:25 INFO - 2016-11-18 08:04:25.207 screenresolution[1627:7413] starting screenresolution argv=screenresolution list 08:04:25 INFO - Available Modes on Display 0 08:04:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:04:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:04:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:04:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:04:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:04:25 INFO - Intel Iris: 08:04:25 INFO - Chipset Model: Intel Iris 08:04:25 INFO - Type: GPU 08:04:25 INFO - Bus: Built-In 08:04:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:04:25 INFO - Vendor: Intel (0x8086) 08:04:25 INFO - Device ID: 0x0a2e 08:04:25 INFO - Revision ID: 0x0009 08:04:25 INFO - Displays: 08:04:25 INFO - Display: 08:04:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:04:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:04:25 INFO - Display Serial Number: 1600x1200 60 08:04:25 INFO - Main Display: Yes 08:04:25 INFO - Mirror: Off 08:04:25 INFO - Online: Yes 08:04:25 INFO - Rotation: Supported 08:04:25 INFO - Return code: 0 08:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:25 INFO - Python 2.7.3 08:04:25 INFO - Return code: 0 08:04:25 INFO - grabbing minidump binary from tooltool 08:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:25 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 0x102a2cd30>, '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 0x102892db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a24b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:25 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 08:04:25 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 08:04:25 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 08:04:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:25 INFO - Return code: 0 08:04:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:04:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:04:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 08:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 08:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FY7F7pg2F8/Render', 08:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:25 INFO - 'HOME': '/Users/cltbld', 08:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:25 INFO - 'LOGNAME': 'cltbld', 08:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:25 INFO - 'MOZ_NO_REMOTE': '1', 08:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'NO_EM_RESTART': '1', 08:04:25 INFO - 'PAGER': '/bin/cat', 08:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:25 INFO - 'PWD': '/builds/slave/test', 08:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:25 INFO - 'SHELL': '/bin/bash', 08:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wb9nOURkGt/Listeners', 08:04:25 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 08:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:25 INFO - 'USER': 'cltbld', 08:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:25 INFO - 'XPC_FLAGS': '0x0', 08:04:25 INFO - 'XPC_SERVICE_NAME': '0', 08:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 08:04:25 INFO - mozversion application_buildid: 20161118040828 08:04:25 INFO - mozversion application_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:04:25 INFO - mozversion application_display_name: Firefox 08:04:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:25 INFO - mozversion application_name: Firefox 08:04:25 INFO - mozversion application_remotingname: firefox 08:04:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:25 INFO - mozversion application_vendor: Mozilla 08:04:25 INFO - mozversion application_version: 51.0 08:04:25 INFO - mozversion platform_buildid: 20161118040828 08:04:25 INFO - mozversion platform_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:04:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:25 INFO - mozversion platform_version: 51.0 08:04:25 INFO - using testdate: 1479485065 08:04:25 INFO - actual date: 1479485065 08:04:25 INFO - starting webserver on 'localhost:49240' 08:04:25 INFO - SUITE-START | Running 2 tests 08:04:25 INFO - TEST-START | dromaeo_css 08:04:25 INFO - operating with platform_type : mac_ 08:04:25 INFO - Initialising browser for dromaeo_css test... 08:04:25 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpibNSDE/profile http://localhost:49240/getInfo.html) 08:04:28 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 08:04:28 INFO - PROCESS | 1637 | colorDepth:24 08:04:28 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 08:04:28 INFO - PROCESS | 1637 | __metrics 08:04:28 INFO - PROCESS | 1637 | 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" 08:04:28 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:28 INFO - TEST-INFO | 1637: exit 0 08:04:28 INFO - Browser initialized. 08:04:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:28 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpibNSDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:40 INFO - PROCESS | 1640 | RSS: Main: 168112128 08:04:40 INFO - PROCESS | 1640 | 08:05:32 INFO - PROCESS | 1640 | 1479485132517 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] 08:07:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:07:44 INFO - PROCESS | 1640 | RSS: Main: 273481728 08:07:44 INFO - PROCESS | 1640 | 08:10:47 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:10:47 INFO - PROCESS | 1640 | RSS: Main: 299483136 08:10:47 INFO - PROCESS | 1640 | 08:13:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:13:50 INFO - PROCESS | 1640 | RSS: Main: 278708224 08:13:50 INFO - PROCESS | 1640 | 08:16:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:16:53 INFO - PROCESS | 1640 | RSS: Main: 287166464 08:16:53 INFO - PROCESS | 1640 | 08:19:56 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:19:56 INFO - PROCESS | 1640 | RSS: Main: 261345280 08:19:56 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:22:59 INFO - PROCESS | 1640 | RSS: Main: 331902976 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | __start_tp_report 08:22:59 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 08:22:59 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 08:22:59 INFO - PROCESS | 1640 | |i|pagename|runs| 08:22:59 INFO - PROCESS | 1640 | |0;dojo.html;3502.2995400919813;3504.246586983798;3528.9294214115735;3532.841022154001;3586.246888153488;4746.288056791483;5850.093235548491;5856.414358564152;5886.705664716763;5925.1112333149995;5864.824055278338;5920.407959204077;5924.644521328723;5937.168796368512;5958.970205148979;5241.580673546107;5251.789928402859;5318.388385335678;5326.467353264681;5329.706866122362;4452;5239.73801309933;5254.8686282842855;5257.080010998079;5359.08895487766;4059.472268605092;5276.657017293883;5303.602229832759;5305.469453054702;5319.813806516772;5290.947090529103;5314.73426328682;5324.92012619811;5373.113436283009;5381.838544843661;5226.346706661668;5293.258943747878;5303.337082864642;5306.814261500867;5334;5679.432056794329;5739.139129130622;5743.282089738783;5790.13148027795;5799.21710569072;6224.408681175281;6286.937130628681;6289;6301.495880329563;6310.905336419957;6200.751969921198;6243.687815609202;6253.843653908643;6271.310155882849;6272.65500397478;5780.88438231233;5823.94176058234;5847.707614619252;5906.26171728534;5964.284285885678;6258.249010118815;6278.811635650938;6310.116583678288;6313.179286692793;6329.620222786648;6247.312795592481;6251.718672659741;6256.593321434092;6265.749370025148;6273.404026617464;6214.285357183981;6218.782342617987;6268.749250030039;6294.8426289342215;6303.779367722108;6306.747730090745;6313.210848643919;6319.6208227506495;6337.207849018872;6347.873042539123;6219;6277.780277690259;6312.463440607508;6313.96843015782;6324.3043265240785;4929.285253638202;4989.201727723546;5061.5950723942;5084.161113416319;5090.363704536933;3936.3308237599676;4543.568361005699;4581.152486789954;4607.746573938465;4619.514950930171;5965.642061476326;5969.462748352582;5969.701514924323;5971;5974.864775692605;6170.321264660884;6244.906326405107;6249.25008998923;6256.937430625636;6268;5782.392848750905;5866.70666466675;5953.493953013955;5967.254093238345;6034.306054803666;5514.172874068921;5542.75057622408;5545.667259964415;5563.109902415594;5578.44215578447;6385;6390.201224846801;6391.616503009835;6409.391107844747;6420.06908998202;6180.196574445294;6221.595596286227;6255.96872015637;6271.937280627135;6285.308616052139;6414.390632889868;6422.293547709842;6423.197100362455;6424.421802037839;6437.452816510649;6264.59280146789;6302.779402720883;6312.526560508072;6347.682615869096;6350.650714210763;6105.511559075352;6210.378962103753;6213.068039794067;6281.52888533371;6301.369863013845;6194.163787888758;6239.438450539473;6253;6268.717907694074;6288.371162883675;6239.376062393724;6250.781222657185;6259.718312676032;6270.372962703693;6296.464800492009;6010.549208809444;6061.605995610271;6069.089636554552;6108.267007959073;6134.294556126102;6209.844753881189;6233.657148856675;6289.654069026247;6307.810765677037;6311.2426508819235;5046.924296135634;6111.480524155319;6124.785632502841;6128.662923539248;6150.261968563801 08:22:59 INFO - PROCESS | 1640 | |1;ext.html;518.5229588778324;531.415443012686;542.8181559177675;553.6041730162933;564.1875698993447;33021.504677429824;42502;43634.56365436345;43818.780906095504;45756.85607859797;44934;45167;45687.31469027967;45730.77134614322;45764.77117614415;10022.949885250582;10225.977402259752;10227.079562839343;10236.078752912237;10259.974002599754;9391;9623;10351.534180961837;10957.520734700833;12427.440765165544;12526.874731252707;12587.685307867285;12595;12615.243085414904;12616.873831261662;12395.38023098846;12474.251544907243;12488.12583119182;12510.124291299613;12512.81230781539;12325;12429.37853107341;12440.377981100999;12441.564545240873;12444.626661200178;42645.786771066254;42971;42983;42994.355084673756;43095.784521077505;3428.879989200366;3435.158386195398;3558.3061303045915;3562.2163124112653;3687.059799751073;31738.841305793554;32397.352052959046;32673.50989735156;32919;33032.6696733032;3233.110894504007;3326.6340702522944;3407.454807230831;3422.178677117499;3425.53755243044;557597;561221;561255;561525.9999999959;562440.1877990625;67416;67869.32130678729;68034.29914252184;68054;68172;36164.819175903955;36921.63078369236;36931.4460283096;37762.244755104744;37822.810885945946;18403.72394414085;18560.721589176173;18619.348322808906;18639.440816775248;18647.160877760263;12797.488100476063;13061.738765224833;14108;14180.858191417954;14211.573652790434;20169;20534.973251337375;20799.96000199984;21016.159353625684;21081.683774743393;8200.630971606291;8212.301954333949;8248.298894593907;8299.29455996235;8309.8338033239;910.6539514984264;953.4994128082812;1013.4983183324155;1032.7160030991388;1070.4112737994071;31929.52105718416;32080;32171.839140804615;32302.67697323044;32428.02715918526;944.9669261575949;1078.8759292681443;1100.862392200975;1113.4321496036916;1115.043099360617;15758.369665213493;16267.593310167103;16315.755263671055;16361.509154725378;16704.6659066818;562351;568775;569310;569365;570690;59267;59925.40074599198;60032.39967600355;60070;60196;1229.6065259117177;1299.4022749535131;1338.772408690525;1429.89275804313;1463.2098666720065;31494.52758208583;33326.66673333236;33370.666293336755;33398;33822.323553529284;53604.73197633987;54258;54340.45659543354;54468;54528;536647.3167634137;539010;541399;842009;863255;27850.860745696144;28557.000504982225;28561.857190713912;29228.707712922598;29240.976565820096;50311;50626;50847.491525084275;50933.490665092875;51400;40578.9855253621;40951.7952410236;41621.79189104035;42346.78826605847;43682;41074.794626026676;41377.96555086147;41993.369311508264;42094.57905420907;42512.57487425086;41084.79457602693;41122.38316425316;41823.79088104662;42079.158416832106;42159.73520794381;32383.676163238066;32417;36356.72751453686;36727.26545469129;37150.628493714714;26765.598516022666;27169.59245611278;27223.863880681263;27345.72654273432;27783.583246250917 08:22:59 INFO - PROCESS | 1640 | |2;jquery.html;377.0799249830414;381.1082067960971;389.2463435534704;391.5653624476831;412.47821505795173;20203.191872325107;20316.492087697778;21414.785852141475;21559.46101347465;21563.460913477153;20284.958945322087;21137.26019589315;21154.25960091397;21395.893020534877;21547.892260538676;5834.124881267812;6039.1545183674325;6087;6089;6093.6039157454625;5725.742341594618;5946.375630558772;5979.730912108944;6097.878042439171;6104.786332478364;5934.940650593504;5943.732532036069;5945.959457094991;5951.6429014259065;5954.047352423613;5825.88348233033;5926.703664816763;5937.2578427696535;6108.877822443571;6175.135481032659;6037.396260373971;6052.394760523956;6056.697165141725;6060.212172417558;6061.242344706911;22279;23763.76236237633;24670;25455.236342909742;25690.972361105534;2224.9332520024427;2327.1273272522803;2337.836351455399;2401.7478164792797;2420.1287536486852;10287.639932602398;10353.482325883675;12497.625071247787;15120.563546463069;15690.058596484247;1956.2664000999625;1990.8506861985409;2019.8993047230863;2050.641137800879;2058.2487392101775;122853;126718;127547;133384;137468;11269.38018408979;11537.48081336342;11615.535378584931;11619.419029048513;11845.703857403461;14690.045147065406;14699.779503307458;14707.779383309258;14730.484433045007;14733.26333683333;8620.224179823846;8717.694880679146;8851.734447966572;8942.150495702897;8946.776330591658;8678.175573320525;8809.295256379473;8972.282217422591;8996.100389960951;9200.539973001323;3611.4582812578324;4390.253656878338;4531;4543.931841022388;4608.078384323148;1933.236371633197;1967.2917749610128;1969.2516843599626;1979.2973494409277;1983.454549998733;879.7140929198036;960;970.631160159135;988.604558176735;1015.5937624950079;19316.903415482833;20809.791902080786;20818.89590552068;21202.958830415;21225.15099396038;845.9341230050059;953.6090203016869;1000.2098342309494;1002.0630710285906;1059;9882.209423246122;10254.948725256327;10583.682489525327;11042.723931901606;11063.225574209728;606613;619128;632499;644913;646879;135457;138301.6169838309;139071;139914;146511;981.6220755009373;989.8020395920845;999.9850002249972;1003.3327836988321;1019.3527110285022;17632.73550896763;18324.90837545804;18484.81515184831;18492.907535462236;18493.630127397646;37148;50314.748426259095;50596.747016264686;55949.72025139848;57268.42731572631;71539;78058.2194178051;78710;80217.1978280233;80945;4882.7558622068045;7387.1135463744695;7649.502782319131;7908.802279943047;8160.83678326442;12141.510990247154;12972.286524241257;13063.954883609098;13074.084814063304;13344.332783360987;11160.441977901235;11220.326780392876;11301.660950171508;11465.4267286637;11616.709582260512;11069.612563560237;11135;11160.832587511031;11222.55109795599;11551.133664974992;11332.886671133183;11444.198906076495;11737.061035117;11761.941190293994;11860.110491713329;7739.187385324685;7920.960395197987;7948.16544262844;8282.4202305838;8282.875756863532;8226.136255693305;10087.394756314645;11184.888151118384;11356.54573817038;11567.363794991355 08:22:59 INFO - PROCESS | 1640 | |3;mootools.html;1420.3963315590884;1454.4909281751388;1598.8880778345513;1821.317006122704;1980.0792631426384;8340.83318333633;8864.822703545926;9041.457512549243;9393.577289021994;9400.764980875481;9228.953855230715;9325.766855828608;9338.579763910624;9345.67290144845;9358.110979456958;2454.975450245497;2484.8881800319027;2488.315713178881;2488.776010159085;2489.215896992451;2411.4212588978694;2476.5418397596413;2477.677901872754;2479.0207867892173;2480.293116461809;2430.2101816909485;2448.8163387745903;2473.3445636906145;2475.4553998120386;2476.578981573137;2410.9517809643885;2436.062116085311;2444.4133407982135;2448.5714999875127;2452.1294940296293;2408.0247499762622;2437.427204606916;2439.4511234972165;2441.5727247731575;2453.1659235859893;9272.675456358995;9317.16145546904;9385.38994965325;9414.858777118348;9415.764605884839;5471.179323101527;5680.488756011938;5694.4590263924865;5741.081426971707;5747.48272655463;3772.5661548921676;3774.9056273593105;3806.143617686026;3851.595582463829;3858.614138586147;1122.820348744197;1123.8988491035846;1124.3984468309416;1139.2594813371375;1146.5757669662196;12425.93787031059;12454.875451245462;12528.874711252953;12540.372981350987;12553.999999999909;4560.908781824345;4680.742559159211;4810.374651295379;4810.975945120322;4836.202026665631;9710.465924374086;9723.513824308757;9724.659636912675;9725.221982241404;9728.610855565697;4756.357891684647;5502;5516.503514683698;5525.336959564878;5525.640833345819;4109.219248342805;4610.700304480198;4776.23580227162;5114.923276150861;5196.298499702491;3991.2416640838146;4039.2527382434346;4051.068254301468;4080.0207950091763;4110.897227569335;1195.6114262864603;1210.90918181135;1211.5941159711595;1223.082687984012;1223.6757259326287;926.3654396738121;959.318883592643;967.4678926590348;967.9080487353831;1010.0051449322411;6000.639961602318;6059;6066.817995460143;6107.786227482017;6133.478654314434;441.0693436848248;449.7369039112091;454.14620513434534;455.1920341393986;457.6819110718019;3855.5566109897723;3925.7840818755244;4072.75563466193;4082.081531655354;4178.979105104455;11030.338179709242;11553.30680159193;11558.248713833575;11570.94214528922;11594.536218551331;11421.942890285496;11459.369734664508;11500.25248358854;11502.13733969939;11532;8279.917200827915;8642.395032347675;8661.696840610675;8731.60707768152;8766.824663506693;5379.838604841861;6225.844353891189;6233.719482623384;6237.095621135;6356.7775127872155;10515.421651809223;10658.467076645982;10673.46632668379;10677.89322106769;10698.03717665414;8603.354748393771;10264.743381415525;10795.56817727282;10974.451277435937;10979.231453798158;7912.525248485109;8090.0696419912465;8105.75682729519;8108.878366824384;8116.026076870813;8602.956985215034;8643.654253829776;8725.650973961225;8730.825383492167;8814.162654547808;7535.171131175457;7556.471047026876;7570.659320330708;7587.962060189664;7666.501677390952;7415.2214017527385;7419.9258007421395;7436.479446438913;7460.850782984418;7660;7357.411407087528;7358.77923662291;7359.705611775469;7449.292317229854;7454.44091693136;5178.508041736029;5207.973960130326;5224.895502090013;5229.555487783581;5257.710825904612;5115;5149.201873709581;5202.765875535534;5422.430644782241;5480.205370221375 08:22:59 INFO - PROCESS | 1640 | |4;prototype.html;301.2964727361611;302.5673287199304;309.6098915366638;313.4514599450961;315.2214031342586;4443.911121777563;5228.712420816853;5381.327334083239;5413.242146099545;5471.398146203915;4919.606431485481;5097.374851951248;5145.768440420181;5330.92003619946;5406.296851574213;4101.4668093148;4107.412330231949;4124.360724087771;4144.8756537303925;4151.688623353246;3937.448757173998;4152.650388623694;4154.854580089697;4155.729877557964;4167.249895018896;3203.567518385023;4084.5711200323985;4105;4137.875863724078;4138.8137533810905;3582.7671201371827;4083.7549747015273;4088.632023117919;4112.897177570555;4125.195586860564;3079.0916679579577;3153.8265395403246;3531.958072368657;3615.1801594756134;3625.29306785177;4330.834582708646;5066.847994560169;5194.6883187008525;5293.894122117575;5327.922110376918;4699.812007519729;4726.905461890743;4745.193317136095;4754;4758.547937945889;5014.874628134326;5581.469760372758;5589.413111623262;5661.46216109469;5681.9601513190655;3355.808687915779;3756.812159392047;3978.527944660494;3998.140399814025;4011.4183443400543;5098.388193416814;5881.823635272963;5920.703964801785;5964.284285885678;5968.552358573124;3591.6587924147166;4085.428040074392;4089.2230476209425;4104.240715467648;4104.8152833122585;3965.464662270614;4095.0990782027907;4133.545310015896;4144.48193975753;4151.232022075926;4343.84888004679;4630.976845115752;4697.684648298482;4714.147940496019;4720.811167553259;5624.746886390122;5722.942770572241;5737.913931291034;5745.88508229833;5764.913526297109;1170.8887655672868;1257.9685507862378;1294.8899343555904;1379.537854818627;1398.3847107272768;711.9038929744522;853.8420392227458;855.7689423855525;863.218786997768;864.9783755406165;4221.78891055446;4429.446319210098;4603.930941035887;4631.374764406829;4635.397398338195;4276.764777937181;4551.499335073139;4924.581410580069;4955.515258690891;4993.550580447777;4185.351270553069;4226.964393723558;4285.500224764048;4485.161083955562;4525.637948964075;2307.5961706701596;2400.351904985644;2495.6506089147533;2518.0683147235272;2532.556802559545;4306.827726890952;4408.647308215335;4522.547745225451;4766.594839438687;5087.338645976073;4402.933955990663;4582.427196600425;4901.926471102936;5034.521720436553;5040.697558146449;5048.081728942978;5086.92369614456;5461.699606521679;5513.952349053667;6224.253089629274;4876.122297986255;5410.918836217538;5653.321601407857;5705.343885453226;5994.88010239784;4613.7923793430045;4699.741514216614;5546.918350921693;5553.305836770403;5865.882682346414;4955.281484184701;5451.918221226764;6042.395760423922;6126.448619624255;6140.986737188493;3339.7328213743326;3914.805984174854;3993.4608827807874;4044.373122166069;4061.1877624474632;5671.943280567141;5896.587238893237;5997.880042399041;5998.59033127206;6011.72947217385;5281.841544753664;5381.946180538144;5517.606671896835;5793.971030144822;5816.738246778989;5266.447023062523;5334.3865455473115;5764.866999210319;5813.912791308218;5856.652969817052;4957.553820156059;5357.437469065692;5508.81560464502;5679.290088738908;5722.456366645162;5050.368703912011;5084.771185296597;5615.943840561706;5844.444777746107;5851.678157701197;5355.27329474749;5727.6849773262875;5734.455226753452;5762.6830524319885;5779.075347944308 08:22:59 INFO - PROCESS | 1640 | |5;yui.html;742.5062333548191;771.1825465007092;790.8457850719105;813.2274339377591;851.9872201916972;15811.762823557641;16264;16993.405230816923;17053.573660658476;17093.57266068349;15007.549773506813;15393.69212615747;15411;15412.614684632861;15441.150736709476;715.899774031636;738.1584993107862;865.5672163918041;884.8628462588277;887.2946007923716;895.9820803583924;910.2490445382552;920.8020275640736;921.3274309753883;922.8062106957514;818.1859050245015;957.3681370295607;959.9568019439107;960.7454024683465;964.5466630683568;954.9856752148723;955.4171955107379;955.8088382323563;955.8757361543024;956.039180623469;705.3898377903129;705.5942832871119;706.20199174932;708.0759608710631;708.4332533972853;15588;15651.060936343856;15656.21718914061;15664.21678916061;15690.607734806721;13985.650358741012;14792.704145917129;14937.551873443814;15029.624259393493;15130.470433534883;13539.932300338534;13662.521811736542;13743.106698064594;13749.450021999108;13834.446622135103;4709.1288111699105;4711.929321060187;4767.381076842669;4868.123737727207;4957.405111386621;123448;130424;130530.3473482636;130719;133076.33461832727;10996.28524145928;11101.555937762561;11182.384968826793;11277.830832537518;11375.943120284346;21032.369028929155;21284.574308514053;21298.25456109029;21370.679439808417;21394.144234230767;7888.566128862968;8010.799730006796;8130.918690813134;8156.0620528639965;8160.714374996846;4548.363229147922;4563.498015218323;4600.125976064537;4625.468071171791;4699.4360676718325;3732.234891847165;3808.352580061396;3902.453656488094;3903.590123037097;3911.9217615647526;698.6192525073847;718;726.1105146195868;731.5318196354337;731.802413348393;553.6650326552458;575.8877018981342;633.0596721049967;706.7950294414665;710.6588837358097;8743.825123497494;8745.518996455128;9404.200642945427;9584.424934503813;10008.3494572854;661.609650306312;672.5930811858852;699.8460338725472;701.6596950479013;717.6232477949119;4801.759912004386;4824.059308434892;4905.452323831404;4950.455449900508;4980.775865086008;163428;168197;169199;171168;175567;137589;140457;141401;145063;145369.7315134239;119252;121182.78817211714;122134;124672.75327246793;128288;9281.164695177466;9329.346945713734;9519.714408567754;9521.523923803921;9525.095115963972;62065.06902396558;63665.68447877692;64702.67648661727;65863;66826.33173668201;92230.07769922483;95698.04301956891;96913.51543242238;98409;98966.5051674737;11912;12223.694407639525;12327.50689972391;12513;12759.553415630407;11389.373584452935;13306.401211945293;13609.251491168081;13660.180389176681;13810.723785524033;11763.529458821551;12290.815637765261;12309.322987235788;12778.105532612999;12902.290374029519;12418.441170147184;12468.251904885736;12647.430865610886;12771.233725976472;12834.871651283742;12013.63959081229;12119.81820272679;12288.078394120297;12289.631311060682;12383.504659813507;9704.611815527582;10245.463180522982;10845;11143.888561114285;11318.547258109913;10362.481875906326;10951.56193752241;10978.503698555392;11045.668629941114;11120.555177793121 08:22:59 INFO - PROCESS | 1640 | __end_tp_report 08:22:59 INFO - PROCESS | 1640 | __start_cc_report 08:22:59 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1009 08:22:59 INFO - PROCESS | 1640 | __end_cc_report 08:22:59 INFO - PROCESS | 1640 | __startTimestamp1479486179591__endTimestamp 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | ------- Summary: start ------- 08:22:59 INFO - PROCESS | 1640 | Number of tests: 6 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5827.70 Median:6124.79 stddev:658.32 (10.7%) stddev-sans-first:634.56 08:22:59 INFO - PROCESS | 1640 | Values: 3502.3 3504.2 3528.9 3532.8 3586.2 4746.3 5850.1 5856.4 5886.7 5925.1 5864.8 5920.4 5924.6 5937.2 5959.0 5241.6 5251.8 5318.4 5326.5 5329.7 4452.0 5239.7 5254.9 5257.1 5359.1 4059.5 5276.7 5303.6 5305.5 5319.8 5290.9 5314.7 5324.9 5373.1 5381.8 5226.3 5293.3 5303.3 5306.8 5334.0 5679.4 5739.1 5743.3 5790.1 5799.2 6224.4 6286.9 6289.0 6301.5 6310.9 6200.8 6243.7 6253.8 6271.3 6272.7 5780.9 5823.9 5847.7 5906.3 5964.3 6258.2 6278.8 6310.1 6313.2 6329.6 6247.3 6251.7 6256.6 6265.7 6273.4 6214.3 6218.8 6268.7 6294.8 6303.8 6306.7 6313.2 6319.6 6337.2 6347.9 6219.0 6277.8 6312.5 6314.0 6324.3 4929.3 4989.2 5061.6 5084.2 5090.4 3936.3 4543.6 4581.2 4607.7 4619.5 5965.6 5969.5 5969.7 5971.0 5974.9 6170.3 6244.9 6249.3 6256.9 6268.0 5782.4 5866.7 5953.5 5967.3 6034.3 5514.2 5542.8 5545.7 5563.1 5578.4 6385.0 6390.2 6391.6 6409.4 6420.1 6180.2 6221.6 6256.0 6271.9 6285.3 6414.4 6422.3 6423.2 6424.4 6437.5 6264.6 6302.8 6312.5 6347.7 6350.7 6105.5 6210.4 6213.1 6281.5 6301.4 6194.2 6239.4 6253.0 6268.7 6288.4 6239.4 6250.8 6259.7 6270.4 6296.5 6010.5 6061.6 6069.1 6108.3 6134.3 6209.8 6233.7 6289.7 6307.8 6311.2 5046.9 6111.5 6124.8 6128.7 6150.3 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:73726.64 Median:3560.26 stddev:162103.94 (4553.1%) stddev-sans-first:162465.50 08:22:59 INFO - PROCESS | 1640 | Values: 518.5 531.4 542.8 553.6 564.2 33021.5 42502.0 43634.6 43818.8 45756.9 44934.0 45167.0 45687.3 45730.8 45764.8 10022.9 10226.0 10227.1 10236.1 10260.0 9391.0 9623.0 10351.5 10957.5 12427.4 12526.9 12587.7 12595.0 12615.2 12616.9 12395.4 12474.3 12488.1 12510.1 12512.8 12325.0 12429.4 12440.4 12441.6 12444.6 42645.8 42971.0 42983.0 42994.4 43095.8 3428.9 3435.2 3558.3 3562.2 3687.1 31738.8 32397.4 32673.5 32919.0 33032.7 3233.1 3326.6 3407.5 3422.2 3425.5 557597.0 561221.0 561255.0 561526.0 562440.2 67416.0 67869.3 68034.3 68054.0 68172.0 36164.8 36921.6 36931.4 37762.2 37822.8 18403.7 18560.7 18619.3 18639.4 18647.2 12797.5 13061.7 14108.0 14180.9 14211.6 20169.0 20535.0 20800.0 21016.2 21081.7 8200.6 8212.3 8248.3 8299.3 8309.8 910.7 953.5 1013.5 1032.7 1070.4 31929.5 32080.0 32171.8 32302.7 32428.0 945.0 1078.9 1100.9 1113.4 1115.0 15758.4 16267.6 16315.8 16361.5 16704.7 562351.0 568775.0 569310.0 569365.0 570690.0 59267.0 59925.4 60032.4 60070.0 60196.0 1229.6 1299.4 1338.8 1429.9 1463.2 31494.5 33326.7 33370.7 33398.0 33822.3 53604.7 54258.0 54340.5 54468.0 54528.0 536647.3 539010.0 541399.0 842009.0 863255.0 27850.9 28557.0 28561.9 29228.7 29241.0 50311.0 50626.0 50847.5 50933.5 51400.0 40579.0 40951.8 41621.8 42346.8 43682.0 41074.8 41378.0 41993.4 42094.6 42512.6 41084.8 41122.4 41823.8 42079.2 42159.7 32383.7 32417.0 36356.7 36727.3 37150.6 26765.6 27169.6 27223.9 27345.7 27783.6 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:36590.66 Median:12303.06 stddev:105442.45 (857.0%) stddev-sans-first:105703.18 08:22:59 INFO - PROCESS | 1640 | Values: 377.1 381.1 389.2 391.6 412.5 20203.2 20316.5 21414.8 21559.5 21563.5 20285.0 21137.3 21154.3 21395.9 21547.9 5834.1 6039.2 6087.0 6089.0 6093.6 5725.7 5946.4 5979.7 6097.9 6104.8 5934.9 5943.7 5946.0 5951.6 5954.0 5825.9 5926.7 5937.3 6108.9 6175.1 6037.4 6052.4 6056.7 6060.2 6061.2 22279.0 23763.8 24670.0 25455.2 25691.0 2224.9 2327.1 2337.8 2401.7 2420.1 10287.6 10353.5 12497.6 15120.6 15690.1 1956.3 1990.9 2019.9 2050.6 2058.2 122853.0 126718.0 127547.0 133384.0 137468.0 11269.4 11537.5 11615.5 11619.4 11845.7 14690.0 14699.8 14707.8 14730.5 14733.3 8620.2 8717.7 8851.7 8942.2 8946.8 8678.2 8809.3 8972.3 8996.1 9200.5 3611.5 4390.3 4531.0 4543.9 4608.1 1933.2 1967.3 1969.3 1979.3 1983.5 879.7 960.0 970.6 988.6 1015.6 19316.9 20809.8 20818.9 21203.0 21225.2 845.9 953.6 1000.2 1002.1 1059.0 9882.2 10254.9 10583.7 11042.7 11063.2 606613.0 619128.0 632499.0 644913.0 646879.0 135457.0 138301.6 139071.0 139914.0 146511.0 981.6 989.8 1000.0 1003.3 1019.4 17632.7 18324.9 18484.8 18492.9 18493.6 37148.0 50314.7 50596.7 55949.7 57268.4 71539.0 78058.2 78710.0 80217.2 80945.0 4882.8 7387.1 7649.5 7908.8 8160.8 12141.5 12972.3 13064.0 13074.1 13344.3 11160.4 11220.3 11301.7 11465.4 11616.7 11069.6 11135.0 11160.8 11222.6 11551.1 11332.9 11444.2 11737.1 11761.9 11860.1 7739.2 7921.0 7948.2 8282.4 8282.9 8226.1 10087.4 11184.9 11356.5 11567.4 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5956.82 Median:4793.31 stddev:3408.32 (71.1%) stddev-sans-first:3400.83 08:22:59 INFO - PROCESS | 1640 | Values: 1420.4 1454.5 1598.9 1821.3 1980.1 8340.8 8864.8 9041.5 9393.6 9400.8 9229.0 9325.8 9338.6 9345.7 9358.1 2455.0 2484.9 2488.3 2488.8 2489.2 2411.4 2476.5 2477.7 2479.0 2480.3 2430.2 2448.8 2473.3 2475.5 2476.6 2411.0 2436.1 2444.4 2448.6 2452.1 2408.0 2437.4 2439.5 2441.6 2453.2 9272.7 9317.2 9385.4 9414.9 9415.8 5471.2 5680.5 5694.5 5741.1 5747.5 3772.6 3774.9 3806.1 3851.6 3858.6 1122.8 1123.9 1124.4 1139.3 1146.6 12425.9 12454.9 12528.9 12540.4 12554.0 4560.9 4680.7 4810.4 4811.0 4836.2 9710.5 9723.5 9724.7 9725.2 9728.6 4756.4 5502.0 5516.5 5525.3 5525.6 4109.2 4610.7 4776.2 5114.9 5196.3 3991.2 4039.3 4051.1 4080.0 4110.9 1195.6 1210.9 1211.6 1223.1 1223.7 926.4 959.3 967.5 967.9 1010.0 6000.6 6059.0 6066.8 6107.8 6133.5 441.1 449.7 454.1 455.2 457.7 3855.6 3925.8 4072.8 4082.1 4179.0 11030.3 11553.3 11558.2 11570.9 11594.5 11421.9 11459.4 11500.3 11502.1 11532.0 8279.9 8642.4 8661.7 8731.6 8766.8 5379.8 6225.8 6233.7 6237.1 6356.8 10515.4 10658.5 10673.5 10677.9 10698.0 8603.4 10264.7 10795.6 10974.5 10979.2 7912.5 8090.1 8105.8 8108.9 8116.0 8603.0 8643.7 8725.7 8730.8 8814.2 7535.2 7556.5 7570.7 7588.0 7666.5 7415.2 7419.9 7436.5 7460.9 7660.0 7357.4 7358.8 7359.7 7449.3 7454.4 5178.5 5208.0 5224.9 5229.6 5257.7 5115.0 5149.2 5202.8 5422.4 5480.2 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4463.52 Median:4762.57 stddev:1382.50 (29.0%) stddev-sans-first:1350.62 08:22:59 INFO - PROCESS | 1640 | Values: 301.3 302.6 309.6 313.5 315.2 4443.9 5228.7 5381.3 5413.2 5471.4 4919.6 5097.4 5145.8 5330.9 5406.3 4101.5 4107.4 4124.4 4144.9 4151.7 3937.4 4152.7 4154.9 4155.7 4167.2 3203.6 4084.6 4105.0 4137.9 4138.8 3582.8 4083.8 4088.6 4112.9 4125.2 3079.1 3153.8 3532.0 3615.2 3625.3 4330.8 5066.8 5194.7 5293.9 5327.9 4699.8 4726.9 4745.2 4754.0 4758.5 5014.9 5581.5 5589.4 5661.5 5682.0 3355.8 3756.8 3978.5 3998.1 4011.4 5098.4 5881.8 5920.7 5964.3 5968.6 3591.7 4085.4 4089.2 4104.2 4104.8 3965.5 4095.1 4133.5 4144.5 4151.2 4343.8 4631.0 4697.7 4714.1 4720.8 5624.7 5722.9 5737.9 5745.9 5764.9 1170.9 1258.0 1294.9 1379.5 1398.4 711.9 853.8 855.8 863.2 865.0 4221.8 4429.4 4603.9 4631.4 4635.4 4276.8 4551.5 4924.6 4955.5 4993.6 4185.4 4227.0 4285.5 4485.2 4525.6 2307.6 2400.4 2495.7 2518.1 2532.6 4306.8 4408.6 4522.5 4766.6 5087.3 4402.9 4582.4 4901.9 5034.5 5040.7 5048.1 5086.9 5461.7 5514.0 6224.3 4876.1 5410.9 5653.3 5705.3 5994.9 4613.8 4699.7 5546.9 5553.3 5865.9 4955.3 5451.9 6042.4 6126.4 6141.0 3339.7 3914.8 3993.5 4044.4 4061.2 5671.9 5896.6 5997.9 5998.6 6011.7 5281.8 5381.9 5517.6 5794.0 5816.7 5266.4 5334.4 5764.9 5813.9 5856.7 4957.6 5357.4 5508.8 5679.3 5722.5 5050.4 5084.8 5615.9 5844.4 5851.7 5355.3 5727.7 5734.5 5762.7 5779.1 08:22:59 INFO - PROCESS | 1640 | 08:22:59 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:26952.73 Median:3770.29 stddev:44635.26 (1183.9%) stddev-sans-first:44717.09 08:22:59 INFO - PROCESS | 1640 | Values: 742.5 771.2 790.8 813.2 852.0 15811.8 16264.0 16993.4 17053.6 17093.6 15007.5 15393.7 15411.0 15412.6 15441.2 715.9 738.2 865.6 884.9 887.3 896.0 910.2 920.8 921.3 922.8 818.2 957.4 960.0 960.7 964.5 955.0 955.4 955.8 955.9 956.0 705.4 705.6 706.2 708.1 708.4 15588.0 15651.1 15656.2 15664.2 15690.6 13985.7 14792.7 14937.6 15029.6 15130.5 13539.9 13662.5 13743.1 13749.5 13834.4 4709.1 4711.9 4767.4 4868.1 4957.4 123448.0 130424.0 130530.3 130719.0 133076.3 10996.3 11101.6 11182.4 11277.8 11375.9 21032.4 21284.6 21298.3 21370.7 21394.1 7888.6 8010.8 8130.9 8156.1 8160.7 4548.4 4563.5 4600.1 4625.5 4699.4 3732.2 3808.4 3902.5 3903.6 3911.9 698.6 718.0 726.1 731.5 731.8 553.7 575.9 633.1 706.8 710.7 8743.8 8745.5 9404.2 9584.4 10008.3 661.6 672.6 699.8 701.7 717.6 4801.8 4824.1 4905.5 4950.5 4980.8 163428.0 168197.0 169199.0 171168.0 175567.0 137589.0 140457.0 141401.0 145063.0 145369.7 119252.0 121182.8 122134.0 124672.8 128288.0 9281.2 9329.3 9519.7 9521.5 9525.1 62065.1 63665.7 64702.7 65863.0 66826.3 92230.1 95698.0 96913.5 98409.0 98966.5 11912.0 12223.7 12327.5 12513.0 12759.6 11389.4 13306.4 13609.3 13660.2 13810.7 11763.5 12290.8 12309.3 12778.1 12902.3 12418.4 12468.3 12647.4 12771.2 12834.9 12013.6 12119.8 12288.1 12289.6 12383.5 9704.6 10245.5 10845.0 11143.9 11318.5 10362.5 10951.6 10978.5 11045.7 11120.6 08:22:59 INFO - PROCESS | 1640 | -------- Summary: end -------- 08:22:59 INFO - PROCESS | 1640 | 08:23:00 INFO - TEST-INFO | 1640: exit 0 08:23:00 INFO - TEST-OK | dromaeo_css | took 1114364ms 08:23:00 INFO - TEST-START | kraken 08:23:00 INFO - operating with platform_type : mac_ 08:23:00 INFO - Initialising browser for kraken test... 08:23:00 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpq7kBUI/profile http://localhost:49240/getInfo.html) 08:23:02 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:23:02 INFO - PROCESS | 1650 | colorDepth:24 08:23:02 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:23:02 INFO - PROCESS | 1650 | __metrics 08:23:02 INFO - PROCESS | 1650 | 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" 08:23:02 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:03 INFO - TEST-INFO | 1650: exit 0 08:23:03 INFO - Browser initialized. 08:23:03 INFO - Running cycle 1/1 for kraken test... 08:23:03 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpq7kBUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:14 INFO - PROCESS | 1652 | RSS: Main: 167956480 08:23:14 INFO - PROCESS | 1652 | 08:23:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:18 INFO - PROCESS | 1652 | RSS: Main: 218365952 08:23:18 INFO - PROCESS | 1652 | 08:23:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:23:21 INFO - PROCESS | 1652 | RSS: Main: 228503552 08:23:21 INFO - PROCESS | 1652 | 08:23:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:23:25 INFO - PROCESS | 1652 | RSS: Main: 325763072 08:23:25 INFO - PROCESS | 1652 | 08:23:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:23:28 INFO - PROCESS | 1652 | RSS: Main: 228552704 08:23:28 INFO - PROCESS | 1652 | 08:23:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:30 INFO - PROCESS | 1652 | RSS: Main: 229347328 08:23:30 INFO - PROCESS | 1652 | 08:23:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:33 INFO - PROCESS | 1652 | RSS: Main: 265854976 08:23:33 INFO - PROCESS | 1652 | 08:23:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:37 INFO - PROCESS | 1652 | RSS: Main: 266444800 08:23:37 INFO - PROCESS | 1652 | 08:23:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:23:40 INFO - PROCESS | 1652 | RSS: Main: 264568832 08:23:40 INFO - PROCESS | 1652 | 08:23:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:42 INFO - PROCESS | 1652 | RSS: Main: 240611328 08:23:42 INFO - PROCESS | 1652 | 08:23:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:45 INFO - PROCESS | 1652 | RSS: Main: 244662272 08:23:45 INFO - PROCESS | 1652 | 08:23:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:48 INFO - PROCESS | 1652 | RSS: Main: 250400768 08:23:48 INFO - PROCESS | 1652 | 08:23:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:51 INFO - PROCESS | 1652 | RSS: Main: 266391552 08:23:51 INFO - PROCESS | 1652 | 08:23:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:55 INFO - PROCESS | 1652 | RSS: Main: 259395584 08:23:55 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:23:57 INFO - PROCESS | 1652 | RSS: Main: 303415296 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | __start_tp_report 08:23:57 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:23:57 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:23:57 INFO - PROCESS | 1652 | |i|pagename|runs| 08:23:57 INFO - PROCESS | 1652 | |0;ai-astar;118;162;167;114;111;112;113;112;113;112 08:23:57 INFO - PROCESS | 1652 | |1;audio-beat-detection;147;121;144;171;134;107;111;106;137;107 08:23:57 INFO - PROCESS | 1652 | |2;audio-dft;185;182;182;185;185;182;182;194;219;183 08:23:57 INFO - PROCESS | 1652 | |3;audio-fft;80;59;58;87;60;59;61;58;80;57 08:23:57 INFO - PROCESS | 1652 | |4;audio-oscillator;83;72;94;68;66;69;91;68;68;89 08:23:57 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;86;89;86;87;84;87;85;87;84 08:23:57 INFO - PROCESS | 1652 | |6;imaging-darkroom;102;149;138;95;93;93;94;94;93;93 08:23:57 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;86;84;84;85;86;87;83;84;84 08:23:57 INFO - PROCESS | 1652 | |8;json-parse-financial;55;52;51;52;54;55;56;55;55;55 08:23:57 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;63;69;69;77;71;67;68;69;68;69 08:23:57 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;83;81;84;82;91;95;99;85;82 08:23:57 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;136;136;138;135;130;141;149;132;187;143 08:23:57 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;165;162;161;158;213;142;200;216;204;159 08:23:57 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;66;65;65;66;65 08:23:57 INFO - PROCESS | 1652 | __end_tp_report 08:23:57 INFO - PROCESS | 1652 | __start_cc_report 08:23:57 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1899 08:23:57 INFO - PROCESS | 1652 | __end_cc_report 08:23:57 INFO - PROCESS | 1652 | __startTimestamp1479486237281__endTimestamp 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:23:57 INFO - PROCESS | 1652 | Number of tests: 14 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:123.40 Median:113.50 stddev:21.78 (19.2%) stddev-sans-first:23.01 08:23:57 INFO - PROCESS | 1652 | Values: 118.0 162.0 167.0 114.0 111.0 112.0 113.0 112.0 113.0 112.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:135.50 stddev:21.82 (16.1%) stddev-sans-first:22.09 08:23:57 INFO - PROCESS | 1652 | Values: 147.0 121.0 144.0 171.0 134.0 107.0 111.0 106.0 137.0 107.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:187.90 Median:185.00 stddev:11.51 (6.2%) stddev-sans-first:12.16 08:23:57 INFO - PROCESS | 1652 | Values: 185.0 182.0 182.0 185.0 185.0 182.0 182.0 194.0 219.0 183.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.50 stddev:11.55 (19.1%) stddev-sans-first:11.07 08:23:57 INFO - PROCESS | 1652 | Values: 80.0 59.0 58.0 87.0 60.0 59.0 61.0 58.0 80.0 57.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.50 stddev:11.14 (14.4%) stddev-sans-first:11.59 08:23:57 INFO - PROCESS | 1652 | Values: 83.0 72.0 94.0 68.0 66.0 69.0 91.0 68.0 68.0 89.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.64 (1.9%) stddev-sans-first:1.62 08:23:57 INFO - PROCESS | 1652 | Values: 88.0 86.0 89.0 86.0 87.0 84.0 87.0 85.0 87.0 84.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:93.00 stddev:20.95 (22.5%) stddev-sans-first:22.20 08:23:57 INFO - PROCESS | 1652 | Values: 102.0 149.0 138.0 95.0 93.0 93.0 94.0 94.0 93.0 93.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 08:23:57 INFO - PROCESS | 1652 | Values: 84.0 86.0 84.0 84.0 85.0 86.0 87.0 83.0 84.0 84.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.70 (3.1%) stddev-sans-first:1.76 08:23:57 INFO - PROCESS | 1652 | Values: 55.0 52.0 51.0 52.0 54.0 55.0 56.0 55.0 55.0 55.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:3.50 (5.1%) stddev-sans-first:2.96 08:23:57 INFO - PROCESS | 1652 | Values: 63.0 69.0 69.0 77.0 71.0 67.0 68.0 69.0 68.0 69.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.50 stddev:6.26 (7.4%) stddev-sans-first:6.51 08:23:57 INFO - PROCESS | 1652 | Values: 83.0 83.0 81.0 84.0 82.0 91.0 95.0 99.0 85.0 82.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:139.50 stddev:16.51 (11.8%) stddev-sans-first:17.33 08:23:57 INFO - PROCESS | 1652 | Values: 136.0 136.0 138.0 135.0 130.0 141.0 149.0 132.0 187.0 143.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:182.50 stddev:27.08 (14.8%) stddev-sans-first:28.31 08:23:57 INFO - PROCESS | 1652 | Values: 165.0 162.0 161.0 158.0 213.0 142.0 200.0 216.0 204.0 159.0 08:23:57 INFO - PROCESS | 1652 | 08:23:57 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:23:57 INFO - PROCESS | 1652 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 08:23:57 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:23:57 INFO - PROCESS | 1652 | 08:23:58 INFO - TEST-INFO | 1652: exit 0 08:23:58 INFO - TEST-OK | kraken | took 57917ms 08:23:58 INFO - SUITE-END | took 1172s 08:23:58 INFO - Completed test suite (00:19:32) 08:23:58 INFO - javascript benchmark 08:23:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3502.2995400919813, 3504.246586983798, 3528.9294214115735, 3532.841022154001, 3586.246888153488, 4746.288056791483, 5850.093235548491, 5856.414358564152, 5886.705664716763, 5925.1112333149995, 5864.824055278338, 5920.407959204077, 5924.644521328723, 5937.168796368512, 5958.970205148979, 5241.580673546107, 5251.789928402859, 5318.388385335678, 5326.467353264681, 5329.706866122362, 4452.0, 5239.73801309933, 5254.8686282842855, 5257.080010998079, 5359.08895487766, 4059.472268605092, 5276.657017293883, 5303.602229832759, 5305.469453054702, 5319.813806516772, 5290.947090529103, 5314.73426328682, 5324.92012619811, 5373.113436283009, 5381.838544843661, 5226.346706661668, 5293.258943747878, 5303.337082864642, 5306.814261500867, 5334.0, 5679.432056794329, 5739.139129130622, 5743.282089738783, 5790.13148027795, 5799.21710569072, 6224.408681175281, 6286.937130628681, 6289.0, 6301.495880329563, 6310.905336419957, 6200.751969921198, 6243.687815609202, 6253.843653908643, 6271.310155882849, 6272.65500397478, 5780.88438231233, 5823.94176058234, 5847.707614619252, 5906.26171728534, 5964.284285885678, 6258.249010118815, 6278.811635650938, 6310.116583678288, 6313.179286692793, 6329.620222786648, 6247.312795592481, 6251.718672659741, 6256.593321434092, 6265.749370025148, 6273.404026617464, 6214.285357183981, 6218.782342617987, 6268.749250030039, 6294.8426289342215, 6303.779367722108, 6306.747730090745, 6313.210848643919, 6319.6208227506495, 6337.207849018872, 6347.873042539123, 6219.0, 6277.780277690259, 6312.463440607508, 6313.96843015782, 6324.3043265240785, 4929.285253638202, 4989.201727723546, 5061.5950723942, 5084.161113416319, 5090.363704536933, 3936.3308237599676, 4543.568361005699, 4581.152486789954, 4607.746573938465, 4619.514950930171, 5965.642061476326, 5969.462748352582, 5969.701514924323, 5971.0, 5974.864775692605, 6170.321264660884, 6244.906326405107, 6249.25008998923, 6256.937430625636, 6268.0, 5782.392848750905, 5866.70666466675, 5953.493953013955, 5967.254093238345, 6034.306054803666, 5514.172874068921, 5542.75057622408, 5545.667259964415, 5563.109902415594, 5578.44215578447, 6385.0, 6390.201224846801, 6391.616503009835, 6409.391107844747, 6420.06908998202, 6180.196574445294, 6221.595596286227, 6255.96872015637, 6271.937280627135, 6285.308616052139, 6414.390632889868, 6422.293547709842, 6423.197100362455, 6424.421802037839, 6437.452816510649, 6264.59280146789, 6302.779402720883, 6312.526560508072, 6347.682615869096, 6350.650714210763, 6105.511559075352, 6210.378962103753, 6213.068039794067, 6281.52888533371, 6301.369863013845, 6194.163787888758, 6239.438450539473, 6253.0, 6268.717907694074, 6288.371162883675, 6239.376062393724, 6250.781222657185, 6259.718312676032, 6270.372962703693, 6296.464800492009, 6010.549208809444, 6061.605995610271, 6069.089636554552, 6108.267007959073, 6134.294556126102, 6209.844753881189, 6233.657148856675, 6289.654069026247, 6307.810765677037, 6311.2426508819235, 5046.924296135634, 6111.480524155319, 6124.785632502841, 6128.662923539248, 6150.261968563801], "value": 5786.903952520589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.5229588778324, 531.415443012686, 542.8181559177675, 553.6041730162933, 564.1875698993447, 33021.504677429824, 42502.0, 43634.56365436345, 43818.780906095504, 45756.85607859797, 44934.0, 45167.0, 45687.31469027967, 45730.77134614322, 45764.77117614415, 10022.949885250582, 10225.977402259752, 10227.079562839343, 10236.078752912237, 10259.974002599754, 9391.0, 9623.0, 10351.534180961837, 10957.520734700833, 12427.440765165544, 12526.874731252707, 12587.685307867285, 12595.0, 12615.243085414904, 12616.873831261662, 12395.38023098846, 12474.251544907243, 12488.12583119182, 12510.124291299613, 12512.81230781539, 12325.0, 12429.37853107341, 12440.377981100999, 12441.564545240873, 12444.626661200178, 42645.786771066254, 42971.0, 42983.0, 42994.355084673756, 43095.784521077505, 3428.879989200366, 3435.158386195398, 3558.3061303045915, 3562.2163124112653, 3687.059799751073, 31738.841305793554, 32397.352052959046, 32673.50989735156, 32919.0, 33032.6696733032, 3233.110894504007, 3326.6340702522944, 3407.454807230831, 3422.178677117499, 3425.53755243044, 557597.0, 561221.0, 561255.0, 561525.9999999959, 562440.1877990625, 67416.0, 67869.32130678729, 68034.29914252184, 68054.0, 68172.0, 36164.819175903955, 36921.63078369236, 36931.4460283096, 37762.244755104744, 37822.810885945946, 18403.72394414085, 18560.721589176173, 18619.348322808906, 18639.440816775248, 18647.160877760263, 12797.488100476063, 13061.738765224833, 14108.0, 14180.858191417954, 14211.573652790434, 20169.0, 20534.973251337375, 20799.96000199984, 21016.159353625684, 21081.683774743393, 8200.630971606291, 8212.301954333949, 8248.298894593907, 8299.29455996235, 8309.8338033239, 910.6539514984264, 953.4994128082812, 1013.4983183324155, 1032.7160030991388, 1070.4112737994071, 31929.52105718416, 32080.0, 32171.839140804615, 32302.67697323044, 32428.02715918526, 944.9669261575949, 1078.8759292681443, 1100.862392200975, 1113.4321496036916, 1115.043099360617, 15758.369665213493, 16267.593310167103, 16315.755263671055, 16361.509154725378, 16704.6659066818, 562351.0, 568775.0, 569310.0, 569365.0, 570690.0, 59267.0, 59925.40074599198, 60032.39967600355, 60070.0, 60196.0, 1229.6065259117177, 1299.4022749535131, 1338.772408690525, 1429.89275804313, 1463.2098666720065, 31494.52758208583, 33326.66673333236, 33370.666293336755, 33398.0, 33822.323553529284, 53604.73197633987, 54258.0, 54340.45659543354, 54468.0, 54528.0, 536647.3167634137, 539010.0, 541399.0, 842009.0, 863255.0, 27850.860745696144, 28557.000504982225, 28561.857190713912, 29228.707712922598, 29240.976565820096, 50311.0, 50626.0, 50847.491525084275, 50933.490665092875, 51400.0, 40578.9855253621, 40951.7952410236, 41621.79189104035, 42346.78826605847, 43682.0, 41074.794626026676, 41377.96555086147, 41993.369311508264, 42094.57905420907, 42512.57487425086, 41084.79457602693, 41122.38316425316, 41823.79088104662, 42079.158416832106, 42159.73520794381, 32383.676163238066, 32417.0, 36356.72751453686, 36727.26545469129, 37150.628493714714, 26765.598516022666, 27169.59245611278, 27223.863880681263, 27345.72654273432, 27783.583246250917], "value": 21320.95275990029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.0799249830414, 381.1082067960971, 389.2463435534704, 391.5653624476831, 412.47821505795173, 20203.191872325107, 20316.492087697778, 21414.785852141475, 21559.46101347465, 21563.460913477153, 20284.958945322087, 21137.26019589315, 21154.25960091397, 21395.893020534877, 21547.892260538676, 5834.124881267812, 6039.1545183674325, 6087.0, 6089.0, 6093.6039157454625, 5725.742341594618, 5946.375630558772, 5979.730912108944, 6097.878042439171, 6104.786332478364, 5934.940650593504, 5943.732532036069, 5945.959457094991, 5951.6429014259065, 5954.047352423613, 5825.88348233033, 5926.703664816763, 5937.2578427696535, 6108.877822443571, 6175.135481032659, 6037.396260373971, 6052.394760523956, 6056.697165141725, 6060.212172417558, 6061.242344706911, 22279.0, 23763.76236237633, 24670.0, 25455.236342909742, 25690.972361105534, 2224.9332520024427, 2327.1273272522803, 2337.836351455399, 2401.7478164792797, 2420.1287536486852, 10287.639932602398, 10353.482325883675, 12497.625071247787, 15120.563546463069, 15690.058596484247, 1956.2664000999625, 1990.8506861985409, 2019.8993047230863, 2050.641137800879, 2058.2487392101775, 122853.0, 126718.0, 127547.0, 133384.0, 137468.0, 11269.38018408979, 11537.48081336342, 11615.535378584931, 11619.419029048513, 11845.703857403461, 14690.045147065406, 14699.779503307458, 14707.779383309258, 14730.484433045007, 14733.26333683333, 8620.224179823846, 8717.694880679146, 8851.734447966572, 8942.150495702897, 8946.776330591658, 8678.175573320525, 8809.295256379473, 8972.282217422591, 8996.100389960951, 9200.539973001323, 3611.4582812578324, 4390.253656878338, 4531.0, 4543.931841022388, 4608.078384323148, 1933.236371633197, 1967.2917749610128, 1969.2516843599626, 1979.2973494409277, 1983.454549998733, 879.7140929198036, 960.0, 970.631160159135, 988.604558176735, 1015.5937624950079, 19316.903415482833, 20809.791902080786, 20818.89590552068, 21202.958830415, 21225.15099396038, 845.9341230050059, 953.6090203016869, 1000.2098342309494, 1002.0630710285906, 1059.0, 9882.209423246122, 10254.948725256327, 10583.682489525327, 11042.723931901606, 11063.225574209728, 606613.0, 619128.0, 632499.0, 644913.0, 646879.0, 135457.0, 138301.6169838309, 139071.0, 139914.0, 146511.0, 981.6220755009373, 989.8020395920845, 999.9850002249972, 1003.3327836988321, 1019.3527110285022, 17632.73550896763, 18324.90837545804, 18484.81515184831, 18492.907535462236, 18493.630127397646, 37148.0, 50314.748426259095, 50596.747016264686, 55949.72025139848, 57268.42731572631, 71539.0, 78058.2194178051, 78710.0, 80217.1978280233, 80945.0, 4882.7558622068045, 7387.1135463744695, 7649.502782319131, 7908.802279943047, 8160.83678326442, 12141.510990247154, 12972.286524241257, 13063.954883609098, 13074.084814063304, 13344.332783360987, 11160.441977901235, 11220.326780392876, 11301.660950171508, 11465.4267286637, 11616.709582260512, 11069.612563560237, 11135.0, 11160.832587511031, 11222.55109795599, 11551.133664974992, 11332.886671133183, 11444.198906076495, 11737.061035117, 11761.941190293994, 11860.110491713329, 7739.187385324685, 7920.960395197987, 7948.16544262844, 8282.4202305838, 8282.875756863532, 8226.136255693305, 10087.394756314645, 11184.888151118384, 11356.54573817038, 11567.363794991355], "value": 9775.19361547793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.3963315590884, 1454.4909281751388, 1598.8880778345513, 1821.317006122704, 1980.0792631426384, 8340.83318333633, 8864.822703545926, 9041.457512549243, 9393.577289021994, 9400.764980875481, 9228.953855230715, 9325.766855828608, 9338.579763910624, 9345.67290144845, 9358.110979456958, 2454.975450245497, 2484.8881800319027, 2488.315713178881, 2488.776010159085, 2489.215896992451, 2411.4212588978694, 2476.5418397596413, 2477.677901872754, 2479.0207867892173, 2480.293116461809, 2430.2101816909485, 2448.8163387745903, 2473.3445636906145, 2475.4553998120386, 2476.578981573137, 2410.9517809643885, 2436.062116085311, 2444.4133407982135, 2448.5714999875127, 2452.1294940296293, 2408.0247499762622, 2437.427204606916, 2439.4511234972165, 2441.5727247731575, 2453.1659235859893, 9272.675456358995, 9317.16145546904, 9385.38994965325, 9414.858777118348, 9415.764605884839, 5471.179323101527, 5680.488756011938, 5694.4590263924865, 5741.081426971707, 5747.48272655463, 3772.5661548921676, 3774.9056273593105, 3806.143617686026, 3851.595582463829, 3858.614138586147, 1122.820348744197, 1123.8988491035846, 1124.3984468309416, 1139.2594813371375, 1146.5757669662196, 12425.93787031059, 12454.875451245462, 12528.874711252953, 12540.372981350987, 12553.999999999909, 4560.908781824345, 4680.742559159211, 4810.374651295379, 4810.975945120322, 4836.202026665631, 9710.465924374086, 9723.513824308757, 9724.659636912675, 9725.221982241404, 9728.610855565697, 4756.357891684647, 5502.0, 5516.503514683698, 5525.336959564878, 5525.640833345819, 4109.219248342805, 4610.700304480198, 4776.23580227162, 5114.923276150861, 5196.298499702491, 3991.2416640838146, 4039.2527382434346, 4051.068254301468, 4080.0207950091763, 4110.897227569335, 1195.6114262864603, 1210.90918181135, 1211.5941159711595, 1223.082687984012, 1223.6757259326287, 926.3654396738121, 959.318883592643, 967.4678926590348, 967.9080487353831, 1010.0051449322411, 6000.639961602318, 6059.0, 6066.817995460143, 6107.786227482017, 6133.478654314434, 441.0693436848248, 449.7369039112091, 454.14620513434534, 455.1920341393986, 457.6819110718019, 3855.5566109897723, 3925.7840818755244, 4072.75563466193, 4082.081531655354, 4178.979105104455, 11030.338179709242, 11553.30680159193, 11558.248713833575, 11570.94214528922, 11594.536218551331, 11421.942890285496, 11459.369734664508, 11500.25248358854, 11502.13733969939, 11532.0, 8279.917200827915, 8642.395032347675, 8661.696840610675, 8731.60707768152, 8766.824663506693, 5379.838604841861, 6225.844353891189, 6233.719482623384, 6237.095621135, 6356.7775127872155, 10515.421651809223, 10658.467076645982, 10673.46632668379, 10677.89322106769, 10698.03717665414, 8603.354748393771, 10264.743381415525, 10795.56817727282, 10974.451277435937, 10979.231453798158, 7912.525248485109, 8090.0696419912465, 8105.75682729519, 8108.878366824384, 8116.026076870813, 8602.956985215034, 8643.654253829776, 8725.650973961225, 8730.825383492167, 8814.162654547808, 7535.171131175457, 7556.471047026876, 7570.659320330708, 7587.962060189664, 7666.501677390952, 7415.2214017527385, 7419.9258007421395, 7436.479446438913, 7460.850782984418, 7660.0, 7357.411407087528, 7358.77923662291, 7359.705611775469, 7449.292317229854, 7454.44091693136, 5178.508041736029, 5207.973960130326, 5224.895502090013, 5229.555487783581, 5257.710825904612, 5115.0, 5149.201873709581, 5202.765875535534, 5422.430644782241, 5480.205370221375], "value": 4680.806342221497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2964727361611, 302.5673287199304, 309.6098915366638, 313.4514599450961, 315.2214031342586, 4443.911121777563, 5228.712420816853, 5381.327334083239, 5413.242146099545, 5471.398146203915, 4919.606431485481, 5097.374851951248, 5145.768440420181, 5330.92003619946, 5406.296851574213, 4101.4668093148, 4107.412330231949, 4124.360724087771, 4144.8756537303925, 4151.688623353246, 3937.448757173998, 4152.650388623694, 4154.854580089697, 4155.729877557964, 4167.249895018896, 3203.567518385023, 4084.5711200323985, 4105.0, 4137.875863724078, 4138.8137533810905, 3582.7671201371827, 4083.7549747015273, 4088.632023117919, 4112.897177570555, 4125.195586860564, 3079.0916679579577, 3153.8265395403246, 3531.958072368657, 3615.1801594756134, 3625.29306785177, 4330.834582708646, 5066.847994560169, 5194.6883187008525, 5293.894122117575, 5327.922110376918, 4699.812007519729, 4726.905461890743, 4745.193317136095, 4754.0, 4758.547937945889, 5014.874628134326, 5581.469760372758, 5589.413111623262, 5661.46216109469, 5681.9601513190655, 3355.808687915779, 3756.812159392047, 3978.527944660494, 3998.140399814025, 4011.4183443400543, 5098.388193416814, 5881.823635272963, 5920.703964801785, 5964.284285885678, 5968.552358573124, 3591.6587924147166, 4085.428040074392, 4089.2230476209425, 4104.240715467648, 4104.8152833122585, 3965.464662270614, 4095.0990782027907, 4133.545310015896, 4144.48193975753, 4151.232022075926, 4343.84888004679, 4630.976845115752, 4697.684648298482, 4714.147940496019, 4720.811167553259, 5624.746886390122, 5722.942770572241, 5737.913931291034, 5745.88508229833, 5764.913526297109, 1170.8887655672868, 1257.9685507862378, 1294.8899343555904, 1379.537854818627, 1398.3847107272768, 711.9038929744522, 853.8420392227458, 855.7689423855525, 863.218786997768, 864.9783755406165, 4221.78891055446, 4429.446319210098, 4603.930941035887, 4631.374764406829, 4635.397398338195, 4276.764777937181, 4551.499335073139, 4924.581410580069, 4955.515258690891, 4993.550580447777, 4185.351270553069, 4226.964393723558, 4285.500224764048, 4485.161083955562, 4525.637948964075, 2307.5961706701596, 2400.351904985644, 2495.6506089147533, 2518.0683147235272, 2532.556802559545, 4306.827726890952, 4408.647308215335, 4522.547745225451, 4766.594839438687, 5087.338645976073, 4402.933955990663, 4582.427196600425, 4901.926471102936, 5034.521720436553, 5040.697558146449, 5048.081728942978, 5086.92369614456, 5461.699606521679, 5513.952349053667, 6224.253089629274, 4876.122297986255, 5410.918836217538, 5653.321601407857, 5705.343885453226, 5994.88010239784, 4613.7923793430045, 4699.741514216614, 5546.918350921693, 5553.305836770403, 5865.882682346414, 4955.281484184701, 5451.918221226764, 6042.395760423922, 6126.448619624255, 6140.986737188493, 3339.7328213743326, 3914.805984174854, 3993.4608827807874, 4044.373122166069, 4061.1877624474632, 5671.943280567141, 5896.587238893237, 5997.880042399041, 5998.59033127206, 6011.72947217385, 5281.841544753664, 5381.946180538144, 5517.606671896835, 5793.971030144822, 5816.738246778989, 5266.447023062523, 5334.3865455473115, 5764.866999210319, 5813.912791308218, 5856.652969817052, 4957.553820156059, 5357.437469065692, 5508.81560464502, 5679.290088738908, 5722.456366645162, 5050.368703912011, 5084.771185296597, 5615.943840561706, 5844.444777746107, 5851.678157701197, 5355.27329474749, 5727.6849773262875, 5734.455226753452, 5762.6830524319885, 5779.075347944308], "value": 4020.4056073058855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5062333548191, 771.1825465007092, 790.8457850719105, 813.2274339377591, 851.9872201916972, 15811.762823557641, 16264.0, 16993.405230816923, 17053.573660658476, 17093.57266068349, 15007.549773506813, 15393.69212615747, 15411.0, 15412.614684632861, 15441.150736709476, 715.899774031636, 738.1584993107862, 865.5672163918041, 884.8628462588277, 887.2946007923716, 895.9820803583924, 910.2490445382552, 920.8020275640736, 921.3274309753883, 922.8062106957514, 818.1859050245015, 957.3681370295607, 959.9568019439107, 960.7454024683465, 964.5466630683568, 954.9856752148723, 955.4171955107379, 955.8088382323563, 955.8757361543024, 956.039180623469, 705.3898377903129, 705.5942832871119, 706.20199174932, 708.0759608710631, 708.4332533972853, 15588.0, 15651.060936343856, 15656.21718914061, 15664.21678916061, 15690.607734806721, 13985.650358741012, 14792.704145917129, 14937.551873443814, 15029.624259393493, 15130.470433534883, 13539.932300338534, 13662.521811736542, 13743.106698064594, 13749.450021999108, 13834.446622135103, 4709.1288111699105, 4711.929321060187, 4767.381076842669, 4868.123737727207, 4957.405111386621, 123448.0, 130424.0, 130530.3473482636, 130719.0, 133076.33461832727, 10996.28524145928, 11101.555937762561, 11182.384968826793, 11277.830832537518, 11375.943120284346, 21032.369028929155, 21284.574308514053, 21298.25456109029, 21370.679439808417, 21394.144234230767, 7888.566128862968, 8010.799730006796, 8130.918690813134, 8156.0620528639965, 8160.714374996846, 4548.363229147922, 4563.498015218323, 4600.125976064537, 4625.468071171791, 4699.4360676718325, 3732.234891847165, 3808.352580061396, 3902.453656488094, 3903.590123037097, 3911.9217615647526, 698.6192525073847, 718.0, 726.1105146195868, 731.5318196354337, 731.802413348393, 553.6650326552458, 575.8877018981342, 633.0596721049967, 706.7950294414665, 710.6588837358097, 8743.825123497494, 8745.518996455128, 9404.200642945427, 9584.424934503813, 10008.3494572854, 661.609650306312, 672.5930811858852, 699.8460338725472, 701.6596950479013, 717.6232477949119, 4801.759912004386, 4824.059308434892, 4905.452323831404, 4950.455449900508, 4980.775865086008, 163428.0, 168197.0, 169199.0, 171168.0, 175567.0, 137589.0, 140457.0, 141401.0, 145063.0, 145369.7315134239, 119252.0, 121182.78817211714, 122134.0, 124672.75327246793, 128288.0, 9281.164695177466, 9329.346945713734, 9519.714408567754, 9521.523923803921, 9525.095115963972, 62065.06902396558, 63665.68447877692, 64702.67648661727, 65863.0, 66826.33173668201, 92230.07769922483, 95698.04301956891, 96913.51543242238, 98409.0, 98966.5051674737, 11912.0, 12223.694407639525, 12327.50689972391, 12513.0, 12759.553415630407, 11389.373584452935, 13306.401211945293, 13609.251491168081, 13660.180389176681, 13810.723785524033, 11763.529458821551, 12290.815637765261, 12309.322987235788, 12778.105532612999, 12902.290374029519, 12418.441170147184, 12468.251904885736, 12647.430865610886, 12771.233725976472, 12834.871651283742, 12013.63959081229, 12119.81820272679, 12288.078394120297, 12289.631311060682, 12383.504659813507, 9704.611815527582, 10245.463180522982, 10845.0, 11143.888561114285, 11318.547258109913, 10362.481875906326, 10951.56193752241, 10978.503698555392, 11045.668629941114, 11120.555177793121], "value": 8132.778061477946, "unit": "score"}], "name": "dromaeo_css", "value": 7545.871491886916, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 162.0, 167.0, 114.0, 111.0, 112.0, 113.0, 112.0, 113.0, 112.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 144.0, 171.0, 134.0, 107.0, 111.0, 106.0, 137.0, 107.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 182.0, 185.0, 185.0, 182.0, 182.0, 194.0, 219.0, 183.0], "value": 187.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 87.0, 60.0, 59.0, 61.0, 58.0, 80.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 72.0, 94.0, 68.0, 66.0, 69.0, 91.0, 68.0, 68.0, 89.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 87.0, 84.0, 87.0, 85.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 149.0, 138.0, 95.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 84.0, 85.0, 86.0, 87.0, 83.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 52.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 69.0, 77.0, 71.0, 67.0, 68.0, 69.0, 68.0, 69.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 84.0, 82.0, 91.0, 95.0, 99.0, 85.0, 82.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 138.0, 135.0, 130.0, 141.0, 149.0, 132.0, 187.0, 143.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 158.0, 213.0, 142.0, 200.0, 216.0, 204.0, 159.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1453.5000000000002, "alertThreshold": 2.0}]} 08:23:58 INFO - Return code: 0 08:23:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:58 INFO - # TBPL SUCCESS # 08:23:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:58 INFO - 2016-11-18 08:23:58.610 screenresolution[1656:9806] starting screenresolution argv=screenresolution get 08:23:58 INFO - 2016-11-18 08:23:58.613 screenresolution[1656:9806] Display 0: 1600x1200x32@60 08:23:58 INFO - 2016-11-18 08:23:58.619 screenresolution[1657:9809] starting screenresolution argv=screenresolution list 08:23:58 INFO - Available Modes on Display 0 08:23:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:58 INFO - Intel Iris: 08:23:58 INFO - Chipset Model: Intel Iris 08:23:58 INFO - Type: GPU 08:23:58 INFO - Bus: Built-In 08:23:58 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:58 INFO - Vendor: Intel (0x8086) 08:23:58 INFO - Device ID: 0x0a2e 08:23:58 INFO - Revision ID: 0x0009 08:23:58 INFO - Displays: 08:23:58 INFO - Display: 08:23:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:58 INFO - Display Serial Number: 1600x1200 60 08:23:58 INFO - Main Display: Yes 08:23:58 INFO - Mirror: Off 08:23:58 INFO - Online: Yes 08:23:58 INFO - Rotation: Supported 08:23:58 INFO - Return code: 0 08:23:58 INFO - Running post-action listener: _resource_record_post_action 08:23:58 INFO - [mozharness: 2016-11-18 16:23:58.861582Z] Finished run-tests step (success) 08:23:58 INFO - Running post-run listener: _resource_record_post_run 08:23:58 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37728256; Write bytes: 493985280; Read time: 370; Write time: 1719 08:23:58 INFO - TinderboxPrint: CPU usage
53.4% 08:23:58 INFO - TinderboxPrint: I/O read bytes / time
37,728,256 / 370 08:23:58 INFO - TinderboxPrint: I/O write bytes / time
493,985,280 / 1,719 08:23:58 INFO - TinderboxPrint: CPU idle
2,227.4 (46.6%) 08:23:58 INFO - TinderboxPrint: CPU system
957.7 (20.0%) 08:23:58 INFO - TinderboxPrint: CPU user
1,596.5 (33.4%) 08:23:58 INFO - TinderboxPrint: Swap in / out
233,885,696 / 0 08:23:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196114944; Write bytes: 196929024; Read time: 17891; Write time: 389 08:23:58 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33611776; Write bytes: 295696384; Read time: 336; Write time: 1324 08:23:59 INFO - Running post-run listener: _upload_blobber_files 08:23:59 INFO - Blob upload gear active. 08:23:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:59 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 08:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:23:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:00 INFO - (blobuploader) - INFO - Done attempting. 08:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:01 INFO - (blobuploader) - INFO - Done attempting. 08:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:04 INFO - (blobuploader) - INFO - Done attempting. 08:24:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:04 INFO - Return code: 0 08:24:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7653540a4f559812719b6851668da311ad712b38ca86209046512151e8d2e08ba887990ce965a86858570583afce06bc92390240fc0ac6e292dcedc7d2559fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3d126999de65c3591d22ce04b75feb000357edb6a455e3fe348b9a31df8beac0c563f1cf0cc2e2b3ccf3f0793b1e53092c693d22a76a774ad0f35246785878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6694286ad8eb8efd26c1114b35f9c1afecd1d852e53bd11f5b18bf49c51f65c0fba2723280380ebe84bded3ba6677ea3967832fc80e44397946f4c271d8c2c8"} 08:24:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:04 INFO - Contents: 08:24:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7653540a4f559812719b6851668da311ad712b38ca86209046512151e8d2e08ba887990ce965a86858570583afce06bc92390240fc0ac6e292dcedc7d2559fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3d126999de65c3591d22ce04b75feb000357edb6a455e3fe348b9a31df8beac0c563f1cf0cc2e2b3ccf3f0793b1e53092c693d22a76a774ad0f35246785878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6694286ad8eb8efd26c1114b35f9c1afecd1d852e53bd11f5b18bf49c51f65c0fba2723280380ebe84bded3ba6677ea3967832fc80e44397946f4c271d8c2c8"} 08:24:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:04 INFO - Copying logs to upload dir... 08:24:04 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.780376 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-11-18 08:24:04.287265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:04.290502) ========= 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.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-Beta/sha512/d7653540a4f559812719b6851668da311ad712b38ca86209046512151e8d2e08ba887990ce965a86858570583afce06bc92390240fc0ac6e292dcedc7d2559fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3d126999de65c3591d22ce04b75feb000357edb6a455e3fe348b9a31df8beac0c563f1cf0cc2e2b3ccf3f0793b1e53092c693d22a76a774ad0f35246785878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6694286ad8eb8efd26c1114b35f9c1afecd1d852e53bd11f5b18bf49c51f65c0fba2723280380ebe84bded3ba6677ea3967832fc80e44397946f4c271d8c2c8"} build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010473 build_url: 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7653540a4f559812719b6851668da311ad712b38ca86209046512151e8d2e08ba887990ce965a86858570583afce06bc92390240fc0ac6e292dcedc7d2559fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3d126999de65c3591d22ce04b75feb000357edb6a455e3fe348b9a31df8beac0c563f1cf0cc2e2b3ccf3f0793b1e53092c693d22a76a774ad0f35246785878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6694286ad8eb8efd26c1114b35f9c1afecd1d852e53bd11f5b18bf49c51f65c0fba2723280380ebe84bded3ba6677ea3967832fc80e44397946f4c271d8c2c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:04.322575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:04.322908) ========= 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.FY7F7pg2F8/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.wb9nOURkGt/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.004672 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:04.371075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:24:04.371389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:24:04.371724) ========= ========= Total master_lag: 0.17 =========