builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1490028570.14 results: success (0) buildid: 20170320082424 builduid: 88b41fa671ba46b2bb995a5890800df3 revision: 541e65cbfe6e25197e4525fa7828c52921d41745 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.140306) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.140704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.140993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.167701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.168077) ========= 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.MHqoS9MPEc/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.suS7ObOHVk/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-20 09:49:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2017-03-20 09:49:30 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.208927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.401326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.401675) ========= 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.MHqoS9MPEc/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.suS7ObOHVk/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.033490 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:30.456931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 09:49:30.457297) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541e65cbfe6e25197e4525fa7828c52921d41745 --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 541e65cbfe6e25197e4525fa7828c52921d41745 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MHqoS9MPEc/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.suS7ObOHVk/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-20 09:49:30,566 truncating revision to first 12 chars 2017-03-20 09:49:30,567 Setting DEBUG logging. 2017-03-20 09:49:30,567 attempt 1/10 2017-03-20 09:49:30,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/541e65cbfe6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 09:49:31,476 unpacking tar archive at: mozilla-aurora-541e65cbfe6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 09:49:31.659600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:31.659939) ========= script_repo_revision: 541e65cbfe6e25197e4525fa7828c52921d41745 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:31.660335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:31.660598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 09:49:31.680636) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-20 09:49:31.681030) ========= /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.MHqoS9MPEc/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.suS7ObOHVk/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 09:49:31 INFO - MultiFileLogger online at 20170320 09:49:31 in /builds/slave/test 09:49:31 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 09:49:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:49:31 INFO - {'append_to_log': False, 09:49:31 INFO - 'base_work_dir': '/builds/slave/test', 09:49:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:49:31 INFO - 'branch': 'Mozilla-Aurora', 09:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:31 INFO - 'config_files': ('talos/mac_config.py',), 09:49:31 INFO - 'default_actions': ('clobber', 09:49:31 INFO - 'read-buildbot-config', 09:49:31 INFO - 'download-and-extract', 09:49:31 INFO - 'populate-webroot', 09:49:31 INFO - 'create-virtualenv', 09:49:31 INFO - 'install', 09:49:31 INFO - 'run-tests'), 09:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:31 INFO - 'download_minidump_stackwalk': True, 09:49:31 INFO - 'download_symbols': 'ondemand', 09:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:31 INFO - 'gecko_profile': False, 09:49:31 INFO - 'gecko_profile_interval': 0, 09:49:31 INFO - 'installer_path': 'installer.exe', 09:49:31 INFO - 'log_level': 'info', 09:49:31 INFO - 'log_name': 'talos', 09:49:31 INFO - 'log_to_console': True, 09:49:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:49:31 INFO - 'opt_config_files': (), 09:49:31 INFO - 'pip_index': False, 09:49:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:31 INFO - 'cmd': ('bash', 09:49:31 INFO - '-c', 09:49:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:31 INFO - 'enabled': True, 09:49:31 INFO - 'halt_on_failure': False, 09:49:31 INFO - 'name': 'check_screen_resolution'},), 09:49:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:31 INFO - 'cmd': ('bash', 09:49:31 INFO - '-c', 09:49:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:31 INFO - 'enabled': True, 09:49:31 INFO - 'halt_on_failure': False, 09:49:31 INFO - 'name': 'check_screen_resolution'},), 09:49:31 INFO - 'run_cmd_checks_enabled': True, 09:49:31 INFO - 'suite': 'dromaeojs', 09:49:31 INFO - 'system_bits': '32', 09:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:31 INFO - 'title': 't-yosemite-r7-0051', 09:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:31 INFO - 'use_talos_json': True, 09:49:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:31 INFO - 'work_dir': 'build'} 09:49:31 INFO - [mozharness: 2017-03-20 16:49:31.893288Z] Running clobber step. 09:49:31 INFO - Running pre-action listener: _resource_record_pre_action 09:49:31 INFO - Running main action method: clobber 09:49:31 INFO - rmtree: /builds/slave/test/build 09:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - [mozharness: 2017-03-20 16:49:34.607693Z] Finished clobber step (success) 09:49:34 INFO - [mozharness: 2017-03-20 16:49:34.607821Z] Running read-buildbot-config step. 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: read_buildbot_config 09:49:34 INFO - Using buildbot properties: 09:49:34 INFO - { 09:49:34 INFO - "project": "", 09:49:34 INFO - "product": "firefox", 09:49:34 INFO - "script_repo_revision": "production", 09:49:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:49:34 INFO - "repository": "", 09:49:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:49:34 INFO - "buildid": "20170320082424", 09:49:34 INFO - "pgo_build": "False", 09:49:34 INFO - "basedir": "/builds/slave/test", 09:49:34 INFO - "buildnumber": 21, 09:49:34 INFO - "slavename": "t-yosemite-r7-0051", 09:49:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:49:34 INFO - "platform": "yosemite_r7", 09:49:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:49:34 INFO - "branch": "mozilla-aurora", 09:49:34 INFO - "repo_path": "releases/mozilla-aurora", 09:49:34 INFO - "revision": "541e65cbfe6e25197e4525fa7828c52921d41745", 09:49:34 INFO - "stage_platform": "macosx64", 09:49:34 INFO - "builduid": "88b41fa671ba46b2bb995a5890800df3", 09:49:34 INFO - "slavebuilddir": "test" 09:49:34 INFO - } 09:49:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - [mozharness: 2017-03-20 16:49:34.611031Z] Finished read-buildbot-config step (success) 09:49:34 INFO - [mozharness: 2017-03-20 16:49:34.611141Z] Running download-and-extract step. 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: download_and_extract 09:49:34 INFO - mkdir: /builds/slave/test/build/tests 09:49:34 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')]} 09:49:34 INFO - trying https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/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 09:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/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 09:49:35 INFO - Downloaded 1199 bytes. 09:49:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:49:35 INFO - Using the following test package requirements: 09:49:35 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:49:35 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:49:35 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:49:35 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'jsshell-mac.zip'], 09:49:35 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:49:35 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:49:35 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:49:35 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:49:35 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:49:35 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:49:35 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:49:35 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:49:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:49:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:49:35 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:49:37 INFO - Expected file size: 51782555 09:49:37 INFO - Obtained file size: 51782555 09:49:53 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 09:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:49:55 INFO - Expected file size: 51782555 09:49:55 INFO - Obtained file size: 51782555 09:50:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:50:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:50:10 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:50:11 INFO - Expected file size: 14404438 09:50:11 INFO - Obtained file size: 14404438 09:50: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')]} 09:50:11 INFO - trying https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:50:11 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/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 09:50:13 INFO - Downloaded 74750206 bytes. 09:50:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:50:13 INFO - mkdir: /builds/slave/test/properties 09:50:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:13 INFO - Contents: 09:50:13 INFO - build_url:https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - Running post-action listener: set_extra_try_arguments 09:50:14 INFO - [mozharness: 2017-03-20 16:50:14.166602Z] Finished download-and-extract step (success) 09:50:14 INFO - [mozharness: 2017-03-20 16:50:14.166726Z] Running populate-webroot step. 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: populate_webroot 09:50:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:14 INFO - '--tppagecycles', 09:50:14 INFO - '7'], 09:50:14 INFO - 'tests': ['tsvgm']}}, 09:50:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['damp', 'tps']}, 09:50:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'tests': ['damp', 'tps']}, 09:50:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['dromaeo_dom']}, 09:50:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['basic_compositor_video']}, 09:50:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:50:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tsvgx', 09:50:14 INFO - 'tsvgr_opacity', 09:50:14 INFO - 'tart', 09:50:14 INFO - 'tscrollx', 09:50:14 INFO - 'cart', 09:50:14 INFO - 'tsvg_static']}, 09:50:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:14 INFO - 'tsvgr_opacity', 09:50:14 INFO - 'tart', 09:50:14 INFO - 'tscrollx', 09:50:14 INFO - 'cart', 09:50:14 INFO - 'tsvg_static']}, 09:50:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tp5o']}, 09:50:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:50:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s', 09:50:14 INFO - '--xperf_path', 09:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:14 INFO - 'tests': ['tp5n']}, 09:50:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:50:14 INFO - 'talos_options': ['--xperf_path', 09:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:14 INFO - 'tests': ['tp5n']}}, 09:50:14 INFO - 'talos.zip': {'path': '', 09:50:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - [mozharness: 2017-03-20 16:50:14.185464Z] Finished populate-webroot step (success) 09:50:14 INFO - [mozharness: 2017-03-20 16:50:14.185602Z] Running create-virtualenv step. 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: create_virtualenv 09:50:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:14 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 09:50:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:14 INFO - Using real prefix '/tools/python27' 09:50:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:17 INFO - Installing pip.................done. 09:50:17 INFO - Return code: 0 09:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:50:18 INFO - Reading from file tmpfile_stdout 09:50:18 INFO - Output received: 09:50:18 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) 09:50:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:18 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')]} 09:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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')]} 09:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:18 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 09:50:18 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 09:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:18 INFO - 'HOME': '/Users/cltbld', 09:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:18 INFO - 'LOGNAME': 'cltbld', 09:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:18 INFO - 'MOZ_NO_REMOTE': '1', 09:50:18 INFO - 'NO_EM_RESTART': '1', 09:50:18 INFO - 'PAGER': '/bin/cat', 09:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:18 INFO - 'PWD': '/builds/slave/test', 09:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:18 INFO - 'SHELL': '/bin/bash', 09:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:18 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:18 INFO - 'USER': 'cltbld', 09:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:18 INFO - 'XPC_FLAGS': '0x0', 09:50:18 INFO - 'XPC_SERVICE_NAME': '0', 09:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:18 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 09:50:18 INFO - Cleaning up... 09:50:18 INFO - Return code: 0 09:50:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:18 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')]} 09:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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')]} 09:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:18 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 09:50:18 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 09:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:18 INFO - 'HOME': '/Users/cltbld', 09:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:18 INFO - 'LOGNAME': 'cltbld', 09:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:18 INFO - 'MOZ_NO_REMOTE': '1', 09:50:18 INFO - 'NO_EM_RESTART': '1', 09:50:18 INFO - 'PAGER': '/bin/cat', 09:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:18 INFO - 'PWD': '/builds/slave/test', 09:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:18 INFO - 'SHELL': '/bin/bash', 09:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:18 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:18 INFO - 'USER': 'cltbld', 09:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:18 INFO - 'XPC_FLAGS': '0x0', 09:50:18 INFO - 'XPC_SERVICE_NAME': '0', 09:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:18 INFO - Downloading/unpacking psutil>=3.1.1 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:22 INFO - Installing collected packages: psutil 09:50:22 INFO - Running setup.py install for psutil 09:50:22 INFO - building 'psutil._psutil_osx' extension 09:50:22 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 09:50:22 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 09:50:23 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 09:50:23 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 09:50:23 INFO - building 'psutil._psutil_posix' extension 09:50:23 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 09:50:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:50:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:50:23 INFO - ^ 09:50:23 INFO - 1 warning generated. 09:50:23 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 09:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:23 INFO - Successfully installed psutil 09:50:23 INFO - Cleaning up... 09:50:23 INFO - Return code: 0 09:50:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:50:23 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')]} 09:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:23 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')]} 09:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:24 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:24 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 09:50:24 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 09:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:24 INFO - 'HOME': '/Users/cltbld', 09:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:24 INFO - 'LOGNAME': 'cltbld', 09:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:24 INFO - 'MOZ_NO_REMOTE': '1', 09:50:24 INFO - 'NO_EM_RESTART': '1', 09:50:24 INFO - 'PAGER': '/bin/cat', 09:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:24 INFO - 'PWD': '/builds/slave/test', 09:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:24 INFO - 'SHELL': '/bin/bash', 09:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:24 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:24 INFO - 'USER': 'cltbld', 09:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:24 INFO - 'XPC_FLAGS': '0x0', 09:50:24 INFO - 'XPC_SERVICE_NAME': '0', 09:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:50:24 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 09:50:24 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 09:50:24 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 09:50:24 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 09:50:24 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 09:50:24 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 09:50:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:50:27 INFO - Installing collected packages: mozsystemmonitor 09:50:27 INFO - Running setup.py install for mozsystemmonitor 09:50:27 INFO - Successfully installed mozsystemmonitor 09:50:27 INFO - Cleaning up... 09:50:27 INFO - Return code: 0 09:50:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:27 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:27 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 09:50:27 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 09:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:27 INFO - 'HOME': '/Users/cltbld', 09:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:27 INFO - 'LOGNAME': 'cltbld', 09:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:27 INFO - 'MOZ_NO_REMOTE': '1', 09:50:27 INFO - 'NO_EM_RESTART': '1', 09:50:27 INFO - 'PAGER': '/bin/cat', 09:50:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:27 INFO - 'PWD': '/builds/slave/test', 09:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:27 INFO - 'SHELL': '/bin/bash', 09:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:27 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:27 INFO - 'USER': 'cltbld', 09:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:27 INFO - 'XPC_FLAGS': '0x0', 09:50:27 INFO - 'XPC_SERVICE_NAME': '0', 09:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:31 INFO - warning: no files found matching '*.txt' 09:50:31 INFO - no previously-included directories found matching 'build' 09:50:31 INFO - no previously-included directories found matching 'dist' 09:50:31 INFO - no previously-included directories found matching '.git*' 09:50:31 INFO - Installing collected packages: jsonschema, functools32 09:50:31 INFO - Running setup.py install for functools32 09:50:31 INFO - warning: no files found matching '*.txt' 09:50:31 INFO - no previously-included directories found matching 'build' 09:50:31 INFO - no previously-included directories found matching 'dist' 09:50:31 INFO - no previously-included directories found matching '.git*' 09:50:31 INFO - Successfully installed jsonschema functools32 09:50:31 INFO - Cleaning up... 09:50:31 INFO - Return code: 0 09:50:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:31 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:31 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 09:50:31 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 09:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:31 INFO - 'HOME': '/Users/cltbld', 09:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:31 INFO - 'LOGNAME': 'cltbld', 09:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:31 INFO - 'MOZ_NO_REMOTE': '1', 09:50:31 INFO - 'NO_EM_RESTART': '1', 09:50:31 INFO - 'PAGER': '/bin/cat', 09:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:31 INFO - 'PWD': '/builds/slave/test', 09:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:31 INFO - 'SHELL': '/bin/bash', 09:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:31 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:31 INFO - 'USER': 'cltbld', 09:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:31 INFO - 'XPC_FLAGS': '0x0', 09:50:31 INFO - 'XPC_SERVICE_NAME': '0', 09:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:50:31 INFO - Cleaning up... 09:50:31 INFO - Return code: 0 09:50:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:31 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:31 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 09:50:31 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 09:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:31 INFO - 'HOME': '/Users/cltbld', 09:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:31 INFO - 'LOGNAME': 'cltbld', 09:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:31 INFO - 'MOZ_NO_REMOTE': '1', 09:50:31 INFO - 'NO_EM_RESTART': '1', 09:50:31 INFO - 'PAGER': '/bin/cat', 09:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:31 INFO - 'PWD': '/builds/slave/test', 09:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:31 INFO - 'SHELL': '/bin/bash', 09:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:31 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:31 INFO - 'USER': 'cltbld', 09:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:31 INFO - 'XPC_FLAGS': '0x0', 09:50:31 INFO - 'XPC_SERVICE_NAME': '0', 09:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:32 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 09:50:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50:34 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 09:50:34 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 09:50:34 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 09:50:34 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 09:50:34 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 09:50:34 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 09:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:50:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50:35 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 09:50:35 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 09:50:35 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 09:50:35 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 09:50:35 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 09:50:35 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 09:50:35 INFO - Downloading docopt-0.6.1.tar.gz 09:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:36 INFO - Running setup.py install for blobuploader 09:50:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:50:36 INFO - Running setup.py install for requests 09:50:36 INFO - Running setup.py install for docopt 09:50:36 INFO - Successfully installed blobuploader requests docopt 09:50:36 INFO - Cleaning up... 09:50:36 INFO - Return code: 0 09:50:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:36 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:36 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 09:50:36 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 09:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:36 INFO - 'HOME': '/Users/cltbld', 09:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:36 INFO - 'LOGNAME': 'cltbld', 09:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:36 INFO - 'MOZ_NO_REMOTE': '1', 09:50:36 INFO - 'NO_EM_RESTART': '1', 09:50:36 INFO - 'PAGER': '/bin/cat', 09:50:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:36 INFO - 'PWD': '/builds/slave/test', 09:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:36 INFO - 'SHELL': '/bin/bash', 09:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:36 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:36 INFO - 'USER': 'cltbld', 09:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:36 INFO - 'XPC_FLAGS': '0x0', 09:50:36 INFO - 'XPC_SERVICE_NAME': '0', 09:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ErFGjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-MnDx3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-gKZGY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-9N9Au5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-6sGSXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-EfCMyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-s9ELAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:37 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ONqI2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-8SaUjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-VyQujM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-vzg6hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-AcG6uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-GxClNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-lrRgBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-T4oVBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-xtFiS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:38 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-55OLvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:38 INFO - Running setup.py install for manifestparser 09:50:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:50:39 INFO - Running setup.py install for mozcrash 09:50:39 INFO - Running setup.py install for mozdebug 09:50:39 INFO - Running setup.py install for mozdevice 09:50:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:50:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:50:39 INFO - Running setup.py install for mozfile 09:50:39 INFO - Running setup.py install for mozhttpd 09:50:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:50:39 INFO - Running setup.py install for mozinfo 09:50:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Running setup.py install for mozInstall 09:50:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Running setup.py install for mozleak 09:50:40 INFO - Running setup.py install for mozlog 09:50:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Running setup.py install for moznetwork 09:50:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Running setup.py install for mozprocess 09:50:40 INFO - Running setup.py install for mozprofile 09:50:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:50:40 INFO - Running setup.py install for mozrunner 09:50:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:50:41 INFO - Running setup.py install for mozscreenshot 09:50:41 INFO - Running setup.py install for moztest 09:50:41 INFO - Running setup.py install for mozversion 09:50:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:50:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:41 INFO - Cleaning up... 09:50:41 INFO - Return code: 0 09:50:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:41 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:41 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 09:50:41 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 09:50:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:41 INFO - 'HOME': '/Users/cltbld', 09:50:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:41 INFO - 'LOGNAME': 'cltbld', 09:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:41 INFO - 'MOZ_NO_REMOTE': '1', 09:50:41 INFO - 'NO_EM_RESTART': '1', 09:50:41 INFO - 'PAGER': '/bin/cat', 09:50:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:41 INFO - 'PWD': '/builds/slave/test', 09:50:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:41 INFO - 'SHELL': '/bin/bash', 09:50:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:41 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:41 INFO - 'USER': 'cltbld', 09:50:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:41 INFO - 'XPC_FLAGS': '0x0', 09:50:41 INFO - 'XPC_SERVICE_NAME': '0', 09:50:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:41 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-wCDmrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:41 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-bpbIUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-YpKzbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-OZdPUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-KJIzc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-IVPHLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-GSaOI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-vqLZBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-FwjN4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-gENOcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:42 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-hs_3zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:42 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)) 09:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-CNYG9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:43 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)) 09:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-qdWDyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:43 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)) 09:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ERuhsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:43 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)) 09:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ze0wh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:43 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)) 09:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-R3_5ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:43 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)) 09:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:43 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-GHk8va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:43 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)) 09:50:43 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)) 09:50:43 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)) 09:50:43 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)) 09:50:43 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)) 09:50:43 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)) 09:50:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:46 INFO - Downloading blessings-1.6.tar.gz 09:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:46 INFO - Installing collected packages: blessings 09:50:46 INFO - Running setup.py install for blessings 09:50:46 INFO - Successfully installed blessings 09:50:46 INFO - Cleaning up... 09:50:46 INFO - Return code: 0 09:50:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:46 INFO - Reading from file tmpfile_stdout 09:50:46 INFO - Current package versions: 09:50:46 INFO - blessings == 1.6 09:50:46 INFO - blobuploader == 1.2.4 09:50:46 INFO - docopt == 0.6.1 09:50:46 INFO - functools32 == 3.2.3-2 09:50:46 INFO - jsonschema == 2.5.1 09:50:46 INFO - manifestparser == 1.1 09:50:46 INFO - mozInstall == 1.12 09:50:46 INFO - mozcrash == 1.0 09:50:46 INFO - mozdebug == 0.1 09:50:46 INFO - mozdevice == 0.49 09:50:46 INFO - mozfile == 1.2 09:50:46 INFO - mozhttpd == 0.7 09:50:46 INFO - mozinfo == 0.9 09:50:46 INFO - mozleak == 0.1 09:50:46 INFO - mozlog == 3.4 09:50:46 INFO - moznetwork == 0.27 09:50:46 INFO - mozprocess == 0.25 09:50:46 INFO - mozprofile == 0.28 09:50:46 INFO - mozrunner == 6.13 09:50:46 INFO - mozscreenshot == 0.1 09:50:46 INFO - mozsystemmonitor == 0.3 09:50:46 INFO - moztest == 0.8 09:50:46 INFO - mozversion == 1.4 09:50:46 INFO - psutil == 3.1.1 09:50:46 INFO - requests == 1.2.3 09:50:46 INFO - wsgiref == 0.1.2 09:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:46 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')]} 09:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:46 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')]} 09:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:46 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 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:46 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 09:50:46 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 09:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:46 INFO - 'HOME': '/Users/cltbld', 09:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:46 INFO - 'LOGNAME': 'cltbld', 09:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:46 INFO - 'MOZ_NO_REMOTE': '1', 09:50:46 INFO - 'NO_EM_RESTART': '1', 09:50:46 INFO - 'PAGER': '/bin/cat', 09:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:46 INFO - 'PWD': '/builds/slave/test', 09:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:46 INFO - 'SHELL': '/bin/bash', 09:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:46 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:46 INFO - 'USER': 'cltbld', 09:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:46 INFO - 'XPC_FLAGS': '0x0', 09:50:46 INFO - 'XPC_SERVICE_NAME': '0', 09:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 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)) 09:50:47 INFO - Cleaning up... 09:50:47 INFO - Return code: 0 09:50:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:50: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')]} 09:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17adc3be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, '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.MHqoS9MPEc/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.suS7ObOHVk/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 09:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:50:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:50:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:47 INFO - 'HOME': '/Users/cltbld', 09:50:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:47 INFO - 'LOGNAME': 'cltbld', 09:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:47 INFO - 'MOZ_NO_REMOTE': '1', 09:50:47 INFO - 'NO_EM_RESTART': '1', 09:50:47 INFO - 'PAGER': '/bin/cat', 09:50:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:47 INFO - 'PWD': '/builds/slave/test', 09:50:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:47 INFO - 'SHELL': '/bin/bash', 09:50:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:50:47 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:50:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:47 INFO - 'USER': 'cltbld', 09:50:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:47 INFO - 'XPC_FLAGS': '0x0', 09:50:47 INFO - 'XPC_SERVICE_NAME': '0', 09:50:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:50:47 INFO - Cleaning up... 09:50:47 INFO - Return code: 0 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - Running post-action listener: _start_resource_monitoring 09:50:47 INFO - Starting resource monitoring. 09:50:47 INFO - [mozharness: 2017-03-20 16:50:47.523726Z] Finished create-virtualenv step (success) 09:50:47 INFO - [mozharness: 2017-03-20 16:50:47.524649Z] Running install step. 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: install 09:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:47 INFO - Reading from file tmpfile_stdout 09:50:47 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:50:47 INFO - Reading from file tmpfile_stdout 09:50:47 INFO - Output received: 09:50:47 INFO - Usage: mozinstall [options] installer 09:50:47 INFO - Options: 09:50:47 INFO - -h, --help show this help message and exit 09:50:47 INFO - -d DEST, --destination=DEST 09:50:47 INFO - Directory to install application into. [default: 09:50:47 INFO - "/builds/slave/test"] 09:50:47 INFO - --app=APP Application being installed. [default: firefox] 09:50:47 INFO - mkdir: /builds/slave/test/build/application 09:50:47 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'] 09:50:47 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 09:51:08 INFO - Reading from file tmpfile_stdout 09:51:08 INFO - Output received: 09:51:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:51:08 INFO - Running post-action listener: _resource_record_post_action 09:51:08 INFO - [mozharness: 2017-03-20 16:51:08.221397Z] Finished install step (success) 09:51:08 INFO - [mozharness: 2017-03-20 16:51:08.221549Z] Running run-tests step. 09:51:08 INFO - Running pre-action listener: _resource_record_pre_action 09:51:08 INFO - Running main action method: run_tests 09:51:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:51:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:51:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:51:08 INFO - 2017-03-20 09:51:08.236 screenresolution[1625:7472] starting screenresolution argv=screenresolution get 09:51:08 INFO - 2017-03-20 09:51:08.238 screenresolution[1625:7472] Display 0: 1600x1200x32@60 09:51:08 INFO - 2017-03-20 09:51:08.244 screenresolution[1626:7475] starting screenresolution argv=screenresolution list 09:51:08 INFO - Available Modes on Display 0 09:51:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:51:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:51:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:51:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:51:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:51:08 INFO - Intel Iris: 09:51:08 INFO - Chipset Model: Intel Iris 09:51:08 INFO - Type: GPU 09:51:08 INFO - Bus: Built-In 09:51:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:51:08 INFO - Vendor: Intel (0x8086) 09:51:08 INFO - Device ID: 0x0a2e 09:51:08 INFO - Revision ID: 0x0009 09:51:08 INFO - Displays: 09:51:08 INFO - Display: 09:51:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:51:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:51:08 INFO - Display Serial Number: 1600x1200 60 09:51:08 INFO - Main Display: Yes 09:51:08 INFO - Mirror: Off 09:51:08 INFO - Online: Yes 09:51:08 INFO - Rotation: Supported 09:51:08 INFO - Return code: 0 09:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:08 INFO - Python 2.7.3 09:51:08 INFO - Return code: 0 09:51:08 INFO - grabbing minidump binary from tooltool 09:51:08 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')]} 09:51:08 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 0x104951d30>, '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 0x104878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104946be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:08 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 09:51:08 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 09:51:08 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 09:51:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:08 INFO - Return code: 0 09:51:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:51:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:08 INFO - ENV: RUST_BACKTRACE is now 1 09:51:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:51:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:08 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/KaGftP--Rq6WTjnlAsrQyQ/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 09:51:08 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/KaGftP--Rq6WTjnlAsrQyQ/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 09:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MHqoS9MPEc/Render', 09:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:08 INFO - 'HOME': '/Users/cltbld', 09:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:08 INFO - 'LOGNAME': 'cltbld', 09:51:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:08 INFO - 'MOZ_NO_REMOTE': '1', 09:51:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:08 INFO - 'NO_EM_RESTART': '1', 09:51:08 INFO - 'PAGER': '/bin/cat', 09:51:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:08 INFO - 'PWD': '/builds/slave/test', 09:51:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:08 INFO - 'RUST_BACKTRACE': '1', 09:51:08 INFO - 'SHELL': '/bin/bash', 09:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.suS7ObOHVk/Listeners', 09:51:08 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 09:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:08 INFO - 'USER': 'cltbld', 09:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:08 INFO - 'XPC_FLAGS': '0x0', 09:51:08 INFO - 'XPC_SERVICE_NAME': '0', 09:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:08 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/KaGftP--Rq6WTjnlAsrQyQ/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 09:51:08 INFO - mozversion application_buildid: 20170320082424 09:51:08 INFO - mozversion application_changeset: 541e65cbfe6e25197e4525fa7828c52921d41745 09:51:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:51:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:08 INFO - mozversion application_name: Firefox 09:51:08 INFO - mozversion application_remotingname: firefox-dev 09:51:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:08 INFO - mozversion application_vendor: Mozilla 09:51:08 INFO - mozversion application_version: 54.0a2 09:51:08 INFO - mozversion platform_buildid: 20170320082424 09:51:08 INFO - mozversion platform_changeset: 541e65cbfe6e25197e4525fa7828c52921d41745 09:51:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:08 INFO - mozversion platform_version: 54.0a2 09:51:08 INFO - using testdate: 1490028668 09:51:08 INFO - actual date: 1490028668 09:51:08 INFO - starting webserver on 'localhost:49248' 09:51:08 INFO - SUITE-START | Running 2 tests 09:51:08 INFO - TEST-START | dromaeo_css 09:51:08 INFO - operating with platform_type : mac_ 09:51:08 INFO - Initialising browser for dromaeo_css test... 09:51:08 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpY_z9xt/profile http://localhost:49248/getInfo.html) 09:51:11 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 09:51:11 INFO - PROCESS | 1636 | colorDepth:24 09:51:11 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 09:51:11 INFO - PROCESS | 1636 | __metrics 09:51:11 INFO - PROCESS | 1636 | 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" 09:51:11 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:51:12 INFO - TEST-INFO | 1636: exit 0 09:51:12 INFO - Browser initialized. 09:51:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:12 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpY_z9xt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:24 INFO - PROCESS | 1638 | RSS: Main: 214806528 09:51:24 INFO - PROCESS | 1638 | 09:54:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 09:54:30 INFO - PROCESS | 1638 | RSS: Main: 344584192 09:54:30 INFO - PROCESS | 1638 | 09:56:13 INFO - PROCESS | 1638 | ************************* 09:56:13 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 09:56:13 INFO - PROCESS | 1638 | 09:56:13 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:56:13 INFO - PROCESS | 1638 | Full stack: 09:56:13 INFO - PROCESS | 1638 | ************************* 09:57:33 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 09:57:34 INFO - PROCESS | 1638 | RSS: Main: 353148928 09:57:34 INFO - PROCESS | 1638 | 10:00:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:00:37 INFO - PROCESS | 1638 | RSS: Main: 330211328 10:00:37 INFO - PROCESS | 1638 | 10:03:40 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:03:40 INFO - PROCESS | 1638 | RSS: Main: 343273472 10:03:40 INFO - PROCESS | 1638 | 10:06:44 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:06:45 INFO - PROCESS | 1638 | RSS: Main: 323833856 10:06:45 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:09:48 INFO - PROCESS | 1638 | RSS: Main: 487727104 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | __start_tp_report 10:09:48 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:09:48 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:09:48 INFO - PROCESS | 1638 | |i|pagename|runs| 10:09:48 INFO - PROCESS | 1638 | |0;dojo.html;2872.5978363029176;3400.608929973054;3419.2135808763983;3440.501127336535;3468.1329667583104;5885.9705701471485;5899.2036075129845;5914.201582786322;5942.5840191186635;5952.987992041352;5851.034579294422;5918.911216331759;5937.079752638338;5938.13896984938;5944.524438044957;5324.068288049585;5354.866128346784;5367.677939323634;5447.400785913566;5453.618246722731;5265;5283;5342.545883599899;5468.7539060742365;5479.150731636582;4431.224535706238;4556.931646025312;5291.973540132313;5379.488948549882;5393.541548968343;5348.331458567679;5367.007103685811;5371.650842695251;5380.24676545284;5389.78440862367;5186.818461353834;5319.3616765987945;5319.893602127974;5321.707306098163;5358.196270559409;5900.1739756434135;5901;5905.940940590582;5908.763649454059;5920.97039514804;5191.195364718475;6215.81352559424;6224.9688751556405;6332.145160403333;6402.423781859655;6394.968025159891;6398.648074355909;6398.840028999266;6404.903926441107;6435.839104022437;5644.125160600113;5996.550258730569;6010.429009244115;6011.969940150271;6025.126356678257;6269.122322874801;6299.559030867887;6371;6494.9350506495275;6516.315786842313;5254.6847189168775;6293.653849038347;6400.935990640127;6418.19772528434;6424.550281480345;6420.293767685551;6422.967885160544;6424.38968298011;6425.3574642536305;6432.935670643327;6258;6407.13503677007;6419.197600299963;6424.100625912376;6449.935500644933;6272.905906411407;6318.304986451579;6342.587731797418;6384.553081284265;6391.9680401598625;5199.74001299941;5204.973975130176;5205.349331333583;5213.400458947193;5219.634625576249;4561.29299958507;4583.74789386587;4585.77071146448;4592.196365636;4612.86161415158;5552.7223638817895;5571.025070612626;5737.311522617312;5867.530597552271;5929.99190137669;6337.2395312562785;6395.904061439082;6400.3599640036555;6404.807855764241;6416.390442907917;6055.182550355734;6055.909161362583;6056.394360563909;6074.453299203093;6077.027675571976;5401.891962160735;5492.066348720727;5644.491995720405;5658.292713410824;5696.8860622787315;6431.48548116159;6433.517486188648;6440.742370305135;6451.774187903307;6452.9677351612945;6316.810495685137;6415.775447859489;6426.678666066771;6435.227772667123;6446.129772480655;6540.934590654033;6631.3700198481065;6647.434968027772;6647.4682025438815;6667.399934005963;6422.454091402283;6423.261324947691;6431.324710905287;6436.485081193587;6458.095866578588;6274.435300822948;6319.778807741707;6394.360563943568;6407.1350367701625;6449.677516124269;6271.122042913905;6279.340669229665;6379.138816259931;6390.073439351361;6396.744130234739;6353.650549219838;6355.428011478804;6369.33122022181;6371.171747672773;6395.040743888454;5959.046552551571;6204.875902482016;6218.098375735402;6218.22272215973;6233.532485063548;5133.640645154804;6199.318075011655;6218.098375735583;6320.936790632035;6382.585131966407;5352.661834541364;6098.634081955097;6189.50483961273;6205.937940620536;6215.316315205414 10:09:48 INFO - PROCESS | 1638 | |1;ext.html;716.1549371741346;733.6698485681443;798.8242586630939;816.2531283875254;816.261283538398;32669.836650816742;39109.60890391095;41387;41432.79283603578;41467.585324146785;35521.82239088801;40372.394414083814;40678.38982415266;40683;40724.38913416301;7283.162436319838;9219.216366608829;9373.250139988784;9401.952990235039;9409.717708468757;7384.889226661578;11017.669469915916;11253.943730281337;11403.771924561504;11405.315681059163;11177.385243811586;11211.439428028565;11217.831732524019;11218.158638102133;11238.381888996142;7167.211606723256;11198.048165905908;11259.380734059623;11275.943620281887;11277.774444511146;7328.67020984057;7375.704971801121;7376.852462950765;7379.188289288174;8833.734987950373;38634.61365386338;38820.61179388198;38843.22313553742;38871.8056409719;38898.61101388978;3809.3524100902914;3842.4236364545263;3853.98073009636;3894.7243015706176;4013.7190396672245;26048.73951260482;26541.73458265412;26553.73446265532;27912.720872791215;28695.28261793451;3013.457577636025;3078.1381213260324;3159.3839201355745;3161.8893338733264;3201.5677883485896;361486;363037;363918;364235;366041;39890.60109398869;40634.390484142765;50154.49845501571;50375.24437133446;50402.991940160995;43410.78294608507;53442;54326.456735432934;56229;56655.15017274744;13236.470541178245;13246.867531324757;13260.07179497426;13270;13279.203247805162;11325.263857849213;11335.979761821476;11351.659450216506;11353.54585816558;11358.716032099264;11563.710907227218;11596.536138554533;11621.186516943733;11684.70788230301;11742.354170520532;4822.180229360947;5275.20871869215;5648.293963254593;5744.339400968858;5767.106098554731;1027.2946908132465;1104.9392283424488;1136.3920302638214;1147.4721628051022;1183.2663748475827;22163.556728865333;26582.37921395833;26702.332441689112;26703.798329075238;27036.32409189786;1174.753301806613;1191.3447603818038;1202.828433196874;1231.7105480212142;1249.787536118862;13318.200907945555;13353.399097040656;13663.521776737767;13710.45158193681;14048.578542643738;428474;428568;431362.6863731322;431525;432272;54190;54343.72828135834;54455.455445445834;54474.18288725672;54498.45501544934;1301.316808675472;1389.215093472185;1466.8239811222722;1471.7571600686194;1481.3259966715118;25361.61957570601;26149.869250654385;26189.345266368495;26198.476030479665;26334.341641459116;40906.79546602248;41026.58973410347;41071.589284106776;41087;41100.588994109676;424830;425728;426112;426709;427356;32138.517922230716;32959.01122966315;32989.50515742218;33103.66896331006;33163.83926562559;41294.38058429186;41891;42885.57114428816;43011.35482967695;43024.56975430206;32582.67417325891;32953.34093318168;34568;35824.28351433009;35914.64085359113;34348.82825585856;34572.30855382828;34597;35724.46413303751;35937.28125437529;34433.655663443045;34792.652073479956;35354.40905159223;35391.82304088463;35436.46845297271;29999;31045;31248.687513124576;31269;31330;23317.883410583516;23382.883085584464;23427.648585271574;23592.410189744707;23824.88087559551 10:09:48 INFO - PROCESS | 1638 | |2;jquery.html;383.7083816299615;406.69904270839567;422.3010916932477;427.1116078556603;450.22111746678246;10608.469576521173;14736.852631473683;20976.790232097694;21289.787102128976;22011.33965981019;20633.484162895937;20737.96310184492;20894.16423343068;22952.540949181006;23172.768272317273;6394.784990851746;6732.831679208034;6749.662516874161;6812.386885180333;6992.720291188346;4157.189348077126;4312.784360781964;4911.287863259825;6854.760083397082;6999.965000175018;3680.245549662313;8076.35389168868;8078.394120440961;8079.717209897654;8089.757307280762;7743.845123097506;7843.176466470995;7915.248051435105;7934.285914267686;8051.114377418479;6756.121704178426;7090.255523170044;7676.884846727304;7737.342325902305;7741.8451630967065;25998.6100208497;26410.867945660342;26420.603690944652;26527.336816579547;26628.801703923175;3259.706626403611;3292.160499072745;3362.4620060790403;3400.1839558506026;3520.542329497149;15317.46388876395;15754.212289385485;16006;16164.595885102966;16748.83251167485;2017.9091940862697;2027.4829918370722;2040.33689051059;2067.658836292025;2093.235968871351;160266;160735;165734.171329145;168769;168871;15785.343174751326;16061.518154455385;16111.374940638263;19467;20647.483812904797;33511;33541.66458335386;33603;33627;33685.494717579255;9983.700488985342;10003.24975626831;10201.948990255001;10209.132223761064;10356.275060745826;8402.579871006425;8436.072032076467;8451.746447606582;8608.612612432456;8609.182127697859;6740.561863478858;8716.912830871737;9437.858432123523;9527.28545359087;9615.990321016332;3294.2752594429667;3839.9040023999623;3944.1914407546383;3948.1314110895555;3956.723029387915;906.4606559097326;951.9243255121806;961.5480724059681;982.9777031886757;1003.5132960514145;19830.603387932162;20301.593968120556;21884.671729924063;22007.779922200574;22104.784236867126;1059.3749687684303;1065.0840277361463;1076.8438576406377;1084.6366467233408;1085.1264731890747;10526.789464210673;10622.628208012682;11318.434078296052;11444.256123351955;11512.19414640967;762380;771653;776038;793140;809897;155413;156005;157271;160072;160721;1171.3733152763232;1191.4221602522769;1226.0620625221713;1228.5454381878762;1229.2317301686626;18138.820976636478;18686.90656546763;19306.90346548258;19323.323683671006;19366.4190074298;61712.69143654253;62515.374846250954;63035.054474182005;63622.04566931592;64187;85039;87169.56415217883;87480.56259718661;89810;91897;11315.547378104784;12017.939910300742;12316.815247771112;12682.985361171268;12981.610551683465;11557.364344961108;13853.930730346283;13904.652383690489;14013.369398377301;14049.929750351183;11555.4800033997;11693.88306116928;11747.765044699228;11963.700907477383;12056.939715301367;10514.421706805893;10931.906809319005;11611.883881161419;12218;12220.450079746255;10820.701515818153;10940.781184376427;11779.116566257393;12077.818832717692;12153.756924861276;12681.92203662699;12809.359532023174;12821.679458013625;13043.34783260852;13121.212727236396;11746.882531174579;11746.94126529396;11755;11848.76302473963;12057.51769929193 10:09:48 INFO - PROCESS | 1638 | |3;mootools.html;1431.162769779679;1546.791183190269;1548.233624355944;1567.5375764149576;1583.1530131379714;10574.154067674586;11179.72050698732;11180.273282236649;11180.385078820662;11185.49665265064;10748.247622666417;10867.456627168649;11015.063719583824;11068.335899846015;11078.833817492745;2374.442006128558;2411.240459255329;2412.0834083048503;2416.2388847513066;2419.4072452249134;2105.52625659227;2216.9358707820256;2366.514864452783;2369.8815059247054;2370.573296806574;2328.6739856420113;2348.894299756515;2357.2456813819585;2361.89371478283;2363.775441333071;2300.6779050932882;2328.3946173994714;2332.1371092695726;2338.625819868813;2344.4607740219844;2296.724393072842;2365.3258821235863;2367.337145599235;2370.810335173182;2374.3826605082804;10918.563257469692;11009.174311926638;11025.83461248074;11030.613928512463;11040.447977601169;5396.91904621431;5490.094134467808;5689.345725241567;5695.34503532095;5698.800541981052;2984.149517387534;3310.702036816698;3431.9485207721905;3519.102628829632;3554.537910071674;1119.7873897009433;1133.5125895864776;1196.5692350753723;1202.5129822421934;1206.9879301207052;13596.11625244356;13927.094738841943;14851.48019819312;15297;15329.233538323038;4565.360849481075;4679.602233810164;4682.812687492462;4687.273472611751;4704.200285951397;11680;11687.415629218505;11688.70778230551;11708.824367634492;11711.004564611932;4816.8073277069225;4934.8026078957155;5694.572907031989;5697.857553561194;5699.430056994351;4240.219107974658;5107.97446012775;5220.895582088413;5224.895502089937;5230.869228269247;3348.9116037287977;3501.844391350848;3519.7184225261917;3643.799591022519;3702.315071711742;1000.3847633705365;1003.1824063388315;1004.4832303222187;1016.7000734783256;1016.8983101689772;910.0717268386342;917.8118485710413;938.9201917837061;945.621751299472;977.9853302200472;6541.6402097885075;6560.179977502812;6579;6608.339166083353;6804;1001.1840350114634;1014.8274793285159;1018.674024312213;1033.5297439664935;1036.9740756481149;4237.237297286456;4244.957550424518;4271.594198551133;4387.319965405367;4428.667849911205;13277.535286265127;13761.655958600915;13761.862381376259;13786.310684465736;13925.303734813218;13465.326733663474;13581.456741730417;13835.723285534234;13873.653158671113;13905;9901;9947.253955953332;10003.44981026036;10130.696079117492;10133.64532241368;6374.426301632875;6469.8706025880165;6473.158489396348;6542.182227221598;6613.570117942319;11896.643100706993;12143.635690929286;12185.451654675384;12188.45151968146;12322.876771232173;10774.461276935965;11186.272892261977;12398.070144739;12470.937645311715;12474.313912734886;8375.874361884698;8404.789880253042;8423.199796019368;8530.274926631306;8572;10117.038881306264;10326.896731032593;10341.74145646365;10347.379157250589;10353.844692329772;8965.193132618097;9271.76820579491;9275.25797936177;9279.62881484733;9293.024232455495;8980.191782739585;9013.278937684838;9054.502002389932;9067;9074.591643375932;7560.395168386626;7819.726309579138;7824.374050075867;7933.246341597539;7957;4817.662763606514;5805.506531944832;5817.883642327214;5892.793752218652;5944.227250457413;4729.219678752967;5143.691378517301;5783.450572195635;5841.634138174047;5925.585209035326 10:09:48 INFO - PROCESS | 1638 | |4;prototype.html;360.38554264978217;372.2945019188637;374.20854891903633;377.58654273570465;380.2490082087877;4158.338663255518;4295.926018495376;4318.805653745581;4971.955889263255;5011.216531518703;4727.669063165571;4782.402199725035;4883.829065982683;4908.337374454448;4963.801447942078;3452.2405070884365;3743.3449146399407;4168.749875007494;4277.032565020095;4321.286987647034;3930.5479869815053;4011.879643610682;4366.454193225847;4382.693211475198;4404.955950440487;3816.542014958195;3847.2497862916744;3971.880843574683;4270.807813648377;4283.472751076864;3974.324364857981;4221.472315960505;4260.360945858115;4280.608802139317;4289.978550107261;3616.801075940822;4140.668746500272;4148.79256037197;4161.292580261363;4163.333866581333;4563.471237135564;4788.209945359012;4831.758412079382;4851.660383773137;4878.609711223094;4774.092922344744;4785.617150627942;4787.40157480315;4793.568578827887;4795.7699669653775;4351.73889566627;4663.44038715353;4997.175466048134;5091.694498330112;5270.2358158067245;4115.218108559364;4238.533761286256;4251.44731184944;4275.764832934187;4307.277089164328;5432.728363581884;5496.258005169291;5522.392536820947;5551.72241387933;5573.804916827932;4020.4572382727956;4114.6091121343425;4176.206520761107;4367.5414081520985;4414.616107302021;4154.3976123462535;4270.829166833292;4349.412829268072;4442.644993277081;4474.910501790011;3780.3348639209294;4037.970317569001;4128.710990230655;4765.8093676252565;4779.880502987384;4956.653034287565;5216.66091704038;5295;5325.227841962971;5333;1266.9873301266869;1387.5074348606302;1393.5122707052653;1438.6547228665045;1493.320539154682;997.5211898288862;1103.45379037377;1105.4693747001484;1121.8445001648315;1130.3556972525746;4110.383442483651;4376.956230437655;4433.778311084433;4975.825846095369;5009.373828271466;4834;5057.974710126499;5065.645404821701;5423.647462914898;5439.347278326626;3900.8439662413753;4154.3976123462535;4414.271645178574;4459.843905463294;4938.4320803107385;2504.1235567551576;2684;2808.9185663519283;2821.351089249484;2839.432113577293;5094.821681241213;5157.432682404932;5374.328208973879;5682.011296046433;5759.65442073477;4937.2104760810025;5256.729028364514;5363.5440987516495;5584.357798853184;5723.6279641823985;4989.779548101133;5176.886969301619;5278.228929811879;5452.863678408072;5597.552195824405;4724.692894961817;4990.201567749288;5034.59723222134;5414.4281466304765;5465.672059676433;4874.488178741181;4988.401391833003;5123.308353372247;5313.734313284243;5474.452554744494;4913;4969.732718156847;5039.596832253337;5343.973280133574;5615.775368985195;4004.2191772604065;4327.891802704958;4342.478902531717;4343.565643435758;4355.281378572627;4824.95175048245;4885.265730665563;5185.066687996197;5394.730263486888;5403.162509810985;4589.35270173195;4706.764661766966;4857.9152238329625;5152.536271735562;5222.433270019055;4479;4555.635549155993;4583.220852455157;4998.325226094431;5187.455317191791;4468.882779305174;4556.476005259437;4613.146567884952;5058.595312375075;5138.280640710378;5173.896522069613;5177;5179.611529135254;5206.8958620828125;5266.526012658725;4229.546862819496;4602.838900638461;4914.690095655036;4937.753112344297;5054.494550545063 10:09:48 INFO - PROCESS | 1638 | |5;yui.html;713.58968593059;732.340893196123;771.0439055571094;825.2737590919991;832.9708460203892;15034.17312047837;15913.602159946007;16001.83998160018;16009.75985360219;16010.839891601096;14459.92770036151;14488;14582;14611.05028173168;15079.246037698125;902.3999040637968;908.0737647599444;922.0963455813308;931.8788557487517;937.5171786529943;910.6858133943779;919.6045700348848;924.3760461688368;924.653255029364;925.1673493855517;956.741679746468;959.0888655777039;960.7886265021684;961.4471678784691;962.0523784072683;959.0265880131637;959.7360725800391;959.8800149981253;960.1550635440802;960.7261930349887;582.6678793087941;713.7002458967246;714.0895358418006;714.3606472207397;715.4705517916756;15386;15798.763018554731;15822.05067695942;15996.520104396886;16320.183990800413;13955.162690238516;14156.433742650283;14165.15009099447;14202.289885505683;14269.096549050053;9754;11440.177179235077;11570.421478926104;11726.35505047222;11872.465739041763;3189.617245930503;3203.6315823680343;3207.278362368472;3840.0783811885226;3843.0008197868474;106255.99999999923;112632;114974.42512787467;115115;116047;9526.428414295164;10694.411807350514;10757.892421075689;10758.0855627271;11420.972112509913;22384.888075559516;22953.196638117584;23065.42336441569;23081.88459057694;23115.422114447272;7667.8849817252785;7679.923200768033;7693.692252309845;7765.72819951299;7784.766457006185;4251.893702657459;4273.55127711592;4423.292273236267;4428.800703968329;4505.864824055284;3445.913852153666;3490.214701692099;3540.716742660581;3546.6098729139776;3595.7123430125525;667.9198496180393;672.6065251827638;678.4199509419474;687.9415249703832;689.3313485918651;647.4496677823906;657.8849149278165;685.266764561914;690.8860038093658;704.2323866984908;10312.896871031344;10482.21383396233;10524.26330156897;10565.894341056644;10646.307989980782;646.2923099206362;701.2251462134268;705.7016131030532;708.8369674974784;732.6593134192626;4899.020195960822;5099.821506247264;5139;5148.871278218;5165;80255;107045;109305.45347273213;109608;114825.4258728701;92502.53748731213;92949;93188;95239;97252;80470.19529804627;81835.7724634131;83788.3242335162;84140.15859841446;84254.57872710597;8515.787105322417;9315.767105822408;9740.951295243478;9776.657816976372;9862.408255504693;44461.333080003176;46996;53696.73151634373;54600;55161.72419137879;58885.822283554946;60527;66024.96466325606;69368.6531567339;71935.64032180015;12895.289022932016;13047.217166970013;13273.597008542774;13548;13694.452221911011;14609.488667896572;14734.852651473348;14977.925110374379;15105.773413398589;15495.922520387327;11482.942585287354;13623.142208231997;13727.656808579866;14066.367013484212;14162.645933851736;13300.534481293109;13352.132111412728;14066.156030638194;14080.507182248572;14092.577222683336;11236.381998990135;12774.425150868048;13928.094673846168;14195.361208745839;14207.573772786833;10772.353658780497;11014.38587224619;11284.548618055185;11648.184627076023;11844.111691622991;9641;10179.592816287563;11270.154738394816;11522.13583981188;11563.42182890869 10:09:48 INFO - PROCESS | 1638 | __end_tp_report 10:09:48 INFO - PROCESS | 1638 | __start_cc_report 10:09:48 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1918 10:09:48 INFO - PROCESS | 1638 | __end_cc_report 10:09:48 INFO - PROCESS | 1638 | __startTimestamp1490029788518__endTimestamp 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:09:48 INFO - PROCESS | 1638 | Number of tests: 6 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5891.33 Median:6199.32 stddev:692.33 (11.2%) stddev-sans-first:652.69 10:09:48 INFO - PROCESS | 1638 | Values: 2872.6 3400.6 3419.2 3440.5 3468.1 5886.0 5899.2 5914.2 5942.6 5953.0 5851.0 5918.9 5937.1 5938.1 5944.5 5324.1 5354.9 5367.7 5447.4 5453.6 5265.0 5283.0 5342.5 5468.8 5479.2 4431.2 4556.9 5292.0 5379.5 5393.5 5348.3 5367.0 5371.7 5380.2 5389.8 5186.8 5319.4 5319.9 5321.7 5358.2 5900.2 5901.0 5905.9 5908.8 5921.0 5191.2 6215.8 6225.0 6332.1 6402.4 6395.0 6398.6 6398.8 6404.9 6435.8 5644.1 5996.6 6010.4 6012.0 6025.1 6269.1 6299.6 6371.0 6494.9 6516.3 5254.7 6293.7 6400.9 6418.2 6424.6 6420.3 6423.0 6424.4 6425.4 6432.9 6258.0 6407.1 6419.2 6424.1 6449.9 6272.9 6318.3 6342.6 6384.6 6392.0 5199.7 5205.0 5205.3 5213.4 5219.6 4561.3 4583.7 4585.8 4592.2 4612.9 5552.7 5571.0 5737.3 5867.5 5930.0 6337.2 6395.9 6400.4 6404.8 6416.4 6055.2 6055.9 6056.4 6074.5 6077.0 5401.9 5492.1 5644.5 5658.3 5696.9 6431.5 6433.5 6440.7 6451.8 6453.0 6316.8 6415.8 6426.7 6435.2 6446.1 6540.9 6631.4 6647.4 6647.5 6667.4 6422.5 6423.3 6431.3 6436.5 6458.1 6274.4 6319.8 6394.4 6407.1 6449.7 6271.1 6279.3 6379.1 6390.1 6396.7 6353.7 6355.4 6369.3 6371.2 6395.0 5959.0 6204.9 6218.1 6218.2 6233.5 5133.6 6199.3 6218.1 6320.9 6382.6 5352.7 6098.6 6189.5 6205.9 6215.3 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:54482.70 Median:34694.83 stddev:108040.20 (311.4%) stddev-sans-first:108267.87 10:09:48 INFO - PROCESS | 1638 | Values: 716.2 733.7 798.8 816.3 816.3 32669.8 39109.6 41387.0 41432.8 41467.6 35521.8 40372.4 40678.4 40683.0 40724.4 7283.2 9219.2 9373.3 9402.0 9409.7 7384.9 11017.7 11253.9 11403.8 11405.3 11177.4 11211.4 11217.8 11218.2 11238.4 7167.2 11198.0 11259.4 11275.9 11277.8 7328.7 7375.7 7376.9 7379.2 8833.7 38634.6 38820.6 38843.2 38871.8 38898.6 3809.4 3842.4 3854.0 3894.7 4013.7 26048.7 26541.7 26553.7 27912.7 28695.3 3013.5 3078.1 3159.4 3161.9 3201.6 361486.0 363037.0 363918.0 364235.0 366041.0 39890.6 40634.4 50154.5 50375.2 50403.0 43410.8 53442.0 54326.5 56229.0 56655.2 13236.5 13246.9 13260.1 13270.0 13279.2 11325.3 11336.0 11351.7 11353.5 11358.7 11563.7 11596.5 11621.2 11684.7 11742.4 4822.2 5275.2 5648.3 5744.3 5767.1 1027.3 1104.9 1136.4 1147.5 1183.3 22163.6 26582.4 26702.3 26703.8 27036.3 1174.8 1191.3 1202.8 1231.7 1249.8 13318.2 13353.4 13663.5 13710.5 14048.6 428474.0 428568.0 431362.7 431525.0 432272.0 54190.0 54343.7 54455.5 54474.2 54498.5 1301.3 1389.2 1466.8 1471.8 1481.3 25361.6 26149.9 26189.3 26198.5 26334.3 40906.8 41026.6 41071.6 41087.0 41100.6 424830.0 425728.0 426112.0 426709.0 427356.0 32138.5 32959.0 32989.5 33103.7 33163.8 41294.4 41891.0 42885.6 43011.4 43024.6 32582.7 32953.3 34568.0 35824.3 35914.6 34348.8 34572.3 34597.0 35724.5 35937.3 34433.7 34792.7 35354.4 35391.8 35436.5 29999.0 31045.0 31248.7 31269.0 31330.0 23317.9 23382.9 23427.6 23592.4 23824.9 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:44486.38 Median:11493.70 stddev:130658.63 (1136.8%) stddev-sans-first:130983.19 10:09:48 INFO - PROCESS | 1638 | Values: 383.7 406.7 422.3 427.1 450.2 10608.5 14736.9 20976.8 21289.8 22011.3 20633.5 20738.0 20894.2 22952.5 23172.8 6394.8 6732.8 6749.7 6812.4 6992.7 4157.2 4312.8 4911.3 6854.8 7000.0 3680.2 8076.4 8078.4 8079.7 8089.8 7743.8 7843.2 7915.2 7934.3 8051.1 6756.1 7090.3 7676.9 7737.3 7741.8 25998.6 26410.9 26420.6 26527.3 26628.8 3259.7 3292.2 3362.5 3400.2 3520.5 15317.5 15754.2 16006.0 16164.6 16748.8 2017.9 2027.5 2040.3 2067.7 2093.2 160266.0 160735.0 165734.2 168769.0 168871.0 15785.3 16061.5 16111.4 19467.0 20647.5 33511.0 33541.7 33603.0 33627.0 33685.5 9983.7 10003.2 10201.9 10209.1 10356.3 8402.6 8436.1 8451.7 8608.6 8609.2 6740.6 8716.9 9437.9 9527.3 9616.0 3294.3 3839.9 3944.2 3948.1 3956.7 906.5 951.9 961.5 983.0 1003.5 19830.6 20301.6 21884.7 22007.8 22104.8 1059.4 1065.1 1076.8 1084.6 1085.1 10526.8 10622.6 11318.4 11444.3 11512.2 762380.0 771653.0 776038.0 793140.0 809897.0 155413.0 156005.0 157271.0 160072.0 160721.0 1171.4 1191.4 1226.1 1228.5 1229.2 18138.8 18686.9 19306.9 19323.3 19366.4 61712.7 62515.4 63035.1 63622.0 64187.0 85039.0 87169.6 87480.6 89810.0 91897.0 11315.5 12017.9 12316.8 12683.0 12981.6 11557.4 13853.9 13904.7 14013.4 14049.9 11555.5 11693.9 11747.8 11963.7 12056.9 10514.4 10931.9 11611.9 12218.0 12220.5 10820.7 10940.8 11779.1 12077.8 12153.8 12681.9 12809.4 12821.7 13043.3 13121.2 11746.9 11746.9 11755.0 11848.8 12057.5 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6642.23 Median:2370.69 stddev:4192.53 (176.8%) stddev-sans-first:4186.01 10:09:48 INFO - PROCESS | 1638 | Values: 1431.2 1546.8 1548.2 1567.5 1583.2 10574.2 11179.7 11180.3 11180.4 11185.5 10748.2 10867.5 11015.1 11068.3 11078.8 2374.4 2411.2 2412.1 2416.2 2419.4 2105.5 2216.9 2366.5 2369.9 2370.6 2328.7 2348.9 2357.2 2361.9 2363.8 2300.7 2328.4 2332.1 2338.6 2344.5 2296.7 2365.3 2367.3 2370.8 2374.4 10918.6 11009.2 11025.8 11030.6 11040.4 5396.9 5490.1 5689.3 5695.3 5698.8 2984.1 3310.7 3431.9 3519.1 3554.5 1119.8 1133.5 1196.6 1202.5 1207.0 13596.1 13927.1 14851.5 15297.0 15329.2 4565.4 4679.6 4682.8 4687.3 4704.2 11680.0 11687.4 11688.7 11708.8 11711.0 4816.8 4934.8 5694.6 5697.9 5699.4 4240.2 5108.0 5220.9 5224.9 5230.9 3348.9 3501.8 3519.7 3643.8 3702.3 1000.4 1003.2 1004.5 1016.7 1016.9 910.1 917.8 938.9 945.6 978.0 6541.6 6560.2 6579.0 6608.3 6804.0 1001.2 1014.8 1018.7 1033.5 1037.0 4237.2 4245.0 4271.6 4387.3 4428.7 13277.5 13761.7 13761.9 13786.3 13925.3 13465.3 13581.5 13835.7 13873.7 13905.0 9901.0 9947.3 10003.4 10130.7 10133.6 6374.4 6469.9 6473.2 6542.2 6613.6 11896.6 12143.6 12185.5 12188.5 12322.9 10774.5 11186.3 12398.1 12470.9 12474.3 8375.9 8404.8 8423.2 8530.3 8572.0 10117.0 10326.9 10341.7 10347.4 10353.8 8965.2 9271.8 9275.3 9279.6 9293.0 8980.2 9013.3 9054.5 9067.0 9074.6 7560.4 7819.7 7824.4 7933.2 7957.0 4817.7 5805.5 5817.9 5892.8 5944.2 4729.2 5143.7 5783.5 5841.6 5925.6 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4367.62 Median:4726.18 stddev:1193.02 (25.2%) stddev-sans-first:1157.83 10:09:48 INFO - PROCESS | 1638 | Values: 360.4 372.3 374.2 377.6 380.2 4158.3 4295.9 4318.8 4972.0 5011.2 4727.7 4782.4 4883.8 4908.3 4963.8 3452.2 3743.3 4168.7 4277.0 4321.3 3930.5 4011.9 4366.5 4382.7 4405.0 3816.5 3847.2 3971.9 4270.8 4283.5 3974.3 4221.5 4260.4 4280.6 4290.0 3616.8 4140.7 4148.8 4161.3 4163.3 4563.5 4788.2 4831.8 4851.7 4878.6 4774.1 4785.6 4787.4 4793.6 4795.8 4351.7 4663.4 4997.2 5091.7 5270.2 4115.2 4238.5 4251.4 4275.8 4307.3 5432.7 5496.3 5522.4 5551.7 5573.8 4020.5 4114.6 4176.2 4367.5 4414.6 4154.4 4270.8 4349.4 4442.6 4474.9 3780.3 4038.0 4128.7 4765.8 4779.9 4956.7 5216.7 5295.0 5325.2 5333.0 1267.0 1387.5 1393.5 1438.7 1493.3 997.5 1103.5 1105.5 1121.8 1130.4 4110.4 4377.0 4433.8 4975.8 5009.4 4834.0 5058.0 5065.6 5423.6 5439.3 3900.8 4154.4 4414.3 4459.8 4938.4 2504.1 2684.0 2808.9 2821.4 2839.4 5094.8 5157.4 5374.3 5682.0 5759.7 4937.2 5256.7 5363.5 5584.4 5723.6 4989.8 5176.9 5278.2 5452.9 5597.6 4724.7 4990.2 5034.6 5414.4 5465.7 4874.5 4988.4 5123.3 5313.7 5474.5 4913.0 4969.7 5039.6 5344.0 5615.8 4004.2 4327.9 4342.5 4343.6 4355.3 4825.0 4885.3 5185.1 5394.7 5403.2 4589.4 4706.8 4857.9 5152.5 5222.4 4479.0 4555.6 4583.2 4998.3 5187.5 4468.9 4556.5 4613.1 5058.6 5138.3 5173.9 5177.0 5179.6 5206.9 5266.5 4229.5 4602.8 4914.7 4937.8 5054.5 10:09:48 INFO - PROCESS | 1638 | 10:09:48 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21061.75 Median:4047.45 stddev:30683.89 (758.1%) stddev-sans-first:30731.92 10:09:48 INFO - PROCESS | 1638 | Values: 713.6 732.3 771.0 825.3 833.0 15034.2 15913.6 16001.8 16009.8 16010.8 14459.9 14488.0 14582.0 14611.1 15079.2 902.4 908.1 922.1 931.9 937.5 910.7 919.6 924.4 924.7 925.2 956.7 959.1 960.8 961.4 962.1 959.0 959.7 959.9 960.2 960.7 582.7 713.7 714.1 714.4 715.5 15386.0 15798.8 15822.1 15996.5 16320.2 13955.2 14156.4 14165.2 14202.3 14269.1 9754.0 11440.2 11570.4 11726.4 11872.5 3189.6 3203.6 3207.3 3840.1 3843.0 106256.0 112632.0 114974.4 115115.0 116047.0 9526.4 10694.4 10757.9 10758.1 11421.0 22384.9 22953.2 23065.4 23081.9 23115.4 7667.9 7679.9 7693.7 7765.7 7784.8 4251.9 4273.6 4423.3 4428.8 4505.9 3445.9 3490.2 3540.7 3546.6 3595.7 667.9 672.6 678.4 687.9 689.3 647.4 657.9 685.3 690.9 704.2 10312.9 10482.2 10524.3 10565.9 10646.3 646.3 701.2 705.7 708.8 732.7 4899.0 5099.8 5139.0 5148.9 5165.0 80255.0 107045.0 109305.5 109608.0 114825.4 92502.5 92949.0 93188.0 95239.0 97252.0 80470.2 81835.8 83788.3 84140.2 84254.6 8515.8 9315.8 9741.0 9776.7 9862.4 44461.3 46996.0 53696.7 54600.0 55161.7 58885.8 60527.0 66025.0 69368.7 71935.6 12895.3 13047.2 13273.6 13548.0 13694.5 14609.5 14734.9 14977.9 15105.8 15495.9 11482.9 13623.1 13727.7 14066.4 14162.6 13300.5 13352.1 14066.2 14080.5 14092.6 11236.4 12774.4 13928.1 14195.4 14207.6 10772.4 11014.4 11284.5 11648.2 11844.1 9641.0 10179.6 11270.2 11522.1 11563.4 10:09:48 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:09:48 INFO - PROCESS | 1638 | 10:09:49 INFO - TEST-INFO | 1638: exit 0 10:09:49 INFO - TEST-OK | dromaeo_css | took 1120386ms 10:09:49 INFO - TEST-START | kraken 10:09:49 INFO - operating with platform_type : mac_ 10:09:49 INFO - Initialising browser for kraken test... 10:09:49 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpJn_yk5/profile http://localhost:49248/getInfo.html) 10:09:51 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 10:09:51 INFO - PROCESS | 1649 | colorDepth:24 10:09:51 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 10:09:51 INFO - PROCESS | 1649 | __metrics 10:09:51 INFO - PROCESS | 1649 | 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" 10:09:51 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:52 INFO - TEST-INFO | 1649: exit 0 10:09:52 INFO - Browser initialized. 10:09:52 INFO - Running cycle 1/1 for kraken test... 10:09:52 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpJn_yk5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:04 INFO - PROCESS | 1650 | RSS: Main: 214704128 10:10:04 INFO - PROCESS | 1650 | 10:10:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:08 INFO - PROCESS | 1650 | RSS: Main: 267665408 10:10:08 INFO - PROCESS | 1650 | 10:10:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:10:11 INFO - PROCESS | 1650 | RSS: Main: 279511040 10:10:11 INFO - PROCESS | 1650 | 10:10:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:10:15 INFO - PROCESS | 1650 | RSS: Main: 375549952 10:10:15 INFO - PROCESS | 1650 | 10:10:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:10:18 INFO - PROCESS | 1650 | RSS: Main: 278188032 10:10:18 INFO - PROCESS | 1650 | 10:10:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:20 INFO - PROCESS | 1650 | RSS: Main: 279281664 10:10:20 INFO - PROCESS | 1650 | 10:10:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:24 INFO - PROCESS | 1650 | RSS: Main: 320532480 10:10:24 INFO - PROCESS | 1650 | 10:10:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:27 INFO - PROCESS | 1650 | RSS: Main: 321200128 10:10:27 INFO - PROCESS | 1650 | 10:10:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:10:31 INFO - PROCESS | 1650 | RSS: Main: 319246336 10:10:31 INFO - PROCESS | 1650 | 10:10:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:33 INFO - PROCESS | 1650 | RSS: Main: 296177664 10:10:33 INFO - PROCESS | 1650 | 10:10:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:36 INFO - PROCESS | 1650 | RSS: Main: 299618304 10:10:36 INFO - PROCESS | 1650 | 10:10:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:38 INFO - PROCESS | 1650 | RSS: Main: 304103424 10:10:38 INFO - PROCESS | 1650 | 10:10:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:42 INFO - PROCESS | 1650 | RSS: Main: 319361024 10:10:42 INFO - PROCESS | 1650 | 10:10:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:46 INFO - PROCESS | 1650 | RSS: Main: 312971264 10:10:46 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:10:48 INFO - PROCESS | 1650 | RSS: Main: 357568512 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | __start_tp_report 10:10:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:10:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:10:48 INFO - PROCESS | 1650 | |i|pagename|runs| 10:10:48 INFO - PROCESS | 1650 | |0;ai-astar;116;118;159;171;115;115;115;114;114;114 10:10:48 INFO - PROCESS | 1650 | |1;audio-beat-detection;150;135;135;144;110;110;114;137;156;137 10:10:48 INFO - PROCESS | 1650 | |2;audio-dft;185;185;184;185;183;184;186;185;186;183 10:10:48 INFO - PROCESS | 1650 | |3;audio-fft;84;59;60;95;60;63;63;61;77;61 10:10:48 INFO - PROCESS | 1650 | |4;audio-oscillator;90;68;89;69;69;69;82;68;68;85 10:10:48 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;92;89;92;92;93;90;95;93;93;89 10:10:48 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;95;96;96;96;97;96;96;96;96 10:10:48 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;83;86;86;87;83;85;82;82;86 10:10:48 INFO - PROCESS | 1650 | |8;json-parse-financial;62;60;59;61;64;63;64;65;65;66 10:10:48 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;55;61;64;64;63;59;58;60;60;61 10:10:48 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;84;83;83;84;83;86;85;84;89 10:10:48 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;139;144;139;145;134;139;151;152;216;175 10:10:48 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;167;165;165;168;163;165;152;198;223 10:10:48 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;65;64;66;65;64;65;64;62;63 10:10:48 INFO - PROCESS | 1650 | __end_tp_report 10:10:48 INFO - PROCESS | 1650 | __start_cc_report 10:10:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2127 10:10:48 INFO - PROCESS | 1650 | __end_cc_report 10:10:48 INFO - PROCESS | 1650 | __startTimestamp1490029848308__endTimestamp 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:10:48 INFO - PROCESS | 1650 | Number of tests: 14 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:125.10 Median:115.50 stddev:21.25 (18.4%) stddev-sans-first:22.28 10:10:48 INFO - PROCESS | 1650 | Values: 116.0 118.0 159.0 171.0 115.0 115.0 115.0 114.0 114.0 114.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:137.00 stddev:16.32 (11.9%) stddev-sans-first:16.08 10:10:48 INFO - PROCESS | 1650 | Values: 150.0 135.0 135.0 144.0 110.0 110.0 114.0 137.0 156.0 137.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:1.07 (0.6%) stddev-sans-first:1.13 10:10:48 INFO - PROCESS | 1650 | Values: 185.0 185.0 184.0 185.0 183.0 184.0 186.0 185.0 186.0 183.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:68.30 Median:63.00 stddev:12.57 (20.0%) stddev-sans-first:11.98 10:10:48 INFO - PROCESS | 1650 | Values: 84.0 59.0 60.0 95.0 60.0 63.0 63.0 61.0 77.0 61.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:75.50 stddev:9.55 (12.6%) stddev-sans-first:8.61 10:10:48 INFO - PROCESS | 1650 | Values: 90.0 68.0 89.0 69.0 69.0 69.0 82.0 68.0 68.0 85.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:92.50 stddev:1.93 (2.1%) stddev-sans-first:2.05 10:10:48 INFO - PROCESS | 1650 | Values: 92.0 89.0 92.0 92.0 93.0 90.0 95.0 93.0 93.0 89.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:10:48 INFO - PROCESS | 1650 | Values: 95.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.50 stddev:1.84 (2.2%) stddev-sans-first:1.94 10:10:48 INFO - PROCESS | 1650 | Values: 85.0 83.0 86.0 86.0 87.0 83.0 85.0 82.0 82.0 86.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:64.00 stddev:2.33 (3.6%) stddev-sans-first:2.45 10:10:48 INFO - PROCESS | 1650 | Values: 62.0 60.0 59.0 61.0 64.0 63.0 64.0 65.0 65.0 66.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:2.80 (4.6%) stddev-sans-first:2.15 10:10:48 INFO - PROCESS | 1650 | Values: 55.0 61.0 64.0 64.0 63.0 59.0 58.0 60.0 60.0 61.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:1.90 (2.3%) stddev-sans-first:1.94 10:10:48 INFO - PROCESS | 1650 | Values: 83.0 84.0 83.0 83.0 84.0 83.0 86.0 85.0 84.0 89.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:148.00 stddev:24.83 (16.8%) stddev-sans-first:25.79 10:10:48 INFO - PROCESS | 1650 | Values: 139.0 144.0 139.0 145.0 134.0 139.0 151.0 152.0 216.0 175.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:166.00 stddev:21.04 (12.7%) stddev-sans-first:22.11 10:10:48 INFO - PROCESS | 1650 | Values: 165.0 167.0 165.0 165.0 168.0 163.0 165.0 152.0 198.0 223.0 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 10:10:48 INFO - PROCESS | 1650 | Values: 65.0 65.0 64.0 66.0 65.0 64.0 65.0 64.0 62.0 63.0 10:10:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:10:48 INFO - PROCESS | 1650 | 10:10:49 INFO - TEST-INFO | 1650: exit 0 10:10:49 INFO - TEST-OK | kraken | took 59992ms 10:10:49 INFO - SUITE-END | took 1180s 10:10:49 INFO - Completed test suite (00:19:40) 10:10:49 INFO - javascript benchmark 10:10:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7625.751256893099, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2872.5978363029176, 3400.608929973054, 3419.2135808763983, 3440.501127336535, 3468.1329667583104, 5885.9705701471485, 5899.2036075129845, 5914.201582786322, 5942.5840191186635, 5952.987992041352, 5851.034579294422, 5918.911216331759, 5937.079752638338, 5938.13896984938, 5944.524438044957, 5324.068288049585, 5354.866128346784, 5367.677939323634, 5447.400785913566, 5453.618246722731, 5265.0, 5283.0, 5342.545883599899, 5468.7539060742365, 5479.150731636582, 4431.224535706238, 4556.931646025312, 5291.973540132313, 5379.488948549882, 5393.541548968343, 5348.331458567679, 5367.007103685811, 5371.650842695251, 5380.24676545284, 5389.78440862367, 5186.818461353834, 5319.3616765987945, 5319.893602127974, 5321.707306098163, 5358.196270559409, 5900.1739756434135, 5901.0, 5905.940940590582, 5908.763649454059, 5920.97039514804, 5191.195364718475, 6215.81352559424, 6224.9688751556405, 6332.145160403333, 6402.423781859655, 6394.968025159891, 6398.648074355909, 6398.840028999266, 6404.903926441107, 6435.839104022437, 5644.125160600113, 5996.550258730569, 6010.429009244115, 6011.969940150271, 6025.126356678257, 6269.122322874801, 6299.559030867887, 6371.0, 6494.9350506495275, 6516.315786842313, 5254.6847189168775, 6293.653849038347, 6400.935990640127, 6418.19772528434, 6424.550281480345, 6420.293767685551, 6422.967885160544, 6424.38968298011, 6425.3574642536305, 6432.935670643327, 6258.0, 6407.13503677007, 6419.197600299963, 6424.100625912376, 6449.935500644933, 6272.905906411407, 6318.304986451579, 6342.587731797418, 6384.553081284265, 6391.9680401598625, 5199.74001299941, 5204.973975130176, 5205.349331333583, 5213.400458947193, 5219.634625576249, 4561.29299958507, 4583.74789386587, 4585.77071146448, 4592.196365636, 4612.86161415158, 5552.7223638817895, 5571.025070612626, 5737.311522617312, 5867.530597552271, 5929.99190137669, 6337.2395312562785, 6395.904061439082, 6400.3599640036555, 6404.807855764241, 6416.390442907917, 6055.182550355734, 6055.909161362583, 6056.394360563909, 6074.453299203093, 6077.027675571976, 5401.891962160735, 5492.066348720727, 5644.491995720405, 5658.292713410824, 5696.8860622787315, 6431.48548116159, 6433.517486188648, 6440.742370305135, 6451.774187903307, 6452.9677351612945, 6316.810495685137, 6415.775447859489, 6426.678666066771, 6435.227772667123, 6446.129772480655, 6540.934590654033, 6631.3700198481065, 6647.434968027772, 6647.4682025438815, 6667.399934005963, 6422.454091402283, 6423.261324947691, 6431.324710905287, 6436.485081193587, 6458.095866578588, 6274.435300822948, 6319.778807741707, 6394.360563943568, 6407.1350367701625, 6449.677516124269, 6271.122042913905, 6279.340669229665, 6379.138816259931, 6390.073439351361, 6396.744130234739, 6353.650549219838, 6355.428011478804, 6369.33122022181, 6371.171747672773, 6395.040743888454, 5959.046552551571, 6204.875902482016, 6218.098375735402, 6218.22272215973, 6233.532485063548, 5133.640645154804, 6199.318075011655, 6218.098375735583, 6320.936790632035, 6382.585131966407, 5352.661834541364, 6098.634081955097, 6189.50483961273, 6205.937940620536, 6215.316315205414], "value": 5845.628255469695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.1549371741346, 733.6698485681443, 798.8242586630939, 816.2531283875254, 816.261283538398, 32669.836650816742, 39109.60890391095, 41387.0, 41432.79283603578, 41467.585324146785, 35521.82239088801, 40372.394414083814, 40678.38982415266, 40683.0, 40724.38913416301, 7283.162436319838, 9219.216366608829, 9373.250139988784, 9401.952990235039, 9409.717708468757, 7384.889226661578, 11017.669469915916, 11253.943730281337, 11403.771924561504, 11405.315681059163, 11177.385243811586, 11211.439428028565, 11217.831732524019, 11218.158638102133, 11238.381888996142, 7167.211606723256, 11198.048165905908, 11259.380734059623, 11275.943620281887, 11277.774444511146, 7328.67020984057, 7375.704971801121, 7376.852462950765, 7379.188289288174, 8833.734987950373, 38634.61365386338, 38820.61179388198, 38843.22313553742, 38871.8056409719, 38898.61101388978, 3809.3524100902914, 3842.4236364545263, 3853.98073009636, 3894.7243015706176, 4013.7190396672245, 26048.73951260482, 26541.73458265412, 26553.73446265532, 27912.720872791215, 28695.28261793451, 3013.457577636025, 3078.1381213260324, 3159.3839201355745, 3161.8893338733264, 3201.5677883485896, 361486.0, 363037.0, 363918.0, 364235.0, 366041.0, 39890.60109398869, 40634.390484142765, 50154.49845501571, 50375.24437133446, 50402.991940160995, 43410.78294608507, 53442.0, 54326.456735432934, 56229.0, 56655.15017274744, 13236.470541178245, 13246.867531324757, 13260.07179497426, 13270.0, 13279.203247805162, 11325.263857849213, 11335.979761821476, 11351.659450216506, 11353.54585816558, 11358.716032099264, 11563.710907227218, 11596.536138554533, 11621.186516943733, 11684.70788230301, 11742.354170520532, 4822.180229360947, 5275.20871869215, 5648.293963254593, 5744.339400968858, 5767.106098554731, 1027.2946908132465, 1104.9392283424488, 1136.3920302638214, 1147.4721628051022, 1183.2663748475827, 22163.556728865333, 26582.37921395833, 26702.332441689112, 26703.798329075238, 27036.32409189786, 1174.753301806613, 1191.3447603818038, 1202.828433196874, 1231.7105480212142, 1249.787536118862, 13318.200907945555, 13353.399097040656, 13663.521776737767, 13710.45158193681, 14048.578542643738, 428474.0, 428568.0, 431362.6863731322, 431525.0, 432272.0, 54190.0, 54343.72828135834, 54455.455445445834, 54474.18288725672, 54498.45501544934, 1301.316808675472, 1389.215093472185, 1466.8239811222722, 1471.7571600686194, 1481.3259966715118, 25361.61957570601, 26149.869250654385, 26189.345266368495, 26198.476030479665, 26334.341641459116, 40906.79546602248, 41026.58973410347, 41071.589284106776, 41087.0, 41100.588994109676, 424830.0, 425728.0, 426112.0, 426709.0, 427356.0, 32138.517922230716, 32959.01122966315, 32989.50515742218, 33103.66896331006, 33163.83926562559, 41294.38058429186, 41891.0, 42885.57114428816, 43011.35482967695, 43024.56975430206, 32582.67417325891, 32953.34093318168, 34568.0, 35824.28351433009, 35914.64085359113, 34348.82825585856, 34572.30855382828, 34597.0, 35724.46413303751, 35937.28125437529, 34433.655663443045, 34792.652073479956, 35354.40905159223, 35391.82304088463, 35436.46845297271, 29999.0, 31045.0, 31248.687513124576, 31269.0, 31330.0, 23317.883410583516, 23382.883085584464, 23427.648585271574, 23592.410189744707, 23824.88087559551], "value": 18401.010975761055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.7083816299615, 406.69904270839567, 422.3010916932477, 427.1116078556603, 450.22111746678246, 10608.469576521173, 14736.852631473683, 20976.790232097694, 21289.787102128976, 22011.33965981019, 20633.484162895937, 20737.96310184492, 20894.16423343068, 22952.540949181006, 23172.768272317273, 6394.784990851746, 6732.831679208034, 6749.662516874161, 6812.386885180333, 6992.720291188346, 4157.189348077126, 4312.784360781964, 4911.287863259825, 6854.760083397082, 6999.965000175018, 3680.245549662313, 8076.35389168868, 8078.394120440961, 8079.717209897654, 8089.757307280762, 7743.845123097506, 7843.176466470995, 7915.248051435105, 7934.285914267686, 8051.114377418479, 6756.121704178426, 7090.255523170044, 7676.884846727304, 7737.342325902305, 7741.8451630967065, 25998.6100208497, 26410.867945660342, 26420.603690944652, 26527.336816579547, 26628.801703923175, 3259.706626403611, 3292.160499072745, 3362.4620060790403, 3400.1839558506026, 3520.542329497149, 15317.46388876395, 15754.212289385485, 16006.0, 16164.595885102966, 16748.83251167485, 2017.9091940862697, 2027.4829918370722, 2040.33689051059, 2067.658836292025, 2093.235968871351, 160266.0, 160735.0, 165734.171329145, 168769.0, 168871.0, 15785.343174751326, 16061.518154455385, 16111.374940638263, 19467.0, 20647.483812904797, 33511.0, 33541.66458335386, 33603.0, 33627.0, 33685.494717579255, 9983.700488985342, 10003.24975626831, 10201.948990255001, 10209.132223761064, 10356.275060745826, 8402.579871006425, 8436.072032076467, 8451.746447606582, 8608.612612432456, 8609.182127697859, 6740.561863478858, 8716.912830871737, 9437.858432123523, 9527.28545359087, 9615.990321016332, 3294.2752594429667, 3839.9040023999623, 3944.1914407546383, 3948.1314110895555, 3956.723029387915, 906.4606559097326, 951.9243255121806, 961.5480724059681, 982.9777031886757, 1003.5132960514145, 19830.603387932162, 20301.593968120556, 21884.671729924063, 22007.779922200574, 22104.784236867126, 1059.3749687684303, 1065.0840277361463, 1076.8438576406377, 1084.6366467233408, 1085.1264731890747, 10526.789464210673, 10622.628208012682, 11318.434078296052, 11444.256123351955, 11512.19414640967, 762380.0, 771653.0, 776038.0, 793140.0, 809897.0, 155413.0, 156005.0, 157271.0, 160072.0, 160721.0, 1171.3733152763232, 1191.4221602522769, 1226.0620625221713, 1228.5454381878762, 1229.2317301686626, 18138.820976636478, 18686.90656546763, 19306.90346548258, 19323.323683671006, 19366.4190074298, 61712.69143654253, 62515.374846250954, 63035.054474182005, 63622.04566931592, 64187.0, 85039.0, 87169.56415217883, 87480.56259718661, 89810.0, 91897.0, 11315.547378104784, 12017.939910300742, 12316.815247771112, 12682.985361171268, 12981.610551683465, 11557.364344961108, 13853.930730346283, 13904.652383690489, 14013.369398377301, 14049.929750351183, 11555.4800033997, 11693.88306116928, 11747.765044699228, 11963.700907477383, 12056.939715301367, 10514.421706805893, 10931.906809319005, 11611.883881161419, 12218.0, 12220.450079746255, 10820.701515818153, 10940.781184376427, 11779.116566257393, 12077.818832717692, 12153.756924861276, 12681.92203662699, 12809.359532023174, 12821.679458013625, 13043.34783260852, 13121.212727236396, 11746.882531174579, 11746.94126529396, 11755.0, 11848.76302473963, 12057.51769929193], "value": 11730.98810499532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.162769779679, 1546.791183190269, 1548.233624355944, 1567.5375764149576, 1583.1530131379714, 10574.154067674586, 11179.72050698732, 11180.273282236649, 11180.385078820662, 11185.49665265064, 10748.247622666417, 10867.456627168649, 11015.063719583824, 11068.335899846015, 11078.833817492745, 2374.442006128558, 2411.240459255329, 2412.0834083048503, 2416.2388847513066, 2419.4072452249134, 2105.52625659227, 2216.9358707820256, 2366.514864452783, 2369.8815059247054, 2370.573296806574, 2328.6739856420113, 2348.894299756515, 2357.2456813819585, 2361.89371478283, 2363.775441333071, 2300.6779050932882, 2328.3946173994714, 2332.1371092695726, 2338.625819868813, 2344.4607740219844, 2296.724393072842, 2365.3258821235863, 2367.337145599235, 2370.810335173182, 2374.3826605082804, 10918.563257469692, 11009.174311926638, 11025.83461248074, 11030.613928512463, 11040.447977601169, 5396.91904621431, 5490.094134467808, 5689.345725241567, 5695.34503532095, 5698.800541981052, 2984.149517387534, 3310.702036816698, 3431.9485207721905, 3519.102628829632, 3554.537910071674, 1119.7873897009433, 1133.5125895864776, 1196.5692350753723, 1202.5129822421934, 1206.9879301207052, 13596.11625244356, 13927.094738841943, 14851.48019819312, 15297.0, 15329.233538323038, 4565.360849481075, 4679.602233810164, 4682.812687492462, 4687.273472611751, 4704.200285951397, 11680.0, 11687.415629218505, 11688.70778230551, 11708.824367634492, 11711.004564611932, 4816.8073277069225, 4934.8026078957155, 5694.572907031989, 5697.857553561194, 5699.430056994351, 4240.219107974658, 5107.97446012775, 5220.895582088413, 5224.895502089937, 5230.869228269247, 3348.9116037287977, 3501.844391350848, 3519.7184225261917, 3643.799591022519, 3702.315071711742, 1000.3847633705365, 1003.1824063388315, 1004.4832303222187, 1016.7000734783256, 1016.8983101689772, 910.0717268386342, 917.8118485710413, 938.9201917837061, 945.621751299472, 977.9853302200472, 6541.6402097885075, 6560.179977502812, 6579.0, 6608.339166083353, 6804.0, 1001.1840350114634, 1014.8274793285159, 1018.674024312213, 1033.5297439664935, 1036.9740756481149, 4237.237297286456, 4244.957550424518, 4271.594198551133, 4387.319965405367, 4428.667849911205, 13277.535286265127, 13761.655958600915, 13761.862381376259, 13786.310684465736, 13925.303734813218, 13465.326733663474, 13581.456741730417, 13835.723285534234, 13873.653158671113, 13905.0, 9901.0, 9947.253955953332, 10003.44981026036, 10130.696079117492, 10133.64532241368, 6374.426301632875, 6469.8706025880165, 6473.158489396348, 6542.182227221598, 6613.570117942319, 11896.643100706993, 12143.635690929286, 12185.451654675384, 12188.45151968146, 12322.876771232173, 10774.461276935965, 11186.272892261977, 12398.070144739, 12470.937645311715, 12474.313912734886, 8375.874361884698, 8404.789880253042, 8423.199796019368, 8530.274926631306, 8572.0, 10117.038881306264, 10326.896731032593, 10341.74145646365, 10347.379157250589, 10353.844692329772, 8965.193132618097, 9271.76820579491, 9275.25797936177, 9279.62881484733, 9293.024232455495, 8980.191782739585, 9013.278937684838, 9054.502002389932, 9067.0, 9074.591643375932, 7560.395168386626, 7819.726309579138, 7824.374050075867, 7933.246341597539, 7957.0, 4817.662763606514, 5805.506531944832, 5817.883642327214, 5892.793752218652, 5944.227250457413, 4729.219678752967, 5143.691378517301, 5783.450572195635, 5841.634138174047, 5925.585209035326], "value": 5050.2334609309955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.38554264978217, 372.2945019188637, 374.20854891903633, 377.58654273570465, 380.2490082087877, 4158.338663255518, 4295.926018495376, 4318.805653745581, 4971.955889263255, 5011.216531518703, 4727.669063165571, 4782.402199725035, 4883.829065982683, 4908.337374454448, 4963.801447942078, 3452.2405070884365, 3743.3449146399407, 4168.749875007494, 4277.032565020095, 4321.286987647034, 3930.5479869815053, 4011.879643610682, 4366.454193225847, 4382.693211475198, 4404.955950440487, 3816.542014958195, 3847.2497862916744, 3971.880843574683, 4270.807813648377, 4283.472751076864, 3974.324364857981, 4221.472315960505, 4260.360945858115, 4280.608802139317, 4289.978550107261, 3616.801075940822, 4140.668746500272, 4148.79256037197, 4161.292580261363, 4163.333866581333, 4563.471237135564, 4788.209945359012, 4831.758412079382, 4851.660383773137, 4878.609711223094, 4774.092922344744, 4785.617150627942, 4787.40157480315, 4793.568578827887, 4795.7699669653775, 4351.73889566627, 4663.44038715353, 4997.175466048134, 5091.694498330112, 5270.2358158067245, 4115.218108559364, 4238.533761286256, 4251.44731184944, 4275.764832934187, 4307.277089164328, 5432.728363581884, 5496.258005169291, 5522.392536820947, 5551.72241387933, 5573.804916827932, 4020.4572382727956, 4114.6091121343425, 4176.206520761107, 4367.5414081520985, 4414.616107302021, 4154.3976123462535, 4270.829166833292, 4349.412829268072, 4442.644993277081, 4474.910501790011, 3780.3348639209294, 4037.970317569001, 4128.710990230655, 4765.8093676252565, 4779.880502987384, 4956.653034287565, 5216.66091704038, 5295.0, 5325.227841962971, 5333.0, 1266.9873301266869, 1387.5074348606302, 1393.5122707052653, 1438.6547228665045, 1493.320539154682, 997.5211898288862, 1103.45379037377, 1105.4693747001484, 1121.8445001648315, 1130.3556972525746, 4110.383442483651, 4376.956230437655, 4433.778311084433, 4975.825846095369, 5009.373828271466, 4834.0, 5057.974710126499, 5065.645404821701, 5423.647462914898, 5439.347278326626, 3900.8439662413753, 4154.3976123462535, 4414.271645178574, 4459.843905463294, 4938.4320803107385, 2504.1235567551576, 2684.0, 2808.9185663519283, 2821.351089249484, 2839.432113577293, 5094.821681241213, 5157.432682404932, 5374.328208973879, 5682.011296046433, 5759.65442073477, 4937.2104760810025, 5256.729028364514, 5363.5440987516495, 5584.357798853184, 5723.6279641823985, 4989.779548101133, 5176.886969301619, 5278.228929811879, 5452.863678408072, 5597.552195824405, 4724.692894961817, 4990.201567749288, 5034.59723222134, 5414.4281466304765, 5465.672059676433, 4874.488178741181, 4988.401391833003, 5123.308353372247, 5313.734313284243, 5474.452554744494, 4913.0, 4969.732718156847, 5039.596832253337, 5343.973280133574, 5615.775368985195, 4004.2191772604065, 4327.891802704958, 4342.478902531717, 4343.565643435758, 4355.281378572627, 4824.95175048245, 4885.265730665563, 5185.066687996197, 5394.730263486888, 5403.162509810985, 4589.35270173195, 4706.764661766966, 4857.9152238329625, 5152.536271735562, 5222.433270019055, 4479.0, 4555.635549155993, 4583.220852455157, 4998.325226094431, 5187.455317191791, 4468.882779305174, 4556.476005259437, 4613.146567884952, 5058.595312375075, 5138.280640710378, 5173.896522069613, 5177.0, 5179.611529135254, 5206.8958620828125, 5266.526012658725, 4229.546862819496, 4602.838900638461, 4914.690095655036, 4937.753112344297, 5054.494550545063], "value": 4019.423099211204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.58968593059, 732.340893196123, 771.0439055571094, 825.2737590919991, 832.9708460203892, 15034.17312047837, 15913.602159946007, 16001.83998160018, 16009.75985360219, 16010.839891601096, 14459.92770036151, 14488.0, 14582.0, 14611.05028173168, 15079.246037698125, 902.3999040637968, 908.0737647599444, 922.0963455813308, 931.8788557487517, 937.5171786529943, 910.6858133943779, 919.6045700348848, 924.3760461688368, 924.653255029364, 925.1673493855517, 956.741679746468, 959.0888655777039, 960.7886265021684, 961.4471678784691, 962.0523784072683, 959.0265880131637, 959.7360725800391, 959.8800149981253, 960.1550635440802, 960.7261930349887, 582.6678793087941, 713.7002458967246, 714.0895358418006, 714.3606472207397, 715.4705517916756, 15386.0, 15798.763018554731, 15822.05067695942, 15996.520104396886, 16320.183990800413, 13955.162690238516, 14156.433742650283, 14165.15009099447, 14202.289885505683, 14269.096549050053, 9754.0, 11440.177179235077, 11570.421478926104, 11726.35505047222, 11872.465739041763, 3189.617245930503, 3203.6315823680343, 3207.278362368472, 3840.0783811885226, 3843.0008197868474, 106255.99999999923, 112632.0, 114974.42512787467, 115115.0, 116047.0, 9526.428414295164, 10694.411807350514, 10757.892421075689, 10758.0855627271, 11420.972112509913, 22384.888075559516, 22953.196638117584, 23065.42336441569, 23081.88459057694, 23115.422114447272, 7667.8849817252785, 7679.923200768033, 7693.692252309845, 7765.72819951299, 7784.766457006185, 4251.893702657459, 4273.55127711592, 4423.292273236267, 4428.800703968329, 4505.864824055284, 3445.913852153666, 3490.214701692099, 3540.716742660581, 3546.6098729139776, 3595.7123430125525, 667.9198496180393, 672.6065251827638, 678.4199509419474, 687.9415249703832, 689.3313485918651, 647.4496677823906, 657.8849149278165, 685.266764561914, 690.8860038093658, 704.2323866984908, 10312.896871031344, 10482.21383396233, 10524.26330156897, 10565.894341056644, 10646.307989980782, 646.2923099206362, 701.2251462134268, 705.7016131030532, 708.8369674974784, 732.6593134192626, 4899.020195960822, 5099.821506247264, 5139.0, 5148.871278218, 5165.0, 80255.0, 107045.0, 109305.45347273213, 109608.0, 114825.4258728701, 92502.53748731213, 92949.0, 93188.0, 95239.0, 97252.0, 80470.19529804627, 81835.7724634131, 83788.3242335162, 84140.15859841446, 84254.57872710597, 8515.787105322417, 9315.767105822408, 9740.951295243478, 9776.657816976372, 9862.408255504693, 44461.333080003176, 46996.0, 53696.73151634373, 54600.0, 55161.72419137879, 58885.822283554946, 60527.0, 66024.96466325606, 69368.6531567339, 71935.64032180015, 12895.289022932016, 13047.217166970013, 13273.597008542774, 13548.0, 13694.452221911011, 14609.488667896572, 14734.852651473348, 14977.925110374379, 15105.773413398589, 15495.922520387327, 11482.942585287354, 13623.142208231997, 13727.656808579866, 14066.367013484212, 14162.645933851736, 13300.534481293109, 13352.132111412728, 14066.156030638194, 14080.507182248572, 14092.577222683336, 11236.381998990135, 12774.425150868048, 13928.094673846168, 14195.361208745839, 14207.573772786833, 10772.353658780497, 11014.38587224619, 11284.548618055185, 11648.184627076023, 11844.111691622991, 9641.0, 10179.592816287563, 11270.154738394816, 11522.13583981188, 11563.42182890869], "value": 7676.607610820868, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 159.0, 171.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 135.0, 144.0, 110.0, 110.0, 114.0, 137.0, 156.0, 137.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 185.0, 183.0, 184.0, 186.0, 185.0, 186.0, 183.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 95.0, 60.0, 63.0, 63.0, 61.0, 77.0, 61.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 68.0, 89.0, 69.0, 69.0, 69.0, 82.0, 68.0, 68.0, 85.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 92.0, 93.0, 90.0, 95.0, 93.0, 93.0, 89.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 86.0, 87.0, 83.0, 85.0, 82.0, 82.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 61.0, 64.0, 63.0, 64.0, 65.0, 65.0, 66.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 64.0, 64.0, 63.0, 59.0, 58.0, 60.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 84.0, 83.0, 86.0, 85.0, 84.0, 89.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 139.0, 145.0, 134.0, 139.0, 151.0, 152.0, 216.0, 175.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 165.0, 168.0, 163.0, 165.0, 152.0, 198.0, 223.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 62.0, 63.0], "value": 64.3, "unit": "score"}]}]} 10:10:49 INFO - Return code: 0 10:10:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:10:49 ERROR - # TBPL SUCCESS # 10:10:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:10:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:10:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:10:49 INFO - 2017-03-20 10:10:49.630 screenresolution[1654:9959] starting screenresolution argv=screenresolution get 10:10:49 INFO - 2017-03-20 10:10:49.633 screenresolution[1654:9959] Display 0: 1600x1200x32@60 10:10:49 INFO - 2017-03-20 10:10:49.639 screenresolution[1655:9962] starting screenresolution argv=screenresolution list 10:10:49 INFO - Available Modes on Display 0 10:10:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:10:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:10:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:10:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:10:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:10:49 INFO - Intel Iris: 10:10:49 INFO - Chipset Model: Intel Iris 10:10:49 INFO - Type: GPU 10:10:49 INFO - Bus: Built-In 10:10:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:10:49 INFO - Vendor: Intel (0x8086) 10:10:49 INFO - Device ID: 0x0a2e 10:10:49 INFO - Revision ID: 0x0009 10:10:49 INFO - Displays: 10:10:49 INFO - Display: 10:10:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:10:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:10:49 INFO - Display Serial Number: 1600x1200 60 10:10:49 INFO - Main Display: Yes 10:10:49 INFO - Mirror: Off 10:10:49 INFO - Online: Yes 10:10:49 INFO - Rotation: Supported 10:10:49 INFO - Return code: 0 10:10:49 INFO - Running post-action listener: _resource_record_post_action 10:10:49 INFO - [mozharness: 2017-03-20 17:10:49.879189Z] Finished run-tests step (success) 10:10:49 INFO - Running post-run listener: _resource_record_post_run 10:10:49 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 36824064; Write bytes: 508434432; Read time: 382; Write time: 1849 10:10:49 INFO - TinderboxPrint: CPU usage
53.7% 10:10:49 INFO - TinderboxPrint: I/O read bytes / time
36,824,064 / 382 10:10:49 INFO - TinderboxPrint: I/O write bytes / time
508,434,432 / 1,849 10:10:49 INFO - TinderboxPrint: CPU idle
2,222.8 (46.3%) 10:10:49 INFO - TinderboxPrint: CPU system
957.6 (19.9%) 10:10:49 INFO - TinderboxPrint: CPU user
1,625.3 (33.8%) 10:10:49 INFO - TinderboxPrint: Swap in / out
245,063,680 / 0 10:10:49 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202207744; Write bytes: 202532864; Read time: 15682; Write time: 463 10:10:49 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35869696; Write bytes: 296005632; Read time: 368; Write time: 1354 10:10:50 INFO - Running post-run listener: _upload_blobber_files 10:10:50 INFO - Blob upload gear active. 10:10:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:10:50 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 10:10:50 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'] 10:10:50 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 10:10:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:51 INFO - (blobuploader) - INFO - Done attempting. 10:10:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:10:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:52 INFO - (blobuploader) - INFO - Done attempting. 10:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:54 INFO - (blobuploader) - INFO - Done attempting. 10:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:56 INFO - (blobuploader) - INFO - Done attempting. 10:10:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:56 INFO - Return code: 0 10:10:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:10:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9886365814e5f801b7a6337f6291ae8912fa39435d6b7eed586e3af8975f3327aaba44b283f60b399d1476d283d31b3c9dc3e711e537a7e65ee053f1303d244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/179530431ce2567c31078677d5093f1044099996e865a5233bb0b1ad7dd05fcfa89c1f5d91669201caf6a57767265cfc3c78d9cb65750c20dca31b82d4628306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c7c5a641f6697f8dd5cb353c9e3c61050805b1c5af50e220a91a808f267e6dc7ed1af58db1df8ca9fd2d4a4c275a7e29ecd698d26751b2bccf9750742aebce2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9169520daa188a3e38ab8e6233869f93a83f443ed32f58bece08475506b2150540466f7a862df18372a04b948d840d400749aa0a7351e18b13b5ae31a714c707"} 10:10:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:10:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:10:56 INFO - Contents: 10:10:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9886365814e5f801b7a6337f6291ae8912fa39435d6b7eed586e3af8975f3327aaba44b283f60b399d1476d283d31b3c9dc3e711e537a7e65ee053f1303d244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/179530431ce2567c31078677d5093f1044099996e865a5233bb0b1ad7dd05fcfa89c1f5d91669201caf6a57767265cfc3c78d9cb65750c20dca31b82d4628306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c7c5a641f6697f8dd5cb353c9e3c61050805b1c5af50e220a91a808f267e6dc7ed1af58db1df8ca9fd2d4a4c275a7e29ecd698d26751b2bccf9750742aebce2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9169520daa188a3e38ab8e6233869f93a83f443ed32f58bece08475506b2150540466f7a862df18372a04b948d840d400749aa0a7351e18b13b5ae31a714c707"} 10:10:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:10:56 INFO - Copying logs to upload dir... 10:10:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:10:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.819877 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-20 10:10:56.542907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 10:10:56.546248) ========= 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.MHqoS9MPEc/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.suS7ObOHVk/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/f9886365814e5f801b7a6337f6291ae8912fa39435d6b7eed586e3af8975f3327aaba44b283f60b399d1476d283d31b3c9dc3e711e537a7e65ee053f1303d244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/179530431ce2567c31078677d5093f1044099996e865a5233bb0b1ad7dd05fcfa89c1f5d91669201caf6a57767265cfc3c78d9cb65750c20dca31b82d4628306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c7c5a641f6697f8dd5cb353c9e3c61050805b1c5af50e220a91a808f267e6dc7ed1af58db1df8ca9fd2d4a4c275a7e29ecd698d26751b2bccf9750742aebce2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9169520daa188a3e38ab8e6233869f93a83f443ed32f58bece08475506b2150540466f7a862df18372a04b948d840d400749aa0a7351e18b13b5ae31a714c707"} build_url:https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/KaGftP--Rq6WTjnlAsrQyQ/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/f9886365814e5f801b7a6337f6291ae8912fa39435d6b7eed586e3af8975f3327aaba44b283f60b399d1476d283d31b3c9dc3e711e537a7e65ee053f1303d244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/179530431ce2567c31078677d5093f1044099996e865a5233bb0b1ad7dd05fcfa89c1f5d91669201caf6a57767265cfc3c78d9cb65750c20dca31b82d4628306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c7c5a641f6697f8dd5cb353c9e3c61050805b1c5af50e220a91a808f267e6dc7ed1af58db1df8ca9fd2d4a4c275a7e29ecd698d26751b2bccf9750742aebce2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9169520daa188a3e38ab8e6233869f93a83f443ed32f58bece08475506b2150540466f7a862df18372a04b948d840d400749aa0a7351e18b13b5ae31a714c707"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 10:10:56.582078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 10:10:56.582501) ========= 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.MHqoS9MPEc/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.suS7ObOHVk/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.005109 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 10:10:56.631965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 10:10:56.632324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 10:10:56.632686) ========= ========= Total master_lag: 0.18 =========