builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1490358428.15 results: success (0) buildid: 20170324035015 builduid: 410510bd783b49cd9d850c9ec164e6a6 revision: 47ef934c86b53f4e64abc3b56c93899dc429e075 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.147215) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.147655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.147931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.174322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.174667) ========= 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.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 --2017-03-24 05:27:08-- 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% 8.57M=0.001s 2017-03-24 05:27:08 (8.57 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.329164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.329476) ========= 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.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.027824 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:08.379450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 05:27:08.382684) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 47ef934c86b53f4e64abc3b56c93899dc429e075 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 47ef934c86b53f4e64abc3b56c93899dc429e075 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 2017-03-24 05:27:08,480 truncating revision to first 12 chars 2017-03-24 05:27:08,481 Setting DEBUG logging. 2017-03-24 05:27:08,481 attempt 1/10 2017-03-24 05:27:08,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/47ef934c86b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 05:27:10,213 unpacking tar archive at: mozilla-aurora-47ef934c86b5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.022189 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 05:27:10.702706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:10.703044) ========= script_repo_revision: 47ef934c86b53f4e64abc3b56c93899dc429e075 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:10.703442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:10.703814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 05:27:10.724350) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-24 05:27:10.725040) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:27:10 INFO - MultiFileLogger online at 20170324 05:27:10 in /builds/slave/test 05:27:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:27:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:10 INFO - {'append_to_log': False, 05:27:10 INFO - 'base_work_dir': '/builds/slave/test', 05:27:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:27:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:10 INFO - 'branch': 'Mozilla-Aurora', 05:27:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:10 INFO - 'config_files': ('talos/mac_config.py',), 05:27:10 INFO - 'default_actions': ('clobber', 05:27:10 INFO - 'read-buildbot-config', 05:27:10 INFO - 'download-and-extract', 05:27:10 INFO - 'populate-webroot', 05:27:10 INFO - 'create-virtualenv', 05:27:10 INFO - 'install', 05:27:10 INFO - 'run-tests'), 05:27:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:10 INFO - 'download_minidump_stackwalk': True, 05:27:10 INFO - 'download_symbols': 'ondemand', 05:27:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:10 INFO - 'gecko_profile': False, 05:27:10 INFO - 'gecko_profile_interval': 0, 05:27:10 INFO - 'installer_path': 'installer.exe', 05:27:10 INFO - 'log_level': 'info', 05:27:10 INFO - 'log_name': 'talos', 05:27:10 INFO - 'log_to_console': True, 05:27:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:27:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:27:10 INFO - 'opt_config_files': (), 05:27:10 INFO - 'pip_index': False, 05:27:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:10 INFO - 'cmd': ('bash', 05:27:10 INFO - '-c', 05:27:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:10 INFO - 'enabled': True, 05:27:10 INFO - 'halt_on_failure': False, 05:27:10 INFO - 'name': 'check_screen_resolution'},), 05:27:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:10 INFO - 'cmd': ('bash', 05:27:10 INFO - '-c', 05:27:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:10 INFO - 'enabled': True, 05:27:10 INFO - 'halt_on_failure': False, 05:27:10 INFO - 'name': 'check_screen_resolution'},), 05:27:10 INFO - 'run_cmd_checks_enabled': True, 05:27:10 INFO - 'suite': 'dromaeojs', 05:27:10 INFO - 'system_bits': '32', 05:27:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:10 INFO - 'title': 't-yosemite-r7-0051', 05:27:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:10 INFO - 'use_talos_json': True, 05:27:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:10 INFO - 'work_dir': 'build'} 05:27:10 INFO - [mozharness: 2017-03-24 12:27:10.928155Z] Running clobber step. 05:27:10 INFO - Running pre-action listener: _resource_record_pre_action 05:27:10 INFO - Running main action method: clobber 05:27:10 INFO - rmtree: /builds/slave/test/build 05:27:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:13 INFO - Running post-action listener: _resource_record_post_action 05:27:13 INFO - [mozharness: 2017-03-24 12:27:13.399936Z] Finished clobber step (success) 05:27:13 INFO - [mozharness: 2017-03-24 12:27:13.400069Z] Running read-buildbot-config step. 05:27:13 INFO - Running pre-action listener: _resource_record_pre_action 05:27:13 INFO - Running main action method: read_buildbot_config 05:27:13 INFO - Using buildbot properties: 05:27:13 INFO - { 05:27:13 INFO - "project": "", 05:27:13 INFO - "product": "firefox", 05:27:13 INFO - "script_repo_revision": "production", 05:27:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:27:13 INFO - "repository": "", 05:27:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:27:13 INFO - "buildid": "20170324035015", 05:27:13 INFO - "pgo_build": "False", 05:27:13 INFO - "basedir": "/builds/slave/test", 05:27:13 INFO - "buildnumber": 25, 05:27:13 INFO - "slavename": "t-yosemite-r7-0051", 05:27:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:27:13 INFO - "platform": "yosemite_r7", 05:27:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:27:13 INFO - "branch": "mozilla-aurora", 05:27:13 INFO - "repo_path": "releases/mozilla-aurora", 05:27:13 INFO - "revision": "47ef934c86b53f4e64abc3b56c93899dc429e075", 05:27:13 INFO - "stage_platform": "macosx64", 05:27:13 INFO - "builduid": "410510bd783b49cd9d850c9ec164e6a6", 05:27:13 INFO - "slavebuilddir": "test" 05:27:13 INFO - } 05:27:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 05:27:13 INFO - Running post-action listener: _resource_record_post_action 05:27:13 INFO - [mozharness: 2017-03-24 12:27:13.403534Z] Finished read-buildbot-config step (success) 05:27:13 INFO - [mozharness: 2017-03-24 12:27:13.403669Z] Running download-and-extract step. 05:27:13 INFO - Running pre-action listener: _resource_record_pre_action 05:27:13 INFO - Running main action method: download_and_extract 05:27:13 INFO - mkdir: /builds/slave/test/build/tests 05:27:13 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')]} 05:27:13 INFO - trying https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 05:27:13 INFO - Downloading https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 05:27:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 05:27:14 INFO - Downloaded 1199 bytes. 05:27:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 05:27:14 INFO - Using the following test package requirements: 05:27:14 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 05:27:14 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 05:27:14 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 05:27:14 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'jsshell-mac.zip'], 05:27:14 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 05:27:14 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 05:27:14 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 05:27:14 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 05:27:14 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 05:27:14 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:27:14 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 05:27:14 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:27:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 05:27:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:27:14 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 05:27:16 INFO - Expected file size: 51787374 05:27:16 INFO - Obtained file size: 51787374 05:27:31 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:27:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 05:27:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:27:31 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 05:27:33 INFO - Expected file size: 51787374 05:27:33 INFO - Obtained file size: 51787374 05:27:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 05:27:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:27:48 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 05:27:49 INFO - Expected file size: 14404438 05:27:49 INFO - Obtained file size: 14404438 05:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:49 INFO - trying https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:27:49 INFO - Downloading https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 05:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 05:27:51 INFO - Downloaded 74764371 bytes. 05:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:27:51 INFO - mkdir: /builds/slave/test/properties 05:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:51 INFO - Contents: 05:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:27:52 INFO - Running post-action listener: _resource_record_post_action 05:27:52 INFO - Running post-action listener: set_extra_try_arguments 05:27:52 INFO - [mozharness: 2017-03-24 12:27:52.954504Z] Finished download-and-extract step (success) 05:27:52 INFO - [mozharness: 2017-03-24 12:27:52.954666Z] Running populate-webroot step. 05:27:52 INFO - Running pre-action listener: _resource_record_pre_action 05:27:52 INFO - Running main action method: populate_webroot 05:27:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:52 INFO - '--tppagecycles', 05:27:52 INFO - '7'], 05:27:52 INFO - 'tests': ['tsvgm']}}, 05:27:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['damp', 'tps']}, 05:27:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'tests': ['damp', 'tps']}, 05:27:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['dromaeo_dom']}, 05:27:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['basic_compositor_video']}, 05:27:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['a11yr', 05:27:52 INFO - 'ts_paint', 05:27:52 INFO - 'tpaint', 05:27:52 INFO - 'sessionrestore', 05:27:52 INFO - 'sessionrestore_no_auto_restore', 05:27:52 INFO - 'tabpaint']}, 05:27:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['tsvgx', 05:27:52 INFO - 'tsvgr_opacity', 05:27:52 INFO - 'tart', 05:27:52 INFO - 'tscrollx', 05:27:52 INFO - 'cart', 05:27:52 INFO - 'tsvg_static']}, 05:27:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:52 INFO - 'tsvgr_opacity', 05:27:52 INFO - 'tart', 05:27:52 INFO - 'tscrollx', 05:27:52 INFO - 'cart', 05:27:52 INFO - 'tsvg_static']}, 05:27:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'talos_options': ['--disable-e10s'], 05:27:52 INFO - 'tests': ['tp5o']}, 05:27:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:27:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'talos_options': ['--disable-e10s', 05:27:52 INFO - '--xperf_path', 05:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:52 INFO - 'tests': ['tp5n']}, 05:27:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:27:52 INFO - 'talos_options': ['--xperf_path', 05:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:52 INFO - 'tests': ['tp5n']}}, 05:27:52 INFO - 'talos.zip': {'path': '', 05:27:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:52 INFO - Running post-action listener: _resource_record_post_action 05:27:52 INFO - [mozharness: 2017-03-24 12:27:52.973365Z] Finished populate-webroot step (success) 05:27:52 INFO - [mozharness: 2017-03-24 12:27:52.973496Z] Running create-virtualenv step. 05:27:52 INFO - Running pre-action listener: _resource_record_pre_action 05:27:52 INFO - Running main action method: create_virtualenv 05:27:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:52 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 05:27:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:53 INFO - Using real prefix '/tools/python27' 05:27:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:56 INFO - Installing pip.................done. 05:27:56 INFO - Return code: 0 05:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:27:57 INFO - Reading from file tmpfile_stdout 05:27:57 INFO - Output received: 05:27:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:27:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:57 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:27:57 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 05:27:57 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 05:27:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:27:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:57 INFO - 'HOME': '/Users/cltbld', 05:27:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:57 INFO - 'LOGNAME': 'cltbld', 05:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:57 INFO - 'MOZ_NO_REMOTE': '1', 05:27:57 INFO - 'NO_EM_RESTART': '1', 05:27:57 INFO - 'PAGER': '/bin/cat', 05:27:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:57 INFO - 'PWD': '/builds/slave/test', 05:27:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:57 INFO - 'SHELL': '/bin/bash', 05:27:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:27:57 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:27:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:57 INFO - 'USER': 'cltbld', 05:27:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:57 INFO - 'XPC_FLAGS': '0x0', 05:27:57 INFO - 'XPC_SERVICE_NAME': '0', 05:27:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:58 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 05:27:58 INFO - Cleaning up... 05:27:58 INFO - Return code: 0 05:27:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:58 INFO - 'HOME': '/Users/cltbld', 05:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:58 INFO - 'LOGNAME': 'cltbld', 05:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:58 INFO - 'MOZ_NO_REMOTE': '1', 05:27:58 INFO - 'NO_EM_RESTART': '1', 05:27:58 INFO - 'PAGER': '/bin/cat', 05:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:58 INFO - 'PWD': '/builds/slave/test', 05:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:58 INFO - 'SHELL': '/bin/bash', 05:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:27:58 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:58 INFO - 'USER': 'cltbld', 05:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:58 INFO - 'XPC_FLAGS': '0x0', 05:27:58 INFO - 'XPC_SERVICE_NAME': '0', 05:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:58 INFO - Downloading/unpacking psutil>=3.1.1 05:27:58 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 05:27:58 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 05:27:58 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 05:27:58 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 05:27:58 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 05:27:58 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 05:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:02 INFO - Installing collected packages: psutil 05:28:02 INFO - Running setup.py install for psutil 05:28:02 INFO - building 'psutil._psutil_osx' extension 05:28:02 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 05:28:03 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 05:28:03 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 05:28:03 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 05:28:03 INFO - building 'psutil._psutil_posix' extension 05:28:03 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 05:28:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:28:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:28:03 INFO - ^ 05:28:03 INFO - 1 warning generated. 05:28:03 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 05:28:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:03 INFO - Successfully installed psutil 05:28:03 INFO - Cleaning up... 05:28:03 INFO - Return code: 0 05:28:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:03 INFO - 'HOME': '/Users/cltbld', 05:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:03 INFO - 'LOGNAME': 'cltbld', 05:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:03 INFO - 'MOZ_NO_REMOTE': '1', 05:28:03 INFO - 'NO_EM_RESTART': '1', 05:28:03 INFO - 'PAGER': '/bin/cat', 05:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:03 INFO - 'PWD': '/builds/slave/test', 05:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:03 INFO - 'SHELL': '/bin/bash', 05:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:03 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:03 INFO - 'USER': 'cltbld', 05:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:03 INFO - 'XPC_FLAGS': '0x0', 05:28:03 INFO - 'XPC_SERVICE_NAME': '0', 05:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28:04 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 05:28:04 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 05:28:04 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 05:28:04 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 05:28:04 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 05:28:04 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 05:28:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:06 INFO - Installing collected packages: mozsystemmonitor 05:28:06 INFO - Running setup.py install for mozsystemmonitor 05:28:07 INFO - Successfully installed mozsystemmonitor 05:28:07 INFO - Cleaning up... 05:28:07 INFO - Return code: 0 05:28:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28:07 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')]} 05:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:07 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')]} 05:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:07 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:07 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 05:28:07 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 05:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:07 INFO - 'HOME': '/Users/cltbld', 05:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:07 INFO - 'LOGNAME': 'cltbld', 05:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:07 INFO - 'MOZ_NO_REMOTE': '1', 05:28:07 INFO - 'NO_EM_RESTART': '1', 05:28:07 INFO - 'PAGER': '/bin/cat', 05:28:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:07 INFO - 'PWD': '/builds/slave/test', 05:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:07 INFO - 'SHELL': '/bin/bash', 05:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:07 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:07 INFO - 'USER': 'cltbld', 05:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:07 INFO - 'XPC_FLAGS': '0x0', 05:28:07 INFO - 'XPC_SERVICE_NAME': '0', 05:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:07 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 05:28:07 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 05:28:07 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 05:28:07 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 05:28:07 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 05:28:07 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 05:28:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:10 INFO - warning: no files found matching '*.txt' 05:28:10 INFO - no previously-included directories found matching 'build' 05:28:10 INFO - no previously-included directories found matching 'dist' 05:28:10 INFO - no previously-included directories found matching '.git*' 05:28:10 INFO - Installing collected packages: jsonschema, functools32 05:28:10 INFO - Running setup.py install for functools32 05:28:10 INFO - warning: no files found matching '*.txt' 05:28:10 INFO - no previously-included directories found matching 'build' 05:28:10 INFO - no previously-included directories found matching 'dist' 05:28:10 INFO - no previously-included directories found matching '.git*' 05:28:10 INFO - Successfully installed jsonschema functools32 05:28:10 INFO - Cleaning up... 05:28:10 INFO - Return code: 0 05:28:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:10 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')]} 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:10 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')]} 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:10 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:10 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 05:28:10 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 05:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:10 INFO - 'HOME': '/Users/cltbld', 05:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:10 INFO - 'LOGNAME': 'cltbld', 05:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:10 INFO - 'MOZ_NO_REMOTE': '1', 05:28:10 INFO - 'NO_EM_RESTART': '1', 05:28:10 INFO - 'PAGER': '/bin/cat', 05:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:10 INFO - 'PWD': '/builds/slave/test', 05:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:10 INFO - 'SHELL': '/bin/bash', 05:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:10 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:10 INFO - 'USER': 'cltbld', 05:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:10 INFO - 'XPC_FLAGS': '0x0', 05:28:10 INFO - 'XPC_SERVICE_NAME': '0', 05:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:11 INFO - Cleaning up... 05:28:11 INFO - Return code: 0 05:28:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:11 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')]} 05:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:11 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')]} 05:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:11 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:11 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 05:28:11 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 05:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:11 INFO - 'HOME': '/Users/cltbld', 05:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:11 INFO - 'LOGNAME': 'cltbld', 05:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:11 INFO - 'MOZ_NO_REMOTE': '1', 05:28:11 INFO - 'NO_EM_RESTART': '1', 05:28:11 INFO - 'PAGER': '/bin/cat', 05:28:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:11 INFO - 'PWD': '/builds/slave/test', 05:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:11 INFO - 'SHELL': '/bin/bash', 05:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:11 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:11 INFO - 'USER': 'cltbld', 05:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:11 INFO - 'XPC_FLAGS': '0x0', 05:28:11 INFO - 'XPC_SERVICE_NAME': '0', 05:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:11 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:11 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 05:28:11 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 05:28:11 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 05:28:11 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 05:28:11 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 05:28:11 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 05:28:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:14 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 05:28:15 INFO - Downloading docopt-0.6.1.tar.gz 05:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:15 INFO - Running setup.py install for blobuploader 05:28:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:15 INFO - Running setup.py install for requests 05:28:16 INFO - Running setup.py install for docopt 05:28:16 INFO - Successfully installed blobuploader requests docopt 05:28:16 INFO - Cleaning up... 05:28:16 INFO - Return code: 0 05:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:16 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')]} 05:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:16 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')]} 05:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:16 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:16 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 05:28:16 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 05:28:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:16 INFO - 'HOME': '/Users/cltbld', 05:28:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:16 INFO - 'LOGNAME': 'cltbld', 05:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:16 INFO - 'MOZ_NO_REMOTE': '1', 05:28:16 INFO - 'NO_EM_RESTART': '1', 05:28:16 INFO - 'PAGER': '/bin/cat', 05:28:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:16 INFO - 'PWD': '/builds/slave/test', 05:28:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:16 INFO - 'SHELL': '/bin/bash', 05:28:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:16 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:16 INFO - 'USER': 'cltbld', 05:28:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:16 INFO - 'XPC_FLAGS': '0x0', 05:28:16 INFO - 'XPC_SERVICE_NAME': '0', 05:28:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:16 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-pQpdKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:16 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-3GaHwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:16 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ifuad7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:16 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-KdnfET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:16 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-QxHi3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-af3QZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-3y0MgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-H38s9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-i_j_HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-9D9TC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-KemX2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-HtSiaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ghd9uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-HREcmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:17 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-wzKIxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:18 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-yIm0tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:18 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-8GFGlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:18 INFO - Running setup.py install for manifestparser 05:28:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:18 INFO - Running setup.py install for mozcrash 05:28:18 INFO - Running setup.py install for mozdebug 05:28:18 INFO - Running setup.py install for mozdevice 05:28:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:18 INFO - Running setup.py install for mozfile 05:28:19 INFO - Running setup.py install for mozhttpd 05:28:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Running setup.py install for mozinfo 05:28:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Running setup.py install for mozInstall 05:28:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Running setup.py install for mozleak 05:28:19 INFO - Running setup.py install for mozlog 05:28:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Running setup.py install for moznetwork 05:28:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:19 INFO - Running setup.py install for mozprocess 05:28:20 INFO - Running setup.py install for mozprofile 05:28:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:20 INFO - Running setup.py install for mozrunner 05:28:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:20 INFO - Running setup.py install for mozscreenshot 05:28:20 INFO - Running setup.py install for moztest 05:28:20 INFO - Running setup.py install for mozversion 05:28:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:20 INFO - Cleaning up... 05:28:20 INFO - Return code: 0 05:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:20 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')]} 05:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:20 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')]} 05:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:20 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:20 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 05:28:20 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 05:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:20 INFO - 'HOME': '/Users/cltbld', 05:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:20 INFO - 'LOGNAME': 'cltbld', 05:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:20 INFO - 'MOZ_NO_REMOTE': '1', 05:28:20 INFO - 'NO_EM_RESTART': '1', 05:28:20 INFO - 'PAGER': '/bin/cat', 05:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:20 INFO - 'PWD': '/builds/slave/test', 05:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:20 INFO - 'SHELL': '/bin/bash', 05:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:20 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:20 INFO - 'USER': 'cltbld', 05:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:20 INFO - 'XPC_FLAGS': '0x0', 05:28:20 INFO - 'XPC_SERVICE_NAME': '0', 05:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-nr4tIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-viwkBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-e0BbP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-fYcrVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-FXDxM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-Io5LLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-fdD8d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-kRbPcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:21 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)) 05:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:21 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-7bniUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:22 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-RUK1YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:22 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-C4K2Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:22 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ZWGmql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-HqcrJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:22 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-mZNd7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-QIKSy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:22 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-7ahtzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 05:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:22 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-zxGy4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:22 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)) 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:22 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)) 05:28:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:28:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:28:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:25 INFO - Downloading blessings-1.6.tar.gz 05:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:25 INFO - Installing collected packages: blessings 05:28:25 INFO - Running setup.py install for blessings 05:28:25 INFO - Successfully installed blessings 05:28:25 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:26 INFO - Reading from file tmpfile_stdout 05:28:26 INFO - Current package versions: 05:28:26 INFO - blessings == 1.6 05:28:26 INFO - blobuploader == 1.2.4 05:28:26 INFO - docopt == 0.6.1 05:28:26 INFO - functools32 == 3.2.3-2 05:28:26 INFO - jsonschema == 2.5.1 05:28:26 INFO - manifestparser == 1.1 05:28:26 INFO - mozInstall == 1.12 05:28:26 INFO - mozcrash == 1.0 05:28:26 INFO - mozdebug == 0.1 05:28:26 INFO - mozdevice == 0.49 05:28:26 INFO - mozfile == 1.2 05:28:26 INFO - mozhttpd == 0.7 05:28:26 INFO - mozinfo == 0.9 05:28:26 INFO - mozleak == 0.1 05:28:26 INFO - mozlog == 3.4 05:28:26 INFO - moznetwork == 0.27 05:28:26 INFO - mozprocess == 0.25 05:28:26 INFO - mozprofile == 0.28 05:28:26 INFO - mozrunner == 6.13 05:28:26 INFO - mozscreenshot == 0.1 05:28:26 INFO - mozsystemmonitor == 0.3 05:28:26 INFO - moztest == 0.8 05:28:26 INFO - mozversion == 1.4 05:28:26 INFO - psutil == 3.1.1 05:28:26 INFO - requests == 1.2.3 05:28:26 INFO - wsgiref == 0.1.2 05:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:26 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')]} 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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')]} 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:26 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 05:28:26 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 05:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:26 INFO - 'HOME': '/Users/cltbld', 05:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:26 INFO - 'LOGNAME': 'cltbld', 05:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:26 INFO - 'MOZ_NO_REMOTE': '1', 05:28:26 INFO - 'NO_EM_RESTART': '1', 05:28:26 INFO - 'PAGER': '/bin/cat', 05:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:26 INFO - 'PWD': '/builds/slave/test', 05:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:26 INFO - 'SHELL': '/bin/bash', 05:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:26 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:26 INFO - 'USER': 'cltbld', 05:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:26 INFO - 'XPC_FLAGS': '0x0', 05:28:26 INFO - 'XPC_SERVICE_NAME': '0', 05:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 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)) 05:28:26 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28:26 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')]} 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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')]} 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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 0x109126b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109129768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b04c27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, '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.DdyI2cwS4b/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.9Ums2d4o66/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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 05:28:26 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 05:28:26 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 05:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:26 INFO - 'HOME': '/Users/cltbld', 05:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:26 INFO - 'LOGNAME': 'cltbld', 05:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:26 INFO - 'MOZ_NO_REMOTE': '1', 05:28:26 INFO - 'NO_EM_RESTART': '1', 05:28:26 INFO - 'PAGER': '/bin/cat', 05:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:26 INFO - 'PWD': '/builds/slave/test', 05:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:26 INFO - 'SHELL': '/bin/bash', 05:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:26 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:26 INFO - 'USER': 'cltbld', 05:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:26 INFO - 'XPC_FLAGS': '0x0', 05:28:26 INFO - 'XPC_SERVICE_NAME': '0', 05:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:26 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Running post-action listener: _resource_record_post_action 05:28:26 INFO - Running post-action listener: _start_resource_monitoring 05:28:26 INFO - Starting resource monitoring. 05:28:26 INFO - [mozharness: 2017-03-24 12:28:26.841926Z] Finished create-virtualenv step (success) 05:28:26 INFO - [mozharness: 2017-03-24 12:28:26.842895Z] Running install step. 05:28:26 INFO - Running pre-action listener: _resource_record_pre_action 05:28:26 INFO - Running main action method: install 05:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:27 INFO - Reading from file tmpfile_stdout 05:28:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:27 INFO - Reading from file tmpfile_stdout 05:28:27 INFO - Output received: 05:28:27 INFO - Usage: mozinstall [options] installer 05:28:27 INFO - Options: 05:28:27 INFO - -h, --help show this help message and exit 05:28:27 INFO - -d DEST, --destination=DEST 05:28:27 INFO - Directory to install application into. [default: 05:28:27 INFO - "/builds/slave/test"] 05:28:27 INFO - --app=APP Application being installed. [default: firefox] 05:28:27 INFO - mkdir: /builds/slave/test/build/application 05:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:28:47 INFO - Reading from file tmpfile_stdout 05:28:47 INFO - Output received: 05:28:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:28:47 INFO - Running post-action listener: _resource_record_post_action 05:28:47 INFO - [mozharness: 2017-03-24 12:28:47.571268Z] Finished install step (success) 05:28:47 INFO - [mozharness: 2017-03-24 12:28:47.571419Z] Running run-tests step. 05:28:47 INFO - Running pre-action listener: _resource_record_pre_action 05:28:47 INFO - Running main action method: run_tests 05:28:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:47 INFO - 2017-03-24 05:28:47.586 screenresolution[1620:7345] starting screenresolution argv=screenresolution get 05:28:47 INFO - 2017-03-24 05:28:47.588 screenresolution[1620:7345] Display 0: 1600x1200x32@60 05:28:47 INFO - 2017-03-24 05:28:47.594 screenresolution[1621:7348] starting screenresolution argv=screenresolution list 05:28:47 INFO - Available Modes on Display 0 05:28:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:47 INFO - Intel Iris: 05:28:47 INFO - Chipset Model: Intel Iris 05:28:47 INFO - Type: GPU 05:28:47 INFO - Bus: Built-In 05:28:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:47 INFO - Vendor: Intel (0x8086) 05:28:47 INFO - Device ID: 0x0a2e 05:28:47 INFO - Revision ID: 0x0009 05:28:47 INFO - Displays: 05:28:47 INFO - Display: 05:28:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:47 INFO - Display Serial Number: 1600x1200 60 05:28:47 INFO - Main Display: Yes 05:28:47 INFO - Mirror: Off 05:28:47 INFO - Online: Yes 05:28:47 INFO - Rotation: Supported 05:28:47 INFO - Return code: 0 05:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:47 INFO - Python 2.7.3 05:28:47 INFO - Return code: 0 05:28:47 INFO - grabbing minidump binary from tooltool 05:28: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')]} 05:28:47 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 0x108f04d30>, '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 0x108e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:47 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 05:28:47 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 05:28:47 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 05:28:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:47 INFO - Return code: 0 05:28:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:47 INFO - ENV: RUST_BACKTRACE is now 1 05:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 05:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 05:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DdyI2cwS4b/Render', 05:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:47 INFO - 'HOME': '/Users/cltbld', 05:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:47 INFO - 'LOGNAME': 'cltbld', 05:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:47 INFO - 'MOZ_NO_REMOTE': '1', 05:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:47 INFO - 'NO_EM_RESTART': '1', 05:28:47 INFO - 'PAGER': '/bin/cat', 05:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:47 INFO - 'PWD': '/builds/slave/test', 05:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:47 INFO - 'RUST_BACKTRACE': '1', 05:28:47 INFO - 'SHELL': '/bin/bash', 05:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Ums2d4o66/Listeners', 05:28:47 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 05:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:47 INFO - 'USER': 'cltbld', 05:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:47 INFO - 'XPC_FLAGS': '0x0', 05:28:47 INFO - 'XPC_SERVICE_NAME': '0', 05:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 05:28:48 INFO - mozversion application_buildid: 20170324035015 05:28:48 INFO - mozversion application_changeset: 47ef934c86b53f4e64abc3b56c93899dc429e075 05:28:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:28:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:48 INFO - mozversion application_name: Firefox 05:28:48 INFO - mozversion application_remotingname: firefox-dev 05:28:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:28:48 INFO - mozversion application_vendor: Mozilla 05:28:48 INFO - mozversion application_version: 54.0a2 05:28:48 INFO - mozversion platform_buildid: 20170324035015 05:28:48 INFO - mozversion platform_changeset: 47ef934c86b53f4e64abc3b56c93899dc429e075 05:28:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:28:48 INFO - mozversion platform_version: 54.0a2 05:28:48 INFO - using testdate: 1490358528 05:28:48 INFO - actual date: 1490358528 05:28:48 INFO - starting webserver on 'localhost:49241' 05:28:48 INFO - SUITE-START | Running 2 tests 05:28:48 INFO - TEST-START | dromaeo_css 05:28:48 INFO - operating with platform_type : mac_ 05:28:48 INFO - Initialising browser for dromaeo_css test... 05:28:48 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpLe2TfF/profile http://localhost:49241/getInfo.html) 05:28:50 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 05:28:50 INFO - PROCESS | 1631 | colorDepth:24 05:28:50 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 05:28:50 INFO - PROCESS | 1631 | __metrics 05:28:50 INFO - PROCESS | 1631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:28:50 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:51 INFO - TEST-INFO | 1631: exit 0 05:28:51 INFO - Browser initialized. 05:28:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:51 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpLe2TfF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:03 INFO - PROCESS | 1633 | RSS: Main: 214663168 05:29:03 INFO - PROCESS | 1633 | 05:32:08 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:32:10 INFO - PROCESS | 1633 | RSS: Main: 374538240 05:32:10 INFO - PROCESS | 1633 | 05:33:53 INFO - PROCESS | 1633 | ************************* 05:33:53 INFO - PROCESS | 1633 | A coding exception was thrown and uncaught in a Task. 05:33:53 INFO - PROCESS | 1633 | 05:33:53 ERROR - PROCESS | 1633 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:53 INFO - PROCESS | 1633 | Full stack: 05:33:53 INFO - PROCESS | 1633 | ************************* 05:35:13 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:35:13 INFO - PROCESS | 1633 | RSS: Main: 369414144 05:35:13 INFO - PROCESS | 1633 | 05:38:16 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:38:16 INFO - PROCESS | 1633 | RSS: Main: 329469952 05:38:16 INFO - PROCESS | 1633 | 05:41:19 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:41:20 INFO - PROCESS | 1633 | RSS: Main: 335896576 05:41:20 INFO - PROCESS | 1633 | 05:44:23 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:44:24 INFO - PROCESS | 1633 | RSS: Main: 313782272 05:44:24 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:47:28 INFO - PROCESS | 1633 | RSS: Main: 457109504 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | __start_tp_report 05:47:28 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 05:47:28 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 05:47:28 INFO - PROCESS | 1633 | |i|pagename|runs| 05:47:28 INFO - PROCESS | 1633 | |0;dojo.html;3402.8468718907648;3415.4535274356094;3419.179396944733;3433.64371073426;3476.843542040608;5995.400459954002;6002.6998650067435;6003.418599566711;6033.366496517863;6092.482139018183;5931.406859314077;6012.248468941382;6024.789132380368;6027.126066720334;6058.939410605893;4514.480834704002;5342.305500284958;5357.973210133944;5376.274202982606;5398.568114550826;5276.8153114641;5286.10136276832;5468.863278418032;5479.808206712766;5518.310211223597;5335.146376579748;5361.169018802092;5389.6496727712765;5399.676019438846;5402.054640437927;5381.48875856793;5384.865378365533;5386.8922621547545;5387.865303367408;5390.730463476811;5242.947570524284;5341.958318127967;5349.358077030781;5351.652142610717;5369.731513424314;5957.791477298317;5967.955607768623;5970.6716130612795;5975.820725378246;5976.731047102848;6374.521910856658;6394.104825324458;6406.263279722798;6412.807615771488;6426.2931077581425;6416.743330266784;6444;6448.484121270287;6450.322716114834;6466.935330646727;5965;5994.190784244115;5995.640261584275;6010.8497287567725;6074.058520929263;6509.24762075773;6563.212414510193;6586.440152586988;6591.176102987127;6592.208934927791;5280.313559237275;6222.595531290452;6259.78090766821;6316.463100636405;6329.303776584572;6456.612603243821;6457.483401327976;6481.902771458432;6495.350464953467;6503.317151699098;5875.764969401176;6429.22849258092;6440.452561532322;6450.3549645036055;6470.1588793457495;6305.306416294204;6367.108604795332;6367.968160159169;6432.549721519449;6453.225612926479;5119.180931051014;5151;5164.509371609691;5165.664231824994;5187.766550505236;4159.230542349675;4522.932156017597;4556.225441674923;4563.178627847019;4588.908221835612;4712.858614241578;5748.540116790647;5865.237519122486;6108.17539632144;6114.633122012693;6409.391107844747;6414.486841052704;6443.097966284724;6494.707738151795;6504.38208370204;6074.301455332605;6116.48009919153;6138.631682098999;6140.140380346755;6146.323904370515;5694.914576281359;5697.515711164598;5703.54371650267;5706.771729130871;5725.942740572541;6382.36176382358;6391.744330226739;6570.342965703391;6613.768518101843;6665.700043497957;6498.0252962056065;6505.41451269388;6510.902336464862;6511.3163117871945;6516.837079073061;6614.338566143347;6620.569662971891;6678.699458524281;6697.464202863662;6714.563553369016;6238.438540531374;6278.340774218824;6278.4035516625845;6349.07938348946;6432.13166222554;5425.891482170414;6160.106784516131;6419.614823110628;6439.227292724903;6474.482041436768;6320.209973753281;6328.145700330397;6369.267534233622;6378.617282963037;6391.744330226739;6119.41115851624;6267.310595834546;6291.779787707592;6297.653629050446;6395.744170233139;6230.657313847782;6277.18396608438;6283.8114856554375;6287.717052732546;6288.9685551573775;6365.745370185326;6379.776707815204;6385.29761726219;6389.648569328731;6407.519436042222;5904.822855314347;5976.282846058501;5992.131140984446;6042.3655516170165;6066.878662426815 05:47:28 INFO - PROCESS | 1633 | |1;ext.html;752.7816933089405;787.2599756229145;807.7455601485533;873.7073080518027;884.8982367027794;24511.632325515133;32689.836550817243;40583.79708101463;40589.39115913264;40722.3711051558;40840;41056.178876422455;41075.17849643005;41106;41123;8995.865062024075;9154.404963677373;9161.770955726093;9162.17540421362;9167.312451566158;7139.143302803671;7342.963285183593;7391;7412.59230742309;7414.888776668327;10794.406307653077;10980.066694330992;10991.285566438195;10993.505292261827;11004.009639132477;10900.073493753001;10950.945245273762;10952.561897524089;10955.014048735573;10956.945215273952;7246.782596522113;10757.569697212102;10832.133429325713;10837.620683276127;10844.891551084467;27836.582451263246;39086.41370379447;39660.20679586392;40889.1822163558;40948.38577421341;3867.806609669505;3901.1222474943193;3901.473301104343;3940.8964500262255;4000.2999475092033;27125.457490850073;27270.04554840571;27955.709965257654;28699.426011479864;29161;2962.881484740608;2991.5443387832024;3003.993403929817;3040.6351237851377;3049.5120780675206;326692;329613;332484;332953;333619;52994.73502632539;53310.46689533132;53345.733271334175;53386.19920701192;53508.73245633747;55938.72030639821;55966.160507592416;56011.43988560144;56127.71936140293;56243.718781405834;14352.354144063542;14778.556643300719;14795.704085918436;14801.703965920622;14808.555743327717;12810.911072558936;12816.42326095328;12826.97384209261;12830.29433381173;12843.100982931104;10898.891011089787;11074.390908499949;12214.938925305316;12698.492060317669;12732;4059.89850253746;5345.1714984177515;5474.206240095164;5529.502344788988;5529.529989950819;922.3866129024258;1121.2991880074953;1123.5225029362489;1139.715071232192;1181.303031211572;23382.415439613804;26313.34216644561;26806;26868.865655671598;26903.327416814736;1141.7716456708692;1184.9809164118851;1225.2342286071205;1236.344737289238;1270.39021269791;13472.932635336761;13612.931935340457;13684.384202710902;13740.450381984809;13772.65568360799;449990;450026;450610;450745;451233;55490.890182196934;55498;55506;55588;55701;1396.6927275999265;1450.3255985966575;1454.2728635682158;1458.8103546539094;1460.9415623374946;23255.3023409298;24850.875745621157;25506.362340941625;25615.487690246464;25754.87122564375;46709.59871203869;46791.298130527386;46837.2974405391;46892;46967.29549056835;352643;421360;421377;422574;422811.8859405806;33594.49608255927;34192.14519637029;34261.97214083582;34355.656443436244;34501.30997380088;33596.160095997795;43345.34981975336;43361.13277734491;44432.77783611061;44800.55199448094;35809.46285805663;35965.84204947711;36050.63949360473;37291.88124356273;37576.624233758404;36063.819680901426;36420.81789591035;36922;37198.25603487969;37762;30637.62130704079;36834.44748328724;37083.629163708014;37111.81444092762;37127.81436092802;28223.57664635073;32351;32541.02376928696;32612.83693581517;32816.835915820266;24068.759312407354;24273.271801845975;24509.632355515037;24604.384890377885;24675.629865551673 05:47:28 INFO - PROCESS | 1633 | |2;jquery.html;382.34618801848836;400.4793768101469;420.48070632768514;426.09029721544505;437.4641064695748;12818.359082045896;14506.637334066654;20299.797002029994;20579.38261852143;21105.57788844222;21367.35897923061;21374;21949.78050219497;22248.555028899413;22549.323520294376;6353.777617783378;6378.968105159468;6503.93496065038;6614.338566143371;6615.603063816162;4143.150654115899;4438.933415998747;6522.184726909137;6615.900761488581;6629.502787290949;4379.496357918848;7425;7680.11678656956;7690.2694244046725;7706.075270967463;7087.574745515286;7386.335229829341;7564.016677831846;7667.693292268331;7706.576138312391;7057.611831349273;7252.746153884642;7316.158641756213;7333.816654583625;7334.596597187153;25684;25761.227163184947;25792.968281268728;25944.48111037769;26134.954601815905;2879.43850949065;3133.9216519586967;3265.314284000339;3274.5579346788118;3316.336732653479;12588.748225035448;15144.697106057927;15355;15652.68694626101;16231.350745970147;1908.532409559653;1908.570571621388;1910.8471322294183;1924.9903750481158;1943.679292916667;151601;151676.6973389704;158411.20794395954;159521;161869;18818.588605854617;19589.90205048994;19958.50103747418;20011.499712507302;20239.696404553943;27494.587581186297;31340.216494587818;31630.841845790623;31659.84170079181;31780.682193177774;9897.851532227023;10156.187504999582;10281.023302786223;10387.94806025965;10424.947875260576;7627.855821626689;8068.273855353046;8554.91445085541;8565;8712.738617841474;9057.728268151834;9141.908580914238;9272.119148680864;9328.067193280618;9329.673461428818;3718.6839118675216;3782.924341513154;3821.8662346817728;3822.503074600284;3851.094992676719;853.6457370191425;887.933404994628;890.3233542507611;890.7262614461252;918.7427520294328;20567;21416.678749818766;21480;21488.247911323342;21515;901.9549022548846;902.7517432706059;910.5538286239695;914.3279689428265;920.6363486422825;10427.297510510296;10966.506507207196;11076.778464430667;11157.888421115847;11166.274192177483;726795.3660231665;739989;740013;751512;790845.0915490772;99193;103365;110893;140827;144227.27886360712;1047.8690163729534;1106.8007758603528;1118.4016551145098;1137.7212582917073;1146.3122126724065;17864.821351786315;18010.009449480403;18497.982610955987;18544.443666690022;18751.90624046871;56396;57037.42962570321;57045;57487.712561438595;57909.55226119381;58661.12008319793;81135.78296325677;82178.58910705408;86606.56696716476;89869;11413.08695304357;11489.885101149215;11632.069434445055;11647.941760291144;12013.81979270329;12499.12506124599;12504.874951250735;12573.811392828931;12750.234985900875;12805.975521958035;9804.754881128029;10554.525046372779;10666.466676665981;10852.023317901427;10974.890251097388;7746.883796743166;10711.357318560911;10940.781184376427;10978.066864316303;11115.94398532138;9619.470929098967;10335.17318614524;10662;10779.568817247222;11016.889831101586;9046.366754327133;10261.435621040915;11266.098712102848;11572.36352000648;11574.594889178838;10398.428086455318;10441.738956526147;10515.737106572396;10631.627893023708;10836 05:47:28 INFO - PROCESS | 1633 | |3;mootools.html;1287.6201520551435;1517.8482151784822;1525.54233729881;1542.861142497175;1556.1985577427624;10853;11522.711932201699;11531.654050378482;11550.191486595942;11602.477888495017;10763.246572739912;11153.888461115386;11283.943580282086;11293.661190164308;11307.547698092087;2421.878906054699;2448.9755102448926;2453.82823202375;2458.50829834033;2460.9261722148362;2386.6658667786523;2416.7824895759377;2422.103821586016;2429.0526694589125;2430.914917977871;2385.1771138957033;2400.4478969836946;2414.8309618326725;2415.5893498105365;2421.2857207123852;2352.97647023531;2371.620540713486;2381.785639292472;2382.4996750682376;2384.6899903012586;2319.884005799703;2327.2320134355623;2397.0891061396733;2398;2401.0995876546294;11004.504797284142;11076.889231107747;11103.222774405795;11134.27627204229;11151.327300904848;5754.769809207627;5939.851503712399;5947.881042379171;5958.106284057383;5962.314333851619;3499.7025252853537;3598.676119149263;3631.4915911772373;3658.8902332930056;3687.115092377837;1145.5532342386393;1149.2013050929606;1169.8771628979005;1210.5702475621115;1215.3254943506352;13730.107543009672;14057.086289391156;14340.282985850667;15521.223938803128;15766.9211653941;3882.5535063467496;4813.15769740301;4817.349657796222;4821.156297647897;4846;10210.897891020995;11523.135764817673;11566.132540059529;11566.884331156749;11573.652790416301;4956.132676781549;5626.156076588544;5823.7379317929945;5834.912476312858;5847.649141051551;5181.248718935809;5276.551493123127;5331.253624492574;5360.571154307724;5362.034833729966;3905.511811023622;3907.374820028782;3941.802909854553;3988.700847436454;3995.260876737813;1052.1740433759462;1053.7629033467408;1055.9366438013744;1067.6423398161548;1068.6420049283577;873.1181506678174;918.9081091890891;933.1788026536605;938.7090002099371;976.9267304952157;5317.255584218213;5461.5357694596405;6756.459483241329;7105.609191494414;7130.536515126604;989.7674046599187;1015.6394479959656;1038.4692047039973;1042.99478502607;1056.3714589819044;4104.589541045872;4125.381192821101;4197.643200327945;4202.978985105055;4355.912881742347;13639.931800341134;14015.50945716895;14051.437942482185;14062.71874562503;14102.576922692335;13781.586552403443;13935.721285574231;13946.372413241428;13971.952103592272;13972.72054558903;8388.496690198608;10246.436445995392;10325.690229293134;10332.328398654063;10342.482875856327;5604.8318550443555;6552.803415897531;6603.108580341593;6829.4877884157895;6927.757528486681;10834.404107774148;12521.686957826127;12688.873111269138;12790.36048197605;12850.935745321214;12393.256404615751;13011.674708132372;13014.80477792815;13021.283829389475;13067.17059611636;9100;9466.763330916507;9471.621135154517;9483.715488535356;9484.383515071499;10237.48812559384;10351.223658225814;10365.222608304559;10444.373337599769;10451.790964180522;9114.179723824887;9179.495127768037;9203.171714545722;9237.815243694955;9410.058994100535;7994.640241189277;8547.74356769273;8893.155150260714;8911.643534258557;8938.1508756668;7748.380129589506;7770.222977702185;7853.175416581405;7861.371090312647;7867.763967080997;5782.739776710142;5793.507551857971;5846.970765146147;5967.76128954837;6018.247719035121;4770.952290477051;5343.519083282523;5527.474889885454;5655.7454914528125;5745.1956726059225 05:47:28 INFO - PROCESS | 1633 | |4;prototype.html;348.41118509718575;354.88998410492746;372.2127699914681;384.2027792330914;384.294819007122;3948.091938854065;3956.803973794543;4957.876053098675;4969.819315637995;5075.314832497616;4488.409272581937;4805.327254184408;4843.927341089887;4907.877303067425;5135.537801597856;3875.5971297795404;4204.927743425437;4376.934345984812;4378.584034516716;4385.013371991292;3491.40646090164;4169.603887630686;4335.284678028122;4396.472423309207;4409.662878674291;3741.6071312512204;4184.163167366539;4297.13074812456;4312.28847240205;4368.650507959372;4299.484061912591;4342.457192850909;4389.736615803062;4394.6703997200175;4401.5818497243035;3953.9011524712114;4070.653994410479;4152.397902304149;4217.578242175758;4249.68127390447;4153.854615088458;4363.454568178978;4710.9764451177525;4832.951670483285;4854.6116310695415;4557.726536407793;4655.6973796703105;5014.420457555858;5148.588112950955;5150.9742451287875;4576;4604.618614415662;5180.585553155738;5414.729263536808;5539.266858801121;3703.7777733335815;3708.7589306694977;3919.4708714323488;4082.6937979651643;4236.978815105936;5613.663180209201;5617.045102332572;5632.127020311858;5673.496523421297;5688.728980835953;4093.570175131628;4167.4790651168605;4340.8062782735;4403.282719739304;4423.734575925455;3642.175715498716;3730.384486559687;4167.708260421802;4406.735595864258;4552.998340365114;4866.6106711463;4876.171050921281;4886.486918873467;4925.901481970341;4964.851054468371;4721;4880.511948805091;5308.9116731070035;5330.534103121672;5461.808836690697;1469.7207530569372;1487.910725356482;1524.6264665157107;1528.2817075974274;1543.2592355669342;1014.4420568687193;1014.9900848655487;1017.6285655735603;1099.5107177306181;1156.6819124740764;4240.745555266694;4241.660667146621;4309.48286205651;4902.3872015998;4949.109160351171;4570.71464267866;5106.927545215546;5166.5866730661455;5197.440767769654;5378.300820893337;4251.086016506404;4739.620830333565;4946.046311706856;4962.801487940442;4965.751712414365;2859.828410295347;2892.3058465968015;2956.541736030919;2968.495355789521;2979.4636965346012;5711.742971566289;5747.770089196385;5794.899728645155;5915.2845674753835;5931.703414829241;5009.323741294951;5458.405332016786;5731.598788084877;5827.446392592697;5876.529877609781;5308.460546441489;5476.17857321405;5822.301323841166;5897.174395584708;5923.318818335946;5034.697918124924;5059.696418214919;5463.754131064191;5527.613067085265;5553.694546799965;4208.01111738735;4280.935785963151;4565.429321334833;5318.361796584435;5479.917801232905;5546.334439867242;5741.770329186786;5755.223044888887;5763.9249870045915;5783.797567085132;4076.9015548183;4096.426500290021;4279.957200427956;4476.9104617908115;4511.436070491189;5265.763040663256;5586.608937374344;5663.9716801415725;5664.745086471036;5694.629849059798;4546.88632784183;5316.48480183146;5357.973210133924;5510.504054635102;5520.006398848085;4595.494495605414;4636.049609830045;5102.311187989574;5283.524482796567;5319.41486436484;4736.976315118402;4764.404449443819;4854.0875474714885;5016.372953380827;5255.290535777621;5337.706426146599;5403.595400046941;5426.403095659395;5450.672959622435;5474.507294343528;4524.457065152203;4814.614830813596;5246.711430871339;5368.785248590013;5382.7308634567335 05:47:28 INFO - PROCESS | 1633 | |5;yui.html;723.6960476599828;731.1043971135357;776.0570906348788;821.4208982667218;825.6202147012376;14352.138871667707;15742;15760.60598485037;15791.28939197736;15810.604734881634;12945.417456214469;14182.219977901237;14322.283885805695;14386.1368317901;14396.13623182607;925.1211349218253;940.1115945431536;962.4706411473696;968.3366893677818;977.4379731654292;962.6486332488627;966.4442945306441;967.4920666649995;968.6367612145445;971.3589031239384;945.5508633399149;1013.1995723378523;1013.8834034086063;1014.6803756816616;1017.9185665146771;937.4562753602894;1006.6476733143414;1008.0977525115054;1009.3943633819649;1009.5305682857434;751.0836779129453;754.1252147508918;755.437199286535;755.8299382638862;758.6206896551724;15570.67649249815;15898.523044308573;15984.680306393924;15995.960262582896;16276.593085172846;14030.71938561223;14177;14367.281635918267;14376.568702938928;14421.639459013608;9641.566129524188;11580.536778528849;11609.593664221711;11954.820677689842;12445.25328480294;3531.7527773055895;3639.4540818877117;3763.9623603763885;3768.0391500167557;3845.5000849889616;96863.51568242113;102854.48572757088;105812.47093764559;105843.4707826456;107034;10389.584416623251;10590.629327973484;10608.310459820086;10961.12311015117;11048.627521362325;22400;22615.321540353816;22615.660765088538;22625.4343641407;22650.886745566168;7658;7669.271419215165;7677.731279405194;7777.338926191224;7825.921740782634;4276.893077673083;4307.784610769449;4372.781360932005;4431.8670439886855;4455.420795296655;3421.9486707699402;3530.911727206789;3540.6105328413855;3541.645835416438;3542.5217595624777;610.1823556434399;628.7268281729534;648.8572514046903;653.0367707631206;653.1639501438167;560.0995732574642;581.4098689829826;601.7592962814822;620.9161763162006;662.4005275225928;8194.631241594023;9678.419294842332;10766.745297044397;10817.296875703054;11106.611268605722;567.6508946997567;585.4584509328854;598.6258588382261;646.1277275677797;707.6108140522795;4545.227311357077;5020;5022.824201152942;5026.572741317029;5043.924341134886;99942;101184.48223276656;103648.48175759224;103795.48102259441;104337.95662043283;58411.415885841445;87743;88970.55514722384;89791;90220;50397;54887.72556137194;66363.3409164765;69200.3079969204;71439.64280178565;10012.749681258027;11060.502277397376;11128.554857805597;11333.773324533298;11336.716582085513;34039.9364057236;45979.77010114928;49339.753301233264;50028.499715002385;50611;64873.67563162154;66042.33957660361;66396.6680166596;67419;68468.31531684619;11255;12100.28762897347;12568.874311257136;12915.547955821501;13321.200727956353;14026.78959815624;14514.927425362806;14906.25468726581;15039.548813535612;15497;11503.654890353302;12933.870661293267;13712.862871371159;13714.451421943011;13852.376643051288;13056.934715326743;13215.207087574776;13537.526186583422;13714.040017199099;14010.089344193002;12799.168054076456;13506.527271545448;13597.660058498617;13638.590842274747;13729.862701372858;9331.673391431268;11234.3259404436;11371.14716396257;11496.54013839437;11684.532618695157;10477.515067222947;10961.83557246626;11514.409129005262;11670.88329116732;11686.590969316034 05:47:28 INFO - PROCESS | 1633 | __end_tp_report 05:47:28 INFO - PROCESS | 1633 | __start_cc_report 05:47:28 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,1826 05:47:28 INFO - PROCESS | 1633 | __end_cc_report 05:47:28 INFO - PROCESS | 1633 | __startTimestamp1490359648438__endTimestamp 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | ------- Summary: start ------- 05:47:28 INFO - PROCESS | 1633 | Number of tests: 6 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5937.92 Median:6140.14 stddev:691.02 (11.3%) stddev-sans-first:663.91 05:47:28 INFO - PROCESS | 1633 | Values: 3402.8 3415.5 3419.2 3433.6 3476.8 5995.4 6002.7 6003.4 6033.4 6092.5 5931.4 6012.2 6024.8 6027.1 6058.9 4514.5 5342.3 5358.0 5376.3 5398.6 5276.8 5286.1 5468.9 5479.8 5518.3 5335.1 5361.2 5389.6 5399.7 5402.1 5381.5 5384.9 5386.9 5387.9 5390.7 5242.9 5342.0 5349.4 5351.7 5369.7 5957.8 5968.0 5970.7 5975.8 5976.7 6374.5 6394.1 6406.3 6412.8 6426.3 6416.7 6444.0 6448.5 6450.3 6466.9 5965.0 5994.2 5995.6 6010.8 6074.1 6509.2 6563.2 6586.4 6591.2 6592.2 5280.3 6222.6 6259.8 6316.5 6329.3 6456.6 6457.5 6481.9 6495.4 6503.3 5875.8 6429.2 6440.5 6450.4 6470.2 6305.3 6367.1 6368.0 6432.5 6453.2 5119.2 5151.0 5164.5 5165.7 5187.8 4159.2 4522.9 4556.2 4563.2 4588.9 4712.9 5748.5 5865.2 6108.2 6114.6 6409.4 6414.5 6443.1 6494.7 6504.4 6074.3 6116.5 6138.6 6140.1 6146.3 5694.9 5697.5 5703.5 5706.8 5725.9 6382.4 6391.7 6570.3 6613.8 6665.7 6498.0 6505.4 6510.9 6511.3 6516.8 6614.3 6620.6 6678.7 6697.5 6714.6 6238.4 6278.3 6278.4 6349.1 6432.1 5425.9 6160.1 6419.6 6439.2 6474.5 6320.2 6328.1 6369.3 6378.6 6391.7 6119.4 6267.3 6291.8 6297.7 6395.7 6230.7 6277.2 6283.8 6287.7 6289.0 6365.7 6379.8 6385.3 6389.6 6407.5 5904.8 5976.3 5992.1 6042.4 6066.9 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:54300.48 Median:34308.81 stddev:105886.18 (308.6%) stddev-sans-first:106106.89 05:47:28 INFO - PROCESS | 1633 | Values: 752.8 787.3 807.7 873.7 884.9 24511.6 32689.8 40583.8 40589.4 40722.4 40840.0 41056.2 41075.2 41106.0 41123.0 8995.9 9154.4 9161.8 9162.2 9167.3 7139.1 7343.0 7391.0 7412.6 7414.9 10794.4 10980.1 10991.3 10993.5 11004.0 10900.1 10950.9 10952.6 10955.0 10956.9 7246.8 10757.6 10832.1 10837.6 10844.9 27836.6 39086.4 39660.2 40889.2 40948.4 3867.8 3901.1 3901.5 3940.9 4000.3 27125.5 27270.0 27955.7 28699.4 29161.0 2962.9 2991.5 3004.0 3040.6 3049.5 326692.0 329613.0 332484.0 332953.0 333619.0 52994.7 53310.5 53345.7 53386.2 53508.7 55938.7 55966.2 56011.4 56127.7 56243.7 14352.4 14778.6 14795.7 14801.7 14808.6 12810.9 12816.4 12827.0 12830.3 12843.1 10898.9 11074.4 12214.9 12698.5 12732.0 4059.9 5345.2 5474.2 5529.5 5529.5 922.4 1121.3 1123.5 1139.7 1181.3 23382.4 26313.3 26806.0 26868.9 26903.3 1141.8 1185.0 1225.2 1236.3 1270.4 13472.9 13612.9 13684.4 13740.5 13772.7 449990.0 450026.0 450610.0 450745.0 451233.0 55490.9 55498.0 55506.0 55588.0 55701.0 1396.7 1450.3 1454.3 1458.8 1460.9 23255.3 24850.9 25506.4 25615.5 25754.9 46709.6 46791.3 46837.3 46892.0 46967.3 352643.0 421360.0 421377.0 422574.0 422811.9 33594.5 34192.1 34262.0 34355.7 34501.3 33596.2 43345.3 43361.1 44432.8 44800.6 35809.5 35965.8 36050.6 37291.9 37576.6 36063.8 36420.8 36922.0 37198.3 37762.0 30637.6 36834.4 37083.6 37111.8 37127.8 28223.6 32351.0 32541.0 32612.8 32816.8 24068.8 24273.3 24509.6 24604.4 24675.6 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:41541.85 Median:25777.10 stddev:124500.42 (483.0%) stddev-sans-first:124811.32 05:47:28 INFO - PROCESS | 1633 | Values: 382.3 400.5 420.5 426.1 437.5 12818.4 14506.6 20299.8 20579.4 21105.6 21367.4 21374.0 21949.8 22248.6 22549.3 6353.8 6379.0 6503.9 6614.3 6615.6 4143.2 4438.9 6522.2 6615.9 6629.5 4379.5 7425.0 7680.1 7690.3 7706.1 7087.6 7386.3 7564.0 7667.7 7706.6 7057.6 7252.7 7316.2 7333.8 7334.6 25684.0 25761.2 25793.0 25944.5 26135.0 2879.4 3133.9 3265.3 3274.6 3316.3 12588.7 15144.7 15355.0 15652.7 16231.4 1908.5 1908.6 1910.8 1925.0 1943.7 151601.0 151676.7 158411.2 159521.0 161869.0 18818.6 19589.9 19958.5 20011.5 20239.7 27494.6 31340.2 31630.8 31659.8 31780.7 9897.9 10156.2 10281.0 10387.9 10424.9 7627.9 8068.3 8554.9 8565.0 8712.7 9057.7 9141.9 9272.1 9328.1 9329.7 3718.7 3782.9 3821.9 3822.5 3851.1 853.6 887.9 890.3 890.7 918.7 20567.0 21416.7 21480.0 21488.2 21515.0 902.0 902.8 910.6 914.3 920.6 10427.3 10966.5 11076.8 11157.9 11166.3 726795.4 739989.0 740013.0 751512.0 790845.1 99193.0 103365.0 110893.0 140827.0 144227.3 1047.9 1106.8 1118.4 1137.7 1146.3 17864.8 18010.0 18498.0 18544.4 18751.9 56396.0 57037.4 57045.0 57487.7 57909.6 58661.1 81135.8 82178.6 86606.6 89869.0 11413.1 11489.9 11632.1 11647.9 12013.8 12499.1 12504.9 12573.8 12750.2 12806.0 9804.8 10554.5 10666.5 10852.0 10974.9 7746.9 10711.4 10940.8 10978.1 11115.9 9619.5 10335.2 10662.0 10779.6 11016.9 9046.4 10261.4 11266.1 11572.4 11574.6 10398.4 10441.7 10515.7 10631.6 10836.0 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:6757.00 Median:2421.99 stddev:4257.67 (175.8%) stddev-sans-first:4249.78 05:47:28 INFO - PROCESS | 1633 | Values: 1287.6 1517.8 1525.5 1542.9 1556.2 10853.0 11522.7 11531.7 11550.2 11602.5 10763.2 11153.9 11283.9 11293.7 11307.5 2421.9 2449.0 2453.8 2458.5 2460.9 2386.7 2416.8 2422.1 2429.1 2430.9 2385.2 2400.4 2414.8 2415.6 2421.3 2353.0 2371.6 2381.8 2382.5 2384.7 2319.9 2327.2 2397.1 2398.0 2401.1 11004.5 11076.9 11103.2 11134.3 11151.3 5754.8 5939.9 5947.9 5958.1 5962.3 3499.7 3598.7 3631.5 3658.9 3687.1 1145.6 1149.2 1169.9 1210.6 1215.3 13730.1 14057.1 14340.3 15521.2 15766.9 3882.6 4813.2 4817.3 4821.2 4846.0 10210.9 11523.1 11566.1 11566.9 11573.7 4956.1 5626.2 5823.7 5834.9 5847.6 5181.2 5276.6 5331.3 5360.6 5362.0 3905.5 3907.4 3941.8 3988.7 3995.3 1052.2 1053.8 1055.9 1067.6 1068.6 873.1 918.9 933.2 938.7 976.9 5317.3 5461.5 6756.5 7105.6 7130.5 989.8 1015.6 1038.5 1043.0 1056.4 4104.6 4125.4 4197.6 4203.0 4355.9 13639.9 14015.5 14051.4 14062.7 14102.6 13781.6 13935.7 13946.4 13972.0 13972.7 8388.5 10246.4 10325.7 10332.3 10342.5 5604.8 6552.8 6603.1 6829.5 6927.8 10834.4 12521.7 12688.9 12790.4 12850.9 12393.3 13011.7 13014.8 13021.3 13067.2 9100.0 9466.8 9471.6 9483.7 9484.4 10237.5 10351.2 10365.2 10444.4 10451.8 9114.2 9179.5 9203.2 9237.8 9410.1 7994.6 8547.7 8893.2 8911.6 8938.2 7748.4 7770.2 7853.2 7861.4 7867.8 5782.7 5793.5 5847.0 5967.8 6018.2 4771.0 5343.5 5527.5 5655.7 5745.2 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4492.45 Median:4784.87 stddev:1255.16 (26.2%) stddev-sans-first:1219.54 05:47:28 INFO - PROCESS | 1633 | Values: 348.4 354.9 372.2 384.2 384.3 3948.1 3956.8 4957.9 4969.8 5075.3 4488.4 4805.3 4843.9 4907.9 5135.5 3875.6 4204.9 4376.9 4378.6 4385.0 3491.4 4169.6 4335.3 4396.5 4409.7 3741.6 4184.2 4297.1 4312.3 4368.7 4299.5 4342.5 4389.7 4394.7 4401.6 3953.9 4070.7 4152.4 4217.6 4249.7 4153.9 4363.5 4711.0 4833.0 4854.6 4557.7 4655.7 5014.4 5148.6 5151.0 4576.0 4604.6 5180.6 5414.7 5539.3 3703.8 3708.8 3919.5 4082.7 4237.0 5613.7 5617.0 5632.1 5673.5 5688.7 4093.6 4167.5 4340.8 4403.3 4423.7 3642.2 3730.4 4167.7 4406.7 4553.0 4866.6 4876.2 4886.5 4925.9 4964.9 4721.0 4880.5 5308.9 5330.5 5461.8 1469.7 1487.9 1524.6 1528.3 1543.3 1014.4 1015.0 1017.6 1099.5 1156.7 4240.7 4241.7 4309.5 4902.4 4949.1 4570.7 5106.9 5166.6 5197.4 5378.3 4251.1 4739.6 4946.0 4962.8 4965.8 2859.8 2892.3 2956.5 2968.5 2979.5 5711.7 5747.8 5794.9 5915.3 5931.7 5009.3 5458.4 5731.6 5827.4 5876.5 5308.5 5476.2 5822.3 5897.2 5923.3 5034.7 5059.7 5463.8 5527.6 5553.7 4208.0 4280.9 4565.4 5318.4 5479.9 5546.3 5741.8 5755.2 5763.9 5783.8 4076.9 4096.4 4280.0 4476.9 4511.4 5265.8 5586.6 5664.0 5664.7 5694.6 4546.9 5316.5 5358.0 5510.5 5520.0 4595.5 4636.0 5102.3 5283.5 5319.4 4737.0 4764.4 4854.1 5016.4 5255.3 5337.7 5403.6 5426.4 5450.7 5474.5 4524.5 4814.6 5246.7 5368.8 5382.7 05:47:28 INFO - PROCESS | 1633 | 05:47:28 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:19754.46 Median:22638.16 stddev:27979.47 (123.6%) stddev-sans-first:28021.47 05:47:28 INFO - PROCESS | 1633 | Values: 723.7 731.1 776.1 821.4 825.6 14352.1 15742.0 15760.6 15791.3 15810.6 12945.4 14182.2 14322.3 14386.1 14396.1 925.1 940.1 962.5 968.3 977.4 962.6 966.4 967.5 968.6 971.4 945.6 1013.2 1013.9 1014.7 1017.9 937.5 1006.6 1008.1 1009.4 1009.5 751.1 754.1 755.4 755.8 758.6 15570.7 15898.5 15984.7 15996.0 16276.6 14030.7 14177.0 14367.3 14376.6 14421.6 9641.6 11580.5 11609.6 11954.8 12445.3 3531.8 3639.5 3764.0 3768.0 3845.5 96863.5 102854.5 105812.5 105843.5 107034.0 10389.6 10590.6 10608.3 10961.1 11048.6 22400.0 22615.3 22615.7 22625.4 22650.9 7658.0 7669.3 7677.7 7777.3 7825.9 4276.9 4307.8 4372.8 4431.9 4455.4 3421.9 3530.9 3540.6 3541.6 3542.5 610.2 628.7 648.9 653.0 653.2 560.1 581.4 601.8 620.9 662.4 8194.6 9678.4 10766.7 10817.3 11106.6 567.7 585.5 598.6 646.1 707.6 4545.2 5020.0 5022.8 5026.6 5043.9 99942.0 101184.5 103648.5 103795.5 104338.0 58411.4 87743.0 88970.6 89791.0 90220.0 50397.0 54887.7 66363.3 69200.3 71439.6 10012.7 11060.5 11128.6 11333.8 11336.7 34039.9 45979.8 49339.8 50028.5 50611.0 64873.7 66042.3 66396.7 67419.0 68468.3 11255.0 12100.3 12568.9 12915.5 13321.2 14026.8 14514.9 14906.3 15039.5 15497.0 11503.7 12933.9 13712.9 13714.5 13852.4 13056.9 13215.2 13537.5 13714.0 14010.1 12799.2 13506.5 13597.7 13638.6 13729.9 9331.7 11234.3 11371.1 11496.5 11684.5 10477.5 10961.8 11514.4 11670.9 11686.6 05:47:28 INFO - PROCESS | 1633 | -------- Summary: end -------- 05:47:28 INFO - PROCESS | 1633 | 05:47:29 INFO - TEST-INFO | 1633: exit 0 05:47:29 INFO - TEST-OK | dromaeo_css | took 1120904ms 05:47:29 INFO - TEST-START | kraken 05:47:29 INFO - operating with platform_type : mac_ 05:47:29 INFO - Initialising browser for kraken test... 05:47:29 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmp3ttjLG/profile http://localhost:49241/getInfo.html) 05:47:31 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 05:47:31 INFO - PROCESS | 1644 | colorDepth:24 05:47:31 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 05:47:31 INFO - PROCESS | 1644 | __metrics 05:47:31 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:47:31 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:32 INFO - TEST-INFO | 1644: exit 0 05:47:32 INFO - Browser initialized. 05:47:32 INFO - Running cycle 1/1 for kraken test... 05:47:32 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmp3ttjLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:44 INFO - PROCESS | 1645 | RSS: Main: 215318528 05:47:44 INFO - PROCESS | 1645 | 05:47:47 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:48 INFO - PROCESS | 1645 | RSS: Main: 267821056 05:47:48 INFO - PROCESS | 1645 | 05:47:50 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:47:51 INFO - PROCESS | 1645 | RSS: Main: 279072768 05:47:51 INFO - PROCESS | 1645 | 05:47:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:47:55 INFO - PROCESS | 1645 | RSS: Main: 375332864 05:47:55 INFO - PROCESS | 1645 | 05:47:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:47:57 INFO - PROCESS | 1645 | RSS: Main: 277983232 05:47:57 INFO - PROCESS | 1645 | 05:47:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:00 INFO - PROCESS | 1645 | RSS: Main: 280723456 05:48:00 INFO - PROCESS | 1645 | 05:48:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:03 INFO - PROCESS | 1645 | RSS: Main: 320077824 05:48:03 INFO - PROCESS | 1645 | 05:48:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:07 INFO - PROCESS | 1645 | RSS: Main: 321593344 05:48:07 INFO - PROCESS | 1645 | 05:48:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:48:11 INFO - PROCESS | 1645 | RSS: Main: 320802816 05:48:11 INFO - PROCESS | 1645 | 05:48:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:13 INFO - PROCESS | 1645 | RSS: Main: 294305792 05:48:13 INFO - PROCESS | 1645 | 05:48:15 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:15 INFO - PROCESS | 1645 | RSS: Main: 299659264 05:48:15 INFO - PROCESS | 1645 | 05:48:18 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:18 INFO - PROCESS | 1645 | RSS: Main: 302227456 05:48:18 INFO - PROCESS | 1645 | 05:48:21 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:22 INFO - PROCESS | 1645 | RSS: Main: 314847232 05:48:22 INFO - PROCESS | 1645 | 05:48:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:26 INFO - PROCESS | 1645 | RSS: Main: 308666368 05:48:26 INFO - PROCESS | 1645 | 05:48:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:48:28 INFO - PROCESS | 1645 | RSS: Main: 353378304 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | __start_tp_report 05:48:28 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 05:48:28 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 05:48:28 INFO - PROCESS | 1645 | |i|pagename|runs| 05:48:28 INFO - PROCESS | 1645 | |0;ai-astar;116;116;114;113;115;114;115;115;116;114 05:48:28 INFO - PROCESS | 1645 | |1;audio-beat-detection;143;111;109;146;108;109;109;109;128;111 05:48:28 INFO - PROCESS | 1645 | |2;audio-dft;186;185;183;186;183;184;182;183;185;185 05:48:28 INFO - PROCESS | 1645 | |3;audio-fft;82;58;60;91;62;62;60;58;75;59 05:48:28 INFO - PROCESS | 1645 | |4;audio-oscillator;89;69;86;71;71;68;101;99;94;83 05:48:28 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;87;86;94;87;87;87;87;87;87;87 05:48:28 INFO - PROCESS | 1645 | |6;imaging-darkroom;94;94;95;97;94;94;113;158;129;94 05:48:28 INFO - PROCESS | 1645 | |7;imaging-desaturate;91;129;83;84;85;80;83;69;129;125 05:48:28 INFO - PROCESS | 1645 | |8;json-parse-financial;65;62;61;61;62;62;64;63;64;63 05:48:28 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;54;63;56;65;61;55;59;57;59;58 05:48:28 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;84;83;85;83;82;83;86;83;83;86 05:48:28 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;137;138;129;132;140;146;131;156;183;147 05:48:28 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;166;163;165;164;164;162;164;176;218;196 05:48:28 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;65;64;61;65;66;64;66;66;74;80 05:48:28 INFO - PROCESS | 1645 | __end_tp_report 05:48:28 INFO - PROCESS | 1645 | __start_cc_report 05:48:28 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2190 05:48:28 INFO - PROCESS | 1645 | __end_cc_report 05:48:28 INFO - PROCESS | 1645 | __startTimestamp1490359708010__endTimestamp 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | ------- Summary: start ------- 05:48:28 INFO - PROCESS | 1645 | Number of tests: 14 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 05:48:28 INFO - PROCESS | 1645 | Values: 116.0 116.0 114.0 113.0 115.0 114.0 115.0 115.0 116.0 114.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:111.00 stddev:15.02 (13.5%) stddev-sans-first:13.00 05:48:28 INFO - PROCESS | 1645 | Values: 143.0 111.0 109.0 146.0 108.0 109.0 109.0 109.0 128.0 111.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.40 (0.8%) stddev-sans-first:1.32 05:48:28 INFO - PROCESS | 1645 | Values: 186.0 185.0 183.0 186.0 183.0 184.0 182.0 183.0 185.0 185.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.00 stddev:11.73 (18.9%) stddev-sans-first:11.06 05:48:28 INFO - PROCESS | 1645 | Values: 82.0 58.0 60.0 91.0 62.0 62.0 60.0 58.0 75.0 59.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:84.50 stddev:12.71 (15.0%) stddev-sans-first:13.31 05:48:28 INFO - PROCESS | 1645 | Values: 89.0 69.0 86.0 71.0 71.0 68.0 101.0 99.0 94.0 83.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:87.00 stddev:2.27 (2.6%) stddev-sans-first:2.40 05:48:28 INFO - PROCESS | 1645 | Values: 87.0 86.0 94.0 87.0 87.0 87.0 87.0 87.0 87.0 87.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:94.00 stddev:21.61 (23.0%) stddev-sans-first:22.47 05:48:28 INFO - PROCESS | 1645 | Values: 94.0 94.0 95.0 97.0 94.0 94.0 113.0 158.0 129.0 94.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:83.00 stddev:22.69 (27.3%) stddev-sans-first:23.99 05:48:28 INFO - PROCESS | 1645 | Values: 91.0 129.0 83.0 84.0 85.0 80.0 83.0 69.0 129.0 125.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.13 05:48:28 INFO - PROCESS | 1645 | Values: 65.0 62.0 61.0 61.0 62.0 62.0 64.0 63.0 64.0 63.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:3.50 (5.9%) stddev-sans-first:3.27 05:48:28 INFO - PROCESS | 1645 | Values: 54.0 63.0 56.0 65.0 61.0 55.0 59.0 57.0 59.0 58.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.40 (1.7%) stddev-sans-first:1.48 05:48:28 INFO - PROCESS | 1645 | Values: 84.0 83.0 85.0 83.0 82.0 83.0 86.0 83.0 83.0 86.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:143.00 stddev:16.04 (11.2%) stddev-sans-first:16.82 05:48:28 INFO - PROCESS | 1645 | Values: 137.0 138.0 129.0 132.0 140.0 146.0 131.0 156.0 183.0 147.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:165.50 stddev:18.66 (11.3%) stddev-sans-first:19.58 05:48:28 INFO - PROCESS | 1645 | Values: 166.0 163.0 165.0 164.0 164.0 162.0 164.0 176.0 218.0 196.0 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.00 stddev:5.61 (8.5%) stddev-sans-first:5.89 05:48:28 INFO - PROCESS | 1645 | Values: 65.0 64.0 61.0 65.0 66.0 64.0 66.0 66.0 74.0 80.0 05:48:28 INFO - PROCESS | 1645 | -------- Summary: end -------- 05:48:28 INFO - PROCESS | 1645 | 05:48:28 INFO - TEST-INFO | 1645: exit 0 05:48:28 INFO - TEST-OK | kraken | took 59823ms 05:48:28 INFO - SUITE-END | took 1180s 05:48:29 INFO - Completed test suite (00:19:40) 05:48:29 INFO - javascript benchmark 05:48:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.047745483917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.8468718907648, 3415.4535274356094, 3419.179396944733, 3433.64371073426, 3476.843542040608, 5995.400459954002, 6002.6998650067435, 6003.418599566711, 6033.366496517863, 6092.482139018183, 5931.406859314077, 6012.248468941382, 6024.789132380368, 6027.126066720334, 6058.939410605893, 4514.480834704002, 5342.305500284958, 5357.973210133944, 5376.274202982606, 5398.568114550826, 5276.8153114641, 5286.10136276832, 5468.863278418032, 5479.808206712766, 5518.310211223597, 5335.146376579748, 5361.169018802092, 5389.6496727712765, 5399.676019438846, 5402.054640437927, 5381.48875856793, 5384.865378365533, 5386.8922621547545, 5387.865303367408, 5390.730463476811, 5242.947570524284, 5341.958318127967, 5349.358077030781, 5351.652142610717, 5369.731513424314, 5957.791477298317, 5967.955607768623, 5970.6716130612795, 5975.820725378246, 5976.731047102848, 6374.521910856658, 6394.104825324458, 6406.263279722798, 6412.807615771488, 6426.2931077581425, 6416.743330266784, 6444.0, 6448.484121270287, 6450.322716114834, 6466.935330646727, 5965.0, 5994.190784244115, 5995.640261584275, 6010.8497287567725, 6074.058520929263, 6509.24762075773, 6563.212414510193, 6586.440152586988, 6591.176102987127, 6592.208934927791, 5280.313559237275, 6222.595531290452, 6259.78090766821, 6316.463100636405, 6329.303776584572, 6456.612603243821, 6457.483401327976, 6481.902771458432, 6495.350464953467, 6503.317151699098, 5875.764969401176, 6429.22849258092, 6440.452561532322, 6450.3549645036055, 6470.1588793457495, 6305.306416294204, 6367.108604795332, 6367.968160159169, 6432.549721519449, 6453.225612926479, 5119.180931051014, 5151.0, 5164.509371609691, 5165.664231824994, 5187.766550505236, 4159.230542349675, 4522.932156017597, 4556.225441674923, 4563.178627847019, 4588.908221835612, 4712.858614241578, 5748.540116790647, 5865.237519122486, 6108.17539632144, 6114.633122012693, 6409.391107844747, 6414.486841052704, 6443.097966284724, 6494.707738151795, 6504.38208370204, 6074.301455332605, 6116.48009919153, 6138.631682098999, 6140.140380346755, 6146.323904370515, 5694.914576281359, 5697.515711164598, 5703.54371650267, 5706.771729130871, 5725.942740572541, 6382.36176382358, 6391.744330226739, 6570.342965703391, 6613.768518101843, 6665.700043497957, 6498.0252962056065, 6505.41451269388, 6510.902336464862, 6511.3163117871945, 6516.837079073061, 6614.338566143347, 6620.569662971891, 6678.699458524281, 6697.464202863662, 6714.563553369016, 6238.438540531374, 6278.340774218824, 6278.4035516625845, 6349.07938348946, 6432.13166222554, 5425.891482170414, 6160.106784516131, 6419.614823110628, 6439.227292724903, 6474.482041436768, 6320.209973753281, 6328.145700330397, 6369.267534233622, 6378.617282963037, 6391.744330226739, 6119.41115851624, 6267.310595834546, 6291.779787707592, 6297.653629050446, 6395.744170233139, 6230.657313847782, 6277.18396608438, 6283.8114856554375, 6287.717052732546, 6288.9685551573775, 6365.745370185326, 6379.776707815204, 6385.29761726219, 6389.648569328731, 6407.519436042222, 5904.822855314347, 5976.282846058501, 5992.131140984446, 6042.3655516170165, 6066.878662426815], "value": 5892.512037243801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.7816933089405, 787.2599756229145, 807.7455601485533, 873.7073080518027, 884.8982367027794, 24511.632325515133, 32689.836550817243, 40583.79708101463, 40589.39115913264, 40722.3711051558, 40840.0, 41056.178876422455, 41075.17849643005, 41106.0, 41123.0, 8995.865062024075, 9154.404963677373, 9161.770955726093, 9162.17540421362, 9167.312451566158, 7139.143302803671, 7342.963285183593, 7391.0, 7412.59230742309, 7414.888776668327, 10794.406307653077, 10980.066694330992, 10991.285566438195, 10993.505292261827, 11004.009639132477, 10900.073493753001, 10950.945245273762, 10952.561897524089, 10955.014048735573, 10956.945215273952, 7246.782596522113, 10757.569697212102, 10832.133429325713, 10837.620683276127, 10844.891551084467, 27836.582451263246, 39086.41370379447, 39660.20679586392, 40889.1822163558, 40948.38577421341, 3867.806609669505, 3901.1222474943193, 3901.473301104343, 3940.8964500262255, 4000.2999475092033, 27125.457490850073, 27270.04554840571, 27955.709965257654, 28699.426011479864, 29161.0, 2962.881484740608, 2991.5443387832024, 3003.993403929817, 3040.6351237851377, 3049.5120780675206, 326692.0, 329613.0, 332484.0, 332953.0, 333619.0, 52994.73502632539, 53310.46689533132, 53345.733271334175, 53386.19920701192, 53508.73245633747, 55938.72030639821, 55966.160507592416, 56011.43988560144, 56127.71936140293, 56243.718781405834, 14352.354144063542, 14778.556643300719, 14795.704085918436, 14801.703965920622, 14808.555743327717, 12810.911072558936, 12816.42326095328, 12826.97384209261, 12830.29433381173, 12843.100982931104, 10898.891011089787, 11074.390908499949, 12214.938925305316, 12698.492060317669, 12732.0, 4059.89850253746, 5345.1714984177515, 5474.206240095164, 5529.502344788988, 5529.529989950819, 922.3866129024258, 1121.2991880074953, 1123.5225029362489, 1139.715071232192, 1181.303031211572, 23382.415439613804, 26313.34216644561, 26806.0, 26868.865655671598, 26903.327416814736, 1141.7716456708692, 1184.9809164118851, 1225.2342286071205, 1236.344737289238, 1270.39021269791, 13472.932635336761, 13612.931935340457, 13684.384202710902, 13740.450381984809, 13772.65568360799, 449990.0, 450026.0, 450610.0, 450745.0, 451233.0, 55490.890182196934, 55498.0, 55506.0, 55588.0, 55701.0, 1396.6927275999265, 1450.3255985966575, 1454.2728635682158, 1458.8103546539094, 1460.9415623374946, 23255.3023409298, 24850.875745621157, 25506.362340941625, 25615.487690246464, 25754.87122564375, 46709.59871203869, 46791.298130527386, 46837.2974405391, 46892.0, 46967.29549056835, 352643.0, 421360.0, 421377.0, 422574.0, 422811.8859405806, 33594.49608255927, 34192.14519637029, 34261.97214083582, 34355.656443436244, 34501.30997380088, 33596.160095997795, 43345.34981975336, 43361.13277734491, 44432.77783611061, 44800.55199448094, 35809.46285805663, 35965.84204947711, 36050.63949360473, 37291.88124356273, 37576.624233758404, 36063.819680901426, 36420.81789591035, 36922.0, 37198.25603487969, 37762.0, 30637.62130704079, 36834.44748328724, 37083.629163708014, 37111.81444092762, 37127.81436092802, 28223.57664635073, 32351.0, 32541.02376928696, 32612.83693581517, 32816.835915820266, 24068.759312407354, 24273.271801845975, 24509.632355515037, 24604.384890377885, 24675.629865551673], "value": 18706.31983475733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.34618801848836, 400.4793768101469, 420.48070632768514, 426.09029721544505, 437.4641064695748, 12818.359082045896, 14506.637334066654, 20299.797002029994, 20579.38261852143, 21105.57788844222, 21367.35897923061, 21374.0, 21949.78050219497, 22248.555028899413, 22549.323520294376, 6353.777617783378, 6378.968105159468, 6503.93496065038, 6614.338566143371, 6615.603063816162, 4143.150654115899, 4438.933415998747, 6522.184726909137, 6615.900761488581, 6629.502787290949, 4379.496357918848, 7425.0, 7680.11678656956, 7690.2694244046725, 7706.075270967463, 7087.574745515286, 7386.335229829341, 7564.016677831846, 7667.693292268331, 7706.576138312391, 7057.611831349273, 7252.746153884642, 7316.158641756213, 7333.816654583625, 7334.596597187153, 25684.0, 25761.227163184947, 25792.968281268728, 25944.48111037769, 26134.954601815905, 2879.43850949065, 3133.9216519586967, 3265.314284000339, 3274.5579346788118, 3316.336732653479, 12588.748225035448, 15144.697106057927, 15355.0, 15652.68694626101, 16231.350745970147, 1908.532409559653, 1908.570571621388, 1910.8471322294183, 1924.9903750481158, 1943.679292916667, 151601.0, 151676.6973389704, 158411.20794395954, 159521.0, 161869.0, 18818.588605854617, 19589.90205048994, 19958.50103747418, 20011.499712507302, 20239.696404553943, 27494.587581186297, 31340.216494587818, 31630.841845790623, 31659.84170079181, 31780.682193177774, 9897.851532227023, 10156.187504999582, 10281.023302786223, 10387.94806025965, 10424.947875260576, 7627.855821626689, 8068.273855353046, 8554.91445085541, 8565.0, 8712.738617841474, 9057.728268151834, 9141.908580914238, 9272.119148680864, 9328.067193280618, 9329.673461428818, 3718.6839118675216, 3782.924341513154, 3821.8662346817728, 3822.503074600284, 3851.094992676719, 853.6457370191425, 887.933404994628, 890.3233542507611, 890.7262614461252, 918.7427520294328, 20567.0, 21416.678749818766, 21480.0, 21488.247911323342, 21515.0, 901.9549022548846, 902.7517432706059, 910.5538286239695, 914.3279689428265, 920.6363486422825, 10427.297510510296, 10966.506507207196, 11076.778464430667, 11157.888421115847, 11166.274192177483, 726795.3660231665, 739989.0, 740013.0, 751512.0, 790845.0915490772, 99193.0, 103365.0, 110893.0, 140827.0, 144227.27886360712, 1047.8690163729534, 1106.8007758603528, 1118.4016551145098, 1137.7212582917073, 1146.3122126724065, 17864.821351786315, 18010.009449480403, 18497.982610955987, 18544.443666690022, 18751.90624046871, 56396.0, 57037.42962570321, 57045.0, 57487.712561438595, 57909.55226119381, 58661.12008319793, 81135.78296325677, 82178.58910705408, 86606.56696716476, 89869.0, 11413.08695304357, 11489.885101149215, 11632.069434445055, 11647.941760291144, 12013.81979270329, 12499.12506124599, 12504.874951250735, 12573.811392828931, 12750.234985900875, 12805.975521958035, 9804.754881128029, 10554.525046372779, 10666.466676665981, 10852.023317901427, 10974.890251097388, 7746.883796743166, 10711.357318560911, 10940.781184376427, 10978.066864316303, 11115.94398532138, 9619.470929098967, 10335.17318614524, 10662.0, 10779.568817247222, 11016.889831101586, 9046.366754327133, 10261.435621040915, 11266.098712102848, 11572.36352000648, 11574.594889178838, 10398.428086455318, 10441.738956526147, 10515.737106572396, 10631.627893023708, 10836.0], "value": 11118.145453884663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.6201520551435, 1517.8482151784822, 1525.54233729881, 1542.861142497175, 1556.1985577427624, 10853.0, 11522.711932201699, 11531.654050378482, 11550.191486595942, 11602.477888495017, 10763.246572739912, 11153.888461115386, 11283.943580282086, 11293.661190164308, 11307.547698092087, 2421.878906054699, 2448.9755102448926, 2453.82823202375, 2458.50829834033, 2460.9261722148362, 2386.6658667786523, 2416.7824895759377, 2422.103821586016, 2429.0526694589125, 2430.914917977871, 2385.1771138957033, 2400.4478969836946, 2414.8309618326725, 2415.5893498105365, 2421.2857207123852, 2352.97647023531, 2371.620540713486, 2381.785639292472, 2382.4996750682376, 2384.6899903012586, 2319.884005799703, 2327.2320134355623, 2397.0891061396733, 2398.0, 2401.0995876546294, 11004.504797284142, 11076.889231107747, 11103.222774405795, 11134.27627204229, 11151.327300904848, 5754.769809207627, 5939.851503712399, 5947.881042379171, 5958.106284057383, 5962.314333851619, 3499.7025252853537, 3598.676119149263, 3631.4915911772373, 3658.8902332930056, 3687.115092377837, 1145.5532342386393, 1149.2013050929606, 1169.8771628979005, 1210.5702475621115, 1215.3254943506352, 13730.107543009672, 14057.086289391156, 14340.282985850667, 15521.223938803128, 15766.9211653941, 3882.5535063467496, 4813.15769740301, 4817.349657796222, 4821.156297647897, 4846.0, 10210.897891020995, 11523.135764817673, 11566.132540059529, 11566.884331156749, 11573.652790416301, 4956.132676781549, 5626.156076588544, 5823.7379317929945, 5834.912476312858, 5847.649141051551, 5181.248718935809, 5276.551493123127, 5331.253624492574, 5360.571154307724, 5362.034833729966, 3905.511811023622, 3907.374820028782, 3941.802909854553, 3988.700847436454, 3995.260876737813, 1052.1740433759462, 1053.7629033467408, 1055.9366438013744, 1067.6423398161548, 1068.6420049283577, 873.1181506678174, 918.9081091890891, 933.1788026536605, 938.7090002099371, 976.9267304952157, 5317.255584218213, 5461.5357694596405, 6756.459483241329, 7105.609191494414, 7130.536515126604, 989.7674046599187, 1015.6394479959656, 1038.4692047039973, 1042.99478502607, 1056.3714589819044, 4104.589541045872, 4125.381192821101, 4197.643200327945, 4202.978985105055, 4355.912881742347, 13639.931800341134, 14015.50945716895, 14051.437942482185, 14062.71874562503, 14102.576922692335, 13781.586552403443, 13935.721285574231, 13946.372413241428, 13971.952103592272, 13972.72054558903, 8388.496690198608, 10246.436445995392, 10325.690229293134, 10332.328398654063, 10342.482875856327, 5604.8318550443555, 6552.803415897531, 6603.108580341593, 6829.4877884157895, 6927.757528486681, 10834.404107774148, 12521.686957826127, 12688.873111269138, 12790.36048197605, 12850.935745321214, 12393.256404615751, 13011.674708132372, 13014.80477792815, 13021.283829389475, 13067.17059611636, 9100.0, 9466.763330916507, 9471.621135154517, 9483.715488535356, 9484.383515071499, 10237.48812559384, 10351.223658225814, 10365.222608304559, 10444.373337599769, 10451.790964180522, 9114.179723824887, 9179.495127768037, 9203.171714545722, 9237.815243694955, 9410.058994100535, 7994.640241189277, 8547.74356769273, 8893.155150260714, 8911.643534258557, 8938.1508756668, 7748.380129589506, 7770.222977702185, 7853.175416581405, 7861.371090312647, 7867.763967080997, 5782.739776710142, 5793.507551857971, 5846.970765146147, 5967.76128954837, 6018.247719035121, 4770.952290477051, 5343.519083282523, 5527.474889885454, 5655.7454914528125, 5745.1956726059225], "value": 5142.9896674361935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.41118509718575, 354.88998410492746, 372.2127699914681, 384.2027792330914, 384.294819007122, 3948.091938854065, 3956.803973794543, 4957.876053098675, 4969.819315637995, 5075.314832497616, 4488.409272581937, 4805.327254184408, 4843.927341089887, 4907.877303067425, 5135.537801597856, 3875.5971297795404, 4204.927743425437, 4376.934345984812, 4378.584034516716, 4385.013371991292, 3491.40646090164, 4169.603887630686, 4335.284678028122, 4396.472423309207, 4409.662878674291, 3741.6071312512204, 4184.163167366539, 4297.13074812456, 4312.28847240205, 4368.650507959372, 4299.484061912591, 4342.457192850909, 4389.736615803062, 4394.6703997200175, 4401.5818497243035, 3953.9011524712114, 4070.653994410479, 4152.397902304149, 4217.578242175758, 4249.68127390447, 4153.854615088458, 4363.454568178978, 4710.9764451177525, 4832.951670483285, 4854.6116310695415, 4557.726536407793, 4655.6973796703105, 5014.420457555858, 5148.588112950955, 5150.9742451287875, 4576.0, 4604.618614415662, 5180.585553155738, 5414.729263536808, 5539.266858801121, 3703.7777733335815, 3708.7589306694977, 3919.4708714323488, 4082.6937979651643, 4236.978815105936, 5613.663180209201, 5617.045102332572, 5632.127020311858, 5673.496523421297, 5688.728980835953, 4093.570175131628, 4167.4790651168605, 4340.8062782735, 4403.282719739304, 4423.734575925455, 3642.175715498716, 3730.384486559687, 4167.708260421802, 4406.735595864258, 4552.998340365114, 4866.6106711463, 4876.171050921281, 4886.486918873467, 4925.901481970341, 4964.851054468371, 4721.0, 4880.511948805091, 5308.9116731070035, 5330.534103121672, 5461.808836690697, 1469.7207530569372, 1487.910725356482, 1524.6264665157107, 1528.2817075974274, 1543.2592355669342, 1014.4420568687193, 1014.9900848655487, 1017.6285655735603, 1099.5107177306181, 1156.6819124740764, 4240.745555266694, 4241.660667146621, 4309.48286205651, 4902.3872015998, 4949.109160351171, 4570.71464267866, 5106.927545215546, 5166.5866730661455, 5197.440767769654, 5378.300820893337, 4251.086016506404, 4739.620830333565, 4946.046311706856, 4962.801487940442, 4965.751712414365, 2859.828410295347, 2892.3058465968015, 2956.541736030919, 2968.495355789521, 2979.4636965346012, 5711.742971566289, 5747.770089196385, 5794.899728645155, 5915.2845674753835, 5931.703414829241, 5009.323741294951, 5458.405332016786, 5731.598788084877, 5827.446392592697, 5876.529877609781, 5308.460546441489, 5476.17857321405, 5822.301323841166, 5897.174395584708, 5923.318818335946, 5034.697918124924, 5059.696418214919, 5463.754131064191, 5527.613067085265, 5553.694546799965, 4208.01111738735, 4280.935785963151, 4565.429321334833, 5318.361796584435, 5479.917801232905, 5546.334439867242, 5741.770329186786, 5755.223044888887, 5763.9249870045915, 5783.797567085132, 4076.9015548183, 4096.426500290021, 4279.957200427956, 4476.9104617908115, 4511.436070491189, 5265.763040663256, 5586.608937374344, 5663.9716801415725, 5664.745086471036, 5694.629849059798, 4546.88632784183, 5316.48480183146, 5357.973210133924, 5510.504054635102, 5520.006398848085, 4595.494495605414, 4636.049609830045, 5102.311187989574, 5283.524482796567, 5319.41486436484, 4736.976315118402, 4764.404449443819, 4854.0875474714885, 5016.372953380827, 5255.290535777621, 5337.706426146599, 5403.595400046941, 5426.403095659395, 5450.672959622435, 5474.507294343528, 4524.457065152203, 4814.614830813596, 5246.711430871339, 5368.785248590013, 5382.7308634567335], "value": 4125.072983069216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6960476599828, 731.1043971135357, 776.0570906348788, 821.4208982667218, 825.6202147012376, 14352.138871667707, 15742.0, 15760.60598485037, 15791.28939197736, 15810.604734881634, 12945.417456214469, 14182.219977901237, 14322.283885805695, 14386.1368317901, 14396.13623182607, 925.1211349218253, 940.1115945431536, 962.4706411473696, 968.3366893677818, 977.4379731654292, 962.6486332488627, 966.4442945306441, 967.4920666649995, 968.6367612145445, 971.3589031239384, 945.5508633399149, 1013.1995723378523, 1013.8834034086063, 1014.6803756816616, 1017.9185665146771, 937.4562753602894, 1006.6476733143414, 1008.0977525115054, 1009.3943633819649, 1009.5305682857434, 751.0836779129453, 754.1252147508918, 755.437199286535, 755.8299382638862, 758.6206896551724, 15570.67649249815, 15898.523044308573, 15984.680306393924, 15995.960262582896, 16276.593085172846, 14030.71938561223, 14177.0, 14367.281635918267, 14376.568702938928, 14421.639459013608, 9641.566129524188, 11580.536778528849, 11609.593664221711, 11954.820677689842, 12445.25328480294, 3531.7527773055895, 3639.4540818877117, 3763.9623603763885, 3768.0391500167557, 3845.5000849889616, 96863.51568242113, 102854.48572757088, 105812.47093764559, 105843.4707826456, 107034.0, 10389.584416623251, 10590.629327973484, 10608.310459820086, 10961.12311015117, 11048.627521362325, 22400.0, 22615.321540353816, 22615.660765088538, 22625.4343641407, 22650.886745566168, 7658.0, 7669.271419215165, 7677.731279405194, 7777.338926191224, 7825.921740782634, 4276.893077673083, 4307.784610769449, 4372.781360932005, 4431.8670439886855, 4455.420795296655, 3421.9486707699402, 3530.911727206789, 3540.6105328413855, 3541.645835416438, 3542.5217595624777, 610.1823556434399, 628.7268281729534, 648.8572514046903, 653.0367707631206, 653.1639501438167, 560.0995732574642, 581.4098689829826, 601.7592962814822, 620.9161763162006, 662.4005275225928, 8194.631241594023, 9678.419294842332, 10766.745297044397, 10817.296875703054, 11106.611268605722, 567.6508946997567, 585.4584509328854, 598.6258588382261, 646.1277275677797, 707.6108140522795, 4545.227311357077, 5020.0, 5022.824201152942, 5026.572741317029, 5043.924341134886, 99942.0, 101184.48223276656, 103648.48175759224, 103795.48102259441, 104337.95662043283, 58411.415885841445, 87743.0, 88970.55514722384, 89791.0, 90220.0, 50397.0, 54887.72556137194, 66363.3409164765, 69200.3079969204, 71439.64280178565, 10012.749681258027, 11060.502277397376, 11128.554857805597, 11333.773324533298, 11336.716582085513, 34039.9364057236, 45979.77010114928, 49339.753301233264, 50028.499715002385, 50611.0, 64873.67563162154, 66042.33957660361, 66396.6680166596, 67419.0, 68468.31531684619, 11255.0, 12100.28762897347, 12568.874311257136, 12915.547955821501, 13321.200727956353, 14026.78959815624, 14514.927425362806, 14906.25468726581, 15039.548813535612, 15497.0, 11503.654890353302, 12933.870661293267, 13712.862871371159, 13714.451421943011, 13852.376643051288, 13056.934715326743, 13215.207087574776, 13537.526186583422, 13714.040017199099, 14010.089344193002, 12799.168054076456, 13506.527271545448, 13597.660058498617, 13638.590842274747, 13729.862701372858, 9331.673391431268, 11234.3259404436, 11371.14716396257, 11496.54013839437, 11684.532618695157, 10477.515067222947, 10961.83557246626, 11514.409129005262, 11670.88329116732, 11686.590969316034], "value": 7546.784527814806, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1446.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 113.0, 115.0, 114.0, 115.0, 115.0, 116.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 109.0, 146.0, 108.0, 109.0, 109.0, 109.0, 128.0, 111.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 183.0, 186.0, 183.0, 184.0, 182.0, 183.0, 185.0, 185.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 91.0, 62.0, 62.0, 60.0, 58.0, 75.0, 59.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 86.0, 71.0, 71.0, 68.0, 101.0, 99.0, 94.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 94.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 97.0, 94.0, 94.0, 113.0, 158.0, 129.0, 94.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 129.0, 83.0, 84.0, 85.0, 80.0, 83.0, 69.0, 129.0, 125.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 61.0, 61.0, 62.0, 62.0, 64.0, 63.0, 64.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 56.0, 65.0, 61.0, 55.0, 59.0, 57.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 82.0, 83.0, 86.0, 83.0, 83.0, 86.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 129.0, 132.0, 140.0, 146.0, 131.0, 156.0, 183.0, 147.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 165.0, 164.0, 164.0, 162.0, 164.0, 176.0, 218.0, 196.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 61.0, 65.0, 66.0, 64.0, 66.0, 66.0, 74.0, 80.0], "value": 67.1, "unit": "score"}]}]} 05:48:29 INFO - Return code: 0 05:48:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:29 ERROR - # TBPL SUCCESS # 05:48:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:29 INFO - 2017-03-24 05:48:29.301 screenresolution[1649:9807] starting screenresolution argv=screenresolution get 05:48:29 INFO - 2017-03-24 05:48:29.304 screenresolution[1649:9807] Display 0: 1600x1200x32@60 05:48:29 INFO - 2017-03-24 05:48:29.310 screenresolution[1650:9811] starting screenresolution argv=screenresolution list 05:48:29 INFO - Available Modes on Display 0 05:48:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:29 INFO - Intel Iris: 05:48:29 INFO - Chipset Model: Intel Iris 05:48:29 INFO - Type: GPU 05:48:29 INFO - Bus: Built-In 05:48:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:48:29 INFO - Vendor: Intel (0x8086) 05:48:29 INFO - Device ID: 0x0a2e 05:48:29 INFO - Revision ID: 0x0009 05:48:29 INFO - Displays: 05:48:29 INFO - Display: 05:48:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:29 INFO - Display Serial Number: 1600x1200 60 05:48:29 INFO - Main Display: Yes 05:48:29 INFO - Mirror: Off 05:48:29 INFO - Online: Yes 05:48:29 INFO - Rotation: Supported 05:48:29 INFO - Return code: 0 05:48:29 INFO - Running post-action listener: _resource_record_post_action 05:48:29 INFO - [mozharness: 2017-03-24 12:48:29.547136Z] Finished run-tests step (success) 05:48:29 INFO - Running post-run listener: _resource_record_post_run 05:48:29 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 36910080; Write bytes: 512063488; Read time: 385; Write time: 1937 05:48:29 INFO - TinderboxPrint: CPU usage
53.7% 05:48:29 INFO - TinderboxPrint: I/O read bytes / time
36,910,080 / 385 05:48:29 INFO - TinderboxPrint: I/O write bytes / time
512,063,488 / 1,937 05:48:29 INFO - TinderboxPrint: CPU idle
2,224.5 (46.3%) 05:48:29 INFO - TinderboxPrint: CPU system
957.0 (19.9%) 05:48:29 INFO - TinderboxPrint: CPU user
1,628.1 (33.9%) 05:48:29 INFO - TinderboxPrint: Swap in / out
245,547,008 / 0 05:48:29 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201349632; Write bytes: 203696128; Read time: 15878; Write time: 451 05:48:29 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35955712; Write bytes: 298463232; Read time: 370; Write time: 1452 05:48:30 INFO - Running post-run listener: _upload_blobber_files 05:48:30 INFO - Blob upload gear active. 05:48:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:30 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 05:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:48:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:31 INFO - (blobuploader) - INFO - Done attempting. 05:48:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:48:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:48:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:32 INFO - (blobuploader) - INFO - Done attempting. 05:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:33 INFO - (blobuploader) - INFO - Done attempting. 05:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:35 INFO - (blobuploader) - INFO - Done attempting. 05:48:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:35 INFO - Return code: 0 05:48:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9da238b6367f327e6f431313fcd755e50ee8d3854d2e9d0b74666f982fbcf1725557168e3bcca318010759072753b3629c5d98bb3740a2414605b8ba8e1ed937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ffd65248ded77f5eb11baa94b054a1e75ee2f0819f6fc46f0e079756e9c2983a488a2269057dc5fd3f4544b7714160947fecee04daf71594532b663aa75679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d8e45282eaeaab3769fa7ed903295b6def10be9039ea960f7e564ab9887bb7886f9a725221a946aab030efdc29aa4c29a99b089ddf5445f40ac9bb55529ea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e486bdcb88a26a86b3a021cb3514f743912c55eda8bd6e50ac169d8933dfc93b8269e42b6032fb13f3c00ead734cf3e200b798e6fdcc41fb7be0d5c746fee5"} 05:48:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:35 INFO - Contents: 05:48:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9da238b6367f327e6f431313fcd755e50ee8d3854d2e9d0b74666f982fbcf1725557168e3bcca318010759072753b3629c5d98bb3740a2414605b8ba8e1ed937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ffd65248ded77f5eb11baa94b054a1e75ee2f0819f6fc46f0e079756e9c2983a488a2269057dc5fd3f4544b7714160947fecee04daf71594532b663aa75679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d8e45282eaeaab3769fa7ed903295b6def10be9039ea960f7e564ab9887bb7886f9a725221a946aab030efdc29aa4c29a99b089ddf5445f40ac9bb55529ea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e486bdcb88a26a86b3a021cb3514f743912c55eda8bd6e50ac169d8933dfc93b8269e42b6032fb13f3c00ead734cf3e200b798e6fdcc41fb7be0d5c746fee5"} 05:48:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:35 INFO - Copying logs to upload dir... 05:48:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.947587 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-24 05:48:35.945670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 05:48:35.949041) ========= 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.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9da238b6367f327e6f431313fcd755e50ee8d3854d2e9d0b74666f982fbcf1725557168e3bcca318010759072753b3629c5d98bb3740a2414605b8ba8e1ed937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ffd65248ded77f5eb11baa94b054a1e75ee2f0819f6fc46f0e079756e9c2983a488a2269057dc5fd3f4544b7714160947fecee04daf71594532b663aa75679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d8e45282eaeaab3769fa7ed903295b6def10be9039ea960f7e564ab9887bb7886f9a725221a946aab030efdc29aa4c29a99b089ddf5445f40ac9bb55529ea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e486bdcb88a26a86b3a021cb3514f743912c55eda8bd6e50ac169d8933dfc93b8269e42b6032fb13f3c00ead734cf3e200b798e6fdcc41fb7be0d5c746fee5"} build_url:https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010844 build_url: 'https://queue.taskcluster.net/v1/task/PWFJqoOWSMmtd2atFMONWQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9da238b6367f327e6f431313fcd755e50ee8d3854d2e9d0b74666f982fbcf1725557168e3bcca318010759072753b3629c5d98bb3740a2414605b8ba8e1ed937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ffd65248ded77f5eb11baa94b054a1e75ee2f0819f6fc46f0e079756e9c2983a488a2269057dc5fd3f4544b7714160947fecee04daf71594532b663aa75679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d8e45282eaeaab3769fa7ed903295b6def10be9039ea960f7e564ab9887bb7886f9a725221a946aab030efdc29aa4c29a99b089ddf5445f40ac9bb55529ea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e486bdcb88a26a86b3a021cb3514f743912c55eda8bd6e50ac169d8933dfc93b8269e42b6032fb13f3c00ead734cf3e200b798e6fdcc41fb7be0d5c746fee5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 05:48:35.983031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:48:35.983349) ========= 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.DdyI2cwS4b/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.9Ums2d4o66/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:48:36.031356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 05:48:36.031673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 05:48:36.031987) ========= ========= Total master_lag: 0.68 =========