builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1490617755.01 results: success (0) buildid: 20170327035215 builduid: 490580bd56cc4dd7bf80f2be908ea7a6 revision: 0583275688f1f5e8e6d6c6842514c7ec183f5381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.015087) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.015550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.015846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.041368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.041815) ========= 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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-27 05:29:15-- 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% 7.99M=0.001s 2017-03-27 05:29:15 (7.99 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.157679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.158023) ========= 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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.021034 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:15.206918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 05:29:15.207475) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0583275688f1f5e8e6d6c6842514c7ec183f5381 --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 0583275688f1f5e8e6d6c6842514c7ec183f5381 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-27 05:29:15,277 truncating revision to first 12 chars 2017-03-27 05:29:15,278 Setting DEBUG logging. 2017-03-27 05:29:15,278 attempt 1/10 2017-03-27 05:29:15,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0583275688f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 05:29:16,442 unpacking tar archive at: mozilla-aurora-0583275688f1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.388320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 05:29:17.620211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:17.620546) ========= script_repo_revision: 0583275688f1f5e8e6d6c6842514c7ec183f5381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:17.620948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:17.621249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:29:17.641262) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-27 05:29:17.641664) ========= /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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:29:17 INFO - MultiFileLogger online at 20170327 05:29:17 in /builds/slave/test 05:29:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:29:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:17 INFO - {'append_to_log': False, 05:29:17 INFO - 'base_work_dir': '/builds/slave/test', 05:29:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:29:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:17 INFO - 'branch': 'Mozilla-Aurora', 05:29:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:17 INFO - 'config_files': ('talos/mac_config.py',), 05:29:17 INFO - 'default_actions': ('clobber', 05:29:17 INFO - 'read-buildbot-config', 05:29:17 INFO - 'download-and-extract', 05:29:17 INFO - 'populate-webroot', 05:29:17 INFO - 'create-virtualenv', 05:29:17 INFO - 'install', 05:29:17 INFO - 'run-tests'), 05:29:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:17 INFO - 'download_minidump_stackwalk': True, 05:29:17 INFO - 'download_symbols': 'ondemand', 05:29:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:17 INFO - 'gecko_profile': False, 05:29:17 INFO - 'gecko_profile_interval': 0, 05:29:17 INFO - 'installer_path': 'installer.exe', 05:29:17 INFO - 'log_level': 'info', 05:29:17 INFO - 'log_name': 'talos', 05:29:17 INFO - 'log_to_console': True, 05:29:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:17 INFO - 'opt_config_files': (), 05:29:17 INFO - 'pip_index': False, 05:29:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:17 INFO - 'cmd': ('bash', 05:29:17 INFO - '-c', 05:29:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:17 INFO - 'enabled': True, 05:29:17 INFO - 'halt_on_failure': False, 05:29:17 INFO - 'name': 'check_screen_resolution'},), 05:29:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:17 INFO - 'cmd': ('bash', 05:29:17 INFO - '-c', 05:29:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:17 INFO - 'enabled': True, 05:29:17 INFO - 'halt_on_failure': False, 05:29:17 INFO - 'name': 'check_screen_resolution'},), 05:29:17 INFO - 'run_cmd_checks_enabled': True, 05:29:17 INFO - 'suite': 'dromaeojs', 05:29:17 INFO - 'system_bits': '32', 05:29:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:17 INFO - 'title': 't-yosemite-r7-0367', 05:29:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:17 INFO - 'use_talos_json': True, 05:29:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:17 INFO - 'work_dir': 'build'} 05:29:17 INFO - [mozharness: 2017-03-27 12:29:17.831885Z] Running clobber step. 05:29:17 INFO - Running pre-action listener: _resource_record_pre_action 05:29:17 INFO - Running main action method: clobber 05:29:17 INFO - rmtree: /builds/slave/test/build 05:29:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:19 INFO - Running post-action listener: _resource_record_post_action 05:29:19 INFO - [mozharness: 2017-03-27 12:29:19.877922Z] Finished clobber step (success) 05:29:19 INFO - [mozharness: 2017-03-27 12:29:19.878048Z] Running read-buildbot-config step. 05:29:19 INFO - Running pre-action listener: _resource_record_pre_action 05:29:19 INFO - Running main action method: read_buildbot_config 05:29:19 INFO - Using buildbot properties: 05:29:19 INFO - { 05:29:19 INFO - "project": "", 05:29:19 INFO - "product": "firefox", 05:29:19 INFO - "script_repo_revision": "production", 05:29:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:29:19 INFO - "repository": "", 05:29:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:29:19 INFO - "buildid": "20170327035215", 05:29:19 INFO - "pgo_build": "False", 05:29:19 INFO - "basedir": "/builds/slave/test", 05:29:19 INFO - "buildnumber": 35, 05:29:19 INFO - "slavename": "t-yosemite-r7-0367", 05:29:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:29:19 INFO - "platform": "yosemite_r7", 05:29:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:29:19 INFO - "branch": "mozilla-aurora", 05:29:19 INFO - "repo_path": "releases/mozilla-aurora", 05:29:19 INFO - "revision": "0583275688f1f5e8e6d6c6842514c7ec183f5381", 05:29:19 INFO - "stage_platform": "macosx64", 05:29:19 INFO - "builduid": "490580bd56cc4dd7bf80f2be908ea7a6", 05:29:19 INFO - "slavebuilddir": "test" 05:29:19 INFO - } 05:29:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 05:29:19 INFO - Running post-action listener: _resource_record_post_action 05:29:19 INFO - [mozharness: 2017-03-27 12:29:19.881607Z] Finished read-buildbot-config step (success) 05:29:19 INFO - [mozharness: 2017-03-27 12:29:19.881749Z] Running download-and-extract step. 05:29:19 INFO - Running pre-action listener: _resource_record_pre_action 05:29:19 INFO - Running main action method: download_and_extract 05:29:19 INFO - mkdir: /builds/slave/test/build/tests 05:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:19 INFO - trying https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 05:29:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 05:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 05:29:21 INFO - Downloaded 1199 bytes. 05:29:21 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 05:29:21 INFO - Using the following test package requirements: 05:29:21 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 05:29:21 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 05:29:21 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 05:29:21 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'jsshell-mac.zip'], 05:29:21 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 05:29:21 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 05:29:21 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 05:29:21 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 05:29:21 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 05:29:21 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 05:29:21 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:29:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 05:29:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:29:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 05:29:22 INFO - Expected file size: 51787315 05:29:22 INFO - Obtained file size: 51787315 05:29:38 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:29:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 05:29:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:29:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 05:29:40 INFO - Expected file size: 51787315 05:29:40 INFO - Obtained file size: 51787315 05:29:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 05:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:29:55 INFO - Fetch https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 05:29:57 INFO - Expected file size: 14404438 05:29:57 INFO - Obtained file size: 14404438 05:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:57 INFO - trying https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:29:57 INFO - Downloading https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 05:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 05:29:59 INFO - Downloaded 74669428 bytes. 05:29:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:29:59 INFO - mkdir: /builds/slave/test/properties 05:29:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:59 INFO - Contents: 05:29:59 INFO - build_url:https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 05:30:00 INFO - Running post-action listener: _resource_record_post_action 05:30:00 INFO - Running post-action listener: set_extra_try_arguments 05:30:00 INFO - [mozharness: 2017-03-27 12:30:00.523352Z] Finished download-and-extract step (success) 05:30:00 INFO - [mozharness: 2017-03-27 12:30:00.523505Z] Running populate-webroot step. 05:30:00 INFO - Running pre-action listener: _resource_record_pre_action 05:30:00 INFO - Running main action method: populate_webroot 05:30:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:00 INFO - '--tppagecycles', 05:30:00 INFO - '7'], 05:30:00 INFO - 'tests': ['tsvgm']}}, 05:30:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['damp', 'tps']}, 05:30:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'tests': ['damp', 'tps']}, 05:30:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['dromaeo_dom']}, 05:30:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['basic_compositor_video']}, 05:30:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['a11yr', 05:30:00 INFO - 'ts_paint', 05:30:00 INFO - 'tpaint', 05:30:00 INFO - 'sessionrestore', 05:30:00 INFO - 'sessionrestore_no_auto_restore', 05:30:00 INFO - 'tabpaint']}, 05:30:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['tsvgx', 05:30:00 INFO - 'tsvgr_opacity', 05:30:00 INFO - 'tart', 05:30:00 INFO - 'tscrollx', 05:30:00 INFO - 'cart', 05:30:00 INFO - 'tsvg_static']}, 05:30:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:00 INFO - 'tsvgr_opacity', 05:30:00 INFO - 'tart', 05:30:00 INFO - 'tscrollx', 05:30:00 INFO - 'cart', 05:30:00 INFO - 'tsvg_static']}, 05:30:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'talos_options': ['--disable-e10s'], 05:30:00 INFO - 'tests': ['tp5o']}, 05:30:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:30:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'talos_options': ['--disable-e10s', 05:30:00 INFO - '--xperf_path', 05:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:00 INFO - 'tests': ['tp5n']}, 05:30:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:30:00 INFO - 'talos_options': ['--xperf_path', 05:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:00 INFO - 'tests': ['tp5n']}}, 05:30:00 INFO - 'talos.zip': {'path': '', 05:30:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:00 INFO - Running post-action listener: _resource_record_post_action 05:30:00 INFO - [mozharness: 2017-03-27 12:30:00.541872Z] Finished populate-webroot step (success) 05:30:00 INFO - [mozharness: 2017-03-27 12:30:00.542009Z] Running create-virtualenv step. 05:30:00 INFO - Running pre-action listener: _resource_record_pre_action 05:30:00 INFO - Running main action method: create_virtualenv 05:30:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:30:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:00 INFO - Using real prefix '/tools/python27' 05:30:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:04 INFO - Installing pip.................done. 05:30:04 INFO - Return code: 0 05:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:30:04 INFO - Reading from file tmpfile_stdout 05:30:04 INFO - Output received: 05:30:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:30:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:04 INFO - 'HOME': '/Users/cltbld', 05:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PAGER': '/bin/cat', 05:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:04 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - 'XPC_FLAGS': '0x0', 05:30:04 INFO - 'XPC_SERVICE_NAME': '0', 05:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:04 INFO - Cleaning up... 05:30:04 INFO - Return code: 0 05:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:04 INFO - 'HOME': '/Users/cltbld', 05:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PAGER': '/bin/cat', 05:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:04 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - 'XPC_FLAGS': '0x0', 05:30:04 INFO - 'XPC_SERVICE_NAME': '0', 05:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:05 INFO - Downloading/unpacking psutil>=3.1.1 05:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:08 INFO - Installing collected packages: psutil 05:30:08 INFO - Running setup.py install for psutil 05:30:08 INFO - building 'psutil._psutil_osx' extension 05:30:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:30:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:30:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:30:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:30:09 INFO - building 'psutil._psutil_posix' extension 05:30:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:30:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:30:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:30:09 INFO - ^ 05:30:09 INFO - 1 warning generated. 05:30:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:09 INFO - Successfully installed psutil 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:30:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:09 INFO - 'HOME': '/Users/cltbld', 05:30:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:09 INFO - 'LOGNAME': 'cltbld', 05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:09 INFO - 'MOZ_NO_REMOTE': '1', 05:30:09 INFO - 'NO_EM_RESTART': '1', 05:30:09 INFO - 'PAGER': '/bin/cat', 05:30:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:09 INFO - 'PWD': '/builds/slave/test', 05:30:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:09 INFO - 'SHELL': '/bin/bash', 05:30:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:09 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:09 INFO - 'USER': 'cltbld', 05:30:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:09 INFO - 'XPC_FLAGS': '0x0', 05:30:09 INFO - 'XPC_SERVICE_NAME': '0', 05:30:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:12 INFO - Installing collected packages: mozsystemmonitor 05:30:12 INFO - Running setup.py install for mozsystemmonitor 05:30:12 INFO - Successfully installed mozsystemmonitor 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:13 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:13 INFO - 'HOME': '/Users/cltbld', 05:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:13 INFO - 'LOGNAME': 'cltbld', 05:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:13 INFO - 'MOZ_NO_REMOTE': '1', 05:30:13 INFO - 'NO_EM_RESTART': '1', 05:30:13 INFO - 'PAGER': '/bin/cat', 05:30:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:13 INFO - 'PWD': '/builds/slave/test', 05:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:13 INFO - 'SHELL': '/bin/bash', 05:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:13 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:13 INFO - 'USER': 'cltbld', 05:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:13 INFO - 'XPC_FLAGS': '0x0', 05:30:13 INFO - 'XPC_SERVICE_NAME': '0', 05:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:17 INFO - warning: no files found matching '*.txt' 05:30:17 INFO - no previously-included directories found matching 'build' 05:30:17 INFO - no previously-included directories found matching 'dist' 05:30:17 INFO - no previously-included directories found matching '.git*' 05:30:17 INFO - Installing collected packages: jsonschema, functools32 05:30:17 INFO - Running setup.py install for functools32 05:30:17 INFO - warning: no files found matching '*.txt' 05:30:17 INFO - no previously-included directories found matching 'build' 05:30:17 INFO - no previously-included directories found matching 'dist' 05:30:17 INFO - no previously-included directories found matching '.git*' 05:30:17 INFO - Successfully installed jsonschema functools32 05:30:17 INFO - Cleaning up... 05:30:17 INFO - Return code: 0 05:30:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:17 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:30:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:17 INFO - 'HOME': '/Users/cltbld', 05:30:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:17 INFO - 'LOGNAME': 'cltbld', 05:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:17 INFO - 'MOZ_NO_REMOTE': '1', 05:30:17 INFO - 'NO_EM_RESTART': '1', 05:30:17 INFO - 'PAGER': '/bin/cat', 05:30:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:17 INFO - 'PWD': '/builds/slave/test', 05:30:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:17 INFO - 'SHELL': '/bin/bash', 05:30:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:17 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:17 INFO - 'USER': 'cltbld', 05:30:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:17 INFO - 'XPC_FLAGS': '0x0', 05:30:17 INFO - 'XPC_SERVICE_NAME': '0', 05:30:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:17 INFO - Cleaning up... 05:30:17 INFO - Return code: 0 05:30:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:17 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:17 INFO - 'HOME': '/Users/cltbld', 05:30:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:17 INFO - 'LOGNAME': 'cltbld', 05:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:17 INFO - 'MOZ_NO_REMOTE': '1', 05:30:17 INFO - 'NO_EM_RESTART': '1', 05:30:17 INFO - 'PAGER': '/bin/cat', 05:30:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:17 INFO - 'PWD': '/builds/slave/test', 05:30:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:17 INFO - 'SHELL': '/bin/bash', 05:30:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:17 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:17 INFO - 'USER': 'cltbld', 05:30:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:17 INFO - 'XPC_FLAGS': '0x0', 05:30:17 INFO - 'XPC_SERVICE_NAME': '0', 05:30:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:21 INFO - Downloading docopt-0.6.1.tar.gz 05:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:21 INFO - Running setup.py install for blobuploader 05:30:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:21 INFO - Running setup.py install for requests 05:30:22 INFO - Running setup.py install for docopt 05:30:22 INFO - Successfully installed blobuploader requests docopt 05:30:22 INFO - Cleaning up... 05:30:22 INFO - Return code: 0 05:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:22 INFO - 'HOME': '/Users/cltbld', 05:30:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:22 INFO - 'LOGNAME': 'cltbld', 05:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:22 INFO - 'MOZ_NO_REMOTE': '1', 05:30:22 INFO - 'NO_EM_RESTART': '1', 05:30:22 INFO - 'PAGER': '/bin/cat', 05:30:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:22 INFO - 'PWD': '/builds/slave/test', 05:30:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:22 INFO - 'SHELL': '/bin/bash', 05:30:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:22 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:22 INFO - 'USER': 'cltbld', 05:30:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:22 INFO - 'XPC_FLAGS': '0x0', 05:30:22 INFO - 'XPC_SERVICE_NAME': '0', 05:30:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:22 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-XdNm4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-UvzSWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-velFoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-MICk8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-WvrdHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-S5qBZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-wTWEGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8Il8dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-xIzoz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-XilQPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-v5tn2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-x7LTeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-O5_VEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-puPTu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-15bX9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-zUQZc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-fYbTxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:24 INFO - Running setup.py install for manifestparser 05:30:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:24 INFO - Running setup.py install for mozcrash 05:30:25 INFO - Running setup.py install for mozdebug 05:30:25 INFO - Running setup.py install for mozdevice 05:30:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Running setup.py install for mozfile 05:30:25 INFO - Running setup.py install for mozhttpd 05:30:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Running setup.py install for mozinfo 05:30:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Running setup.py install for mozInstall 05:30:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:25 INFO - Running setup.py install for mozleak 05:30:26 INFO - Running setup.py install for mozlog 05:30:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Running setup.py install for moznetwork 05:30:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Running setup.py install for mozprocess 05:30:26 INFO - Running setup.py install for mozprofile 05:30:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Running setup.py install for mozrunner 05:30:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:26 INFO - Running setup.py install for mozscreenshot 05:30:27 INFO - Running setup.py install for moztest 05:30:27 INFO - Running setup.py install for mozversion 05:30:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:27 INFO - Cleaning up... 05:30:27 INFO - Return code: 0 05:30:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:27 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:27 INFO - 'HOME': '/Users/cltbld', 05:30:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:27 INFO - 'LOGNAME': 'cltbld', 05:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:27 INFO - 'MOZ_NO_REMOTE': '1', 05:30:27 INFO - 'NO_EM_RESTART': '1', 05:30:27 INFO - 'PAGER': '/bin/cat', 05:30:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:27 INFO - 'PWD': '/builds/slave/test', 05:30:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:27 INFO - 'SHELL': '/bin/bash', 05:30:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:27 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:27 INFO - 'USER': 'cltbld', 05:30:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:27 INFO - 'XPC_FLAGS': '0x0', 05:30:27 INFO - 'XPC_SERVICE_NAME': '0', 05:30:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:27 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-wmqbOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:27 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-MbdOVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:27 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-DJhvBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-1vtstI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-C2Hays-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-xoE4n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-48Z3jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-rKaMKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-bnD1DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-YZA2Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-4DoHHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KF6xPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-esFs7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-szWRQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tnjgdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-OSkJHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-evRKJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:32 INFO - Downloading blessings-1.6.tar.gz 05:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:32 INFO - Installing collected packages: blessings 05:30:32 INFO - Running setup.py install for blessings 05:30:32 INFO - Successfully installed blessings 05:30:32 INFO - Cleaning up... 05:30:32 INFO - Return code: 0 05:30:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:32 INFO - Reading from file tmpfile_stdout 05:30:32 INFO - Current package versions: 05:30:32 INFO - blessings == 1.6 05:30:32 INFO - blobuploader == 1.2.4 05:30:32 INFO - docopt == 0.6.1 05:30:32 INFO - functools32 == 3.2.3-2 05:30:32 INFO - jsonschema == 2.5.1 05:30:32 INFO - manifestparser == 1.1 05:30:32 INFO - mozInstall == 1.12 05:30:32 INFO - mozcrash == 1.0 05:30:32 INFO - mozdebug == 0.1 05:30:32 INFO - mozdevice == 0.49 05:30:32 INFO - mozfile == 1.2 05:30:32 INFO - mozhttpd == 0.7 05:30:32 INFO - mozinfo == 0.9 05:30:32 INFO - mozleak == 0.1 05:30:32 INFO - mozlog == 3.4 05:30:32 INFO - moznetwork == 0.27 05:30:32 INFO - mozprocess == 0.25 05:30:32 INFO - mozprofile == 0.28 05:30:32 INFO - mozrunner == 6.13 05:30:32 INFO - mozscreenshot == 0.1 05:30:32 INFO - mozsystemmonitor == 0.3 05:30:32 INFO - moztest == 0.8 05:30:32 INFO - mozversion == 1.4 05:30:32 INFO - psutil == 3.1.1 05:30:32 INFO - requests == 1.2.3 05:30:32 INFO - wsgiref == 0.1.2 05:30:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:32 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:32 INFO - 'HOME': '/Users/cltbld', 05:30:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:32 INFO - 'LOGNAME': 'cltbld', 05:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:32 INFO - 'MOZ_NO_REMOTE': '1', 05:30:32 INFO - 'NO_EM_RESTART': '1', 05:30:32 INFO - 'PAGER': '/bin/cat', 05:30:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:32 INFO - 'PWD': '/builds/slave/test', 05:30:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:32 INFO - 'SHELL': '/bin/bash', 05:30:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:32 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:32 INFO - 'USER': 'cltbld', 05:30:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:32 INFO - 'XPC_FLAGS': '0x0', 05:30:32 INFO - 'XPC_SERVICE_NAME': '0', 05:30:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:33 INFO - Cleaning up... 05:30:33 INFO - Return code: 0 05:30:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:33 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 0x104dc6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97384c8b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, '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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:33 INFO - 'HOME': '/Users/cltbld', 05:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:33 INFO - 'LOGNAME': 'cltbld', 05:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:33 INFO - 'MOZ_NO_REMOTE': '1', 05:30:33 INFO - 'NO_EM_RESTART': '1', 05:30:33 INFO - 'PAGER': '/bin/cat', 05:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:33 INFO - 'PWD': '/builds/slave/test', 05:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:33 INFO - 'SHELL': '/bin/bash', 05:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:33 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:33 INFO - 'USER': 'cltbld', 05:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:33 INFO - 'XPC_FLAGS': '0x0', 05:30:33 INFO - 'XPC_SERVICE_NAME': '0', 05:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:33 INFO - Cleaning up... 05:30:33 INFO - Return code: 0 05:30:33 INFO - Running post-action listener: _resource_record_post_action 05:30:33 INFO - Running post-action listener: _start_resource_monitoring 05:30:33 INFO - Starting resource monitoring. 05:30:33 INFO - [mozharness: 2017-03-27 12:30:33.331252Z] Finished create-virtualenv step (success) 05:30:33 INFO - [mozharness: 2017-03-27 12:30:33.332234Z] Running install step. 05:30:33 INFO - Running pre-action listener: _resource_record_pre_action 05:30:33 INFO - Running main action method: install 05:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:33 INFO - Reading from file tmpfile_stdout 05:30:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:33 INFO - Reading from file tmpfile_stdout 05:30:33 INFO - Output received: 05:30:33 INFO - Usage: mozinstall [options] installer 05:30:33 INFO - Options: 05:30:33 INFO - -h, --help show this help message and exit 05:30:33 INFO - -d DEST, --destination=DEST 05:30:33 INFO - Directory to install application into. [default: 05:30:33 INFO - "/builds/slave/test"] 05:30:33 INFO - --app=APP Application being installed. [default: firefox] 05:30:33 INFO - mkdir: /builds/slave/test/build/application 05:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:30:53 INFO - Reading from file tmpfile_stdout 05:30:53 INFO - Output received: 05:30:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:30:53 INFO - Running post-action listener: _resource_record_post_action 05:30:53 INFO - [mozharness: 2017-03-27 12:30:53.856640Z] Finished install step (success) 05:30:53 INFO - [mozharness: 2017-03-27 12:30:53.856810Z] Running run-tests step. 05:30:53 INFO - Running pre-action listener: _resource_record_pre_action 05:30:53 INFO - Running main action method: run_tests 05:30:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:53 INFO - 2017-03-27 05:30:53.871 screenresolution[1973:19183] starting screenresolution argv=screenresolution get 05:30:53 INFO - 2017-03-27 05:30:53.874 screenresolution[1973:19183] Display 0: 1600x1200x32@60 05:30:53 INFO - 2017-03-27 05:30:53.879 screenresolution[1974:19186] starting screenresolution argv=screenresolution list 05:30:53 INFO - Available Modes on Display 0 05:30:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:54 INFO - Intel Iris: 05:30:54 INFO - Chipset Model: Intel Iris 05:30:54 INFO - Type: GPU 05:30:54 INFO - Bus: Built-In 05:30:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:54 INFO - Vendor: Intel (0x8086) 05:30:54 INFO - Device ID: 0x0a2e 05:30:54 INFO - Revision ID: 0x0009 05:30:54 INFO - Displays: 05:30:54 INFO - Display: 05:30:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:54 INFO - Display Serial Number: 1600x1200 60 05:30:54 INFO - Main Display: Yes 05:30:54 INFO - Mirror: Off 05:30:54 INFO - Online: Yes 05:30:54 INFO - Rotation: Supported 05:30:54 INFO - Return code: 0 05:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:54 INFO - Python 2.7.3 05:30:54 INFO - Return code: 0 05:30:54 INFO - grabbing minidump binary from tooltool 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:54 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 0x104ba4d30>, '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 0x104acbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b99be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:30:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:30:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:30:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:54 INFO - Return code: 0 05:30:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:30:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:54 INFO - ENV: RUST_BACKTRACE is now 1 05:30:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:30:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:54 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/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:30:54 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/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LPBqJ8pf1W/Render', 05:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:54 INFO - 'HOME': '/Users/cltbld', 05:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:54 INFO - 'LOGNAME': 'cltbld', 05:30:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:54 INFO - 'MOZ_NO_REMOTE': '1', 05:30:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:54 INFO - 'NO_EM_RESTART': '1', 05:30:54 INFO - 'PAGER': '/bin/cat', 05:30:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:54 INFO - 'PWD': '/builds/slave/test', 05:30:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:54 INFO - 'RUST_BACKTRACE': '1', 05:30:54 INFO - 'SHELL': '/bin/bash', 05:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7KlAsAlTW/Listeners', 05:30:54 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 05:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:54 INFO - 'USER': 'cltbld', 05:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:54 INFO - 'XPC_FLAGS': '0x0', 05:30:54 INFO - 'XPC_SERVICE_NAME': '0', 05:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:54 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/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:30:54 INFO - mozversion application_buildid: 20170327035215 05:30:54 INFO - mozversion application_changeset: 0583275688f1f5e8e6d6c6842514c7ec183f5381 05:30:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:30:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:54 INFO - mozversion application_name: Firefox 05:30:54 INFO - mozversion application_remotingname: firefox-dev 05:30:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:30:54 INFO - mozversion application_vendor: Mozilla 05:30:54 INFO - mozversion application_version: 54.0a2 05:30:54 INFO - mozversion platform_buildid: 20170327035215 05:30:54 INFO - mozversion platform_changeset: 0583275688f1f5e8e6d6c6842514c7ec183f5381 05:30:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:30:54 INFO - mozversion platform_version: 54.0a2 05:30:54 INFO - using testdate: 1490617854 05:30:54 INFO - actual date: 1490617854 05:30:54 INFO - starting webserver on 'localhost:54068' 05:30:54 INFO - SUITE-START | Running 2 tests 05:30:54 INFO - TEST-START | dromaeo_css 05:30:54 INFO - operating with platform_type : mac_ 05:30:54 INFO - Initialising browser for dromaeo_css test... 05:30:54 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmphnHHf2/profile http://localhost:54068/getInfo.html) 05:30:57 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 05:30:57 INFO - PROCESS | 1984 | colorDepth:24 05:30:57 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 05:30:57 INFO - PROCESS | 1984 | __metrics 05:30:57 INFO - PROCESS | 1984 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:30:57 INFO - PROCESS | 1984 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:58 INFO - TEST-INFO | 1984: exit 0 05:30:58 INFO - Browser initialized. 05:30:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:58 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmphnHHf2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:10 INFO - PROCESS | 1986 | RSS: Main: 215629824 05:31:10 INFO - PROCESS | 1986 | 05:34:14 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54068/tests/dromaeo/cssquery-ext.html) 05:34:16 INFO - PROCESS | 1986 | RSS: Main: 397479936 05:34:16 INFO - PROCESS | 1986 | 05:35:59 INFO - PROCESS | 1986 | ************************* 05:35:59 INFO - PROCESS | 1986 | A coding exception was thrown and uncaught in a Task. 05:35:59 INFO - PROCESS | 1986 | 05:35:59 ERROR - PROCESS | 1986 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:35:59 INFO - PROCESS | 1986 | Full stack: 05:35:59 INFO - PROCESS | 1986 | ************************* 05:37:19 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-ext.html (next: http://localhost:54068/tests/dromaeo/cssquery-jquery.html) 05:37:20 INFO - PROCESS | 1986 | RSS: Main: 353136640 05:37:20 INFO - PROCESS | 1986 | 05:40:22 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54068/tests/dromaeo/cssquery-mootools.html) 05:40:23 INFO - PROCESS | 1986 | RSS: Main: 332009472 05:40:23 INFO - PROCESS | 1986 | 05:43:25 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54068/tests/dromaeo/cssquery-prototype.html) 05:43:26 INFO - PROCESS | 1986 | RSS: Main: 318926848 05:43:26 INFO - PROCESS | 1986 | 05:46:30 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54068/tests/dromaeo/cssquery-yui.html) 05:46:30 INFO - PROCESS | 1986 | RSS: Main: 318722048 05:46:30 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:54068/tests/dromaeo/cssquery-yui.html (next: http://localhost:54068/tests/dromaeo/cssquery-dojo.html) 05:49:34 INFO - PROCESS | 1986 | RSS: Main: 361541632 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | __start_tp_report 05:49:34 INFO - PROCESS | 1986 | _x_x_mozilla_page_load 05:49:34 INFO - PROCESS | 1986 | _x_x_mozilla_page_load_details 05:49:34 INFO - PROCESS | 1986 | |i|pagename|runs| 05:49:34 INFO - PROCESS | 1986 | |0;dojo.html;3025.9848700756493;3344.966550334496;3349.7320214382844;3357.3117510910265;3391.711704505117;4759.762011899408;5761.423857614242;5774.884502309951;5777.913331300028;5783.3349164846;5699.829005129843;5795.565332600061;5796.768129274835;5801.9129713054235;5825.766969321222;5222.685355590265;5265.131253343194;5272.683638981654;5289.20661900716;5337.893242135155;5105.642605017651;5114.43741188469;5134.974325128369;5336.67979921204;5364.678119312854;5263.605229607776;5274.4198138204765;5300.151975683892;5329.573634109282;5335.1730481775385;5302.310699609065;5318.202269659543;5319.813806516792;5325.227841962894;5328.973355133199;5050.116229659795;5161.638685292031;5244.423113457517;5250.579953603703;5284.788608455658;5581.302337207849;5585.162225666142;5606.131049687305;5622.156676498517;5642.548596112342;6022.6687532185715;6098.39016098391;6100.847478813065;6110.327863934964;6122.969385153046;6183.979643358841;6261.780837670705;6315.115883776275;6329.810105696836;6349.936500634981;5877.588568800185;5894.852628684317;5908.970455147697;5914.319853216849;5942.286925568959;5280.9207861882105;5449.700266485302;6152.200213972155;6329.367063293634;6350.110984462179;5972.850678733066;6150.169727086786;6194.256689197235;6200.596961197508;6226.439620434183;6317.241930968313;6339.302676705559;6353.809385718436;6354;6364.268109167505;5977.671228082497;6261.5616906816995;6292.370762923762;6308.905366419507;6315.400036996478;6122.846928826815;6134.38656134383;6220.191375121205;6261.874762504815;6292.622442653455;5024.145895197825;5024.748762561931;5034.597232221414;5044.369453818273;5087.898242035212;4511.458624965026;4514.435695538058;4514.503404625489;4523.36672865799;4558.49856515783;5439.211314359475;5482.122860342326;5515.696636685021;5589.692566908859;5719.656820590778;6116.274903966718;6140.289530736458;6151.72317245725;6259.812205633838;6263.96868015657;5774.769009239583;5778.56660750437;5782.161586569924;5797.739101740432;5819.854503637358;5529.806456774074;5533.529649979716;5534.418886016991;5538.501534861801;5543.473370029841;6201.782937597343;6269.279032911091;6386.584871983307;6393.073004414334;6423.132877061724;6240.063990401476;6274.215723034621;6309.179806625109;6334.4932405406535;6345.809625711236;6299.338569450325;6340.4293613575;6345.270293916259;6359.17330747;6362.0774987627465;6201.534884883742;6206.906896396467;6207.937920620736;6229.345918678474;6256.5307601930945;6051.606645568024;6080.787172448943;6136.3965394158;6221.595596286227;6263.311035785969;5994.220751302303;6148.784792532419;6160.7535698571555;6185.567010309235;6187.84530386744;6088.908666370096;6089.665068421279;6134.907976380268;6151.907721384094;6152;5636.436356364495;5740.225069615549;5977.6114552553945;6006.129111278928;6018.608790428608;5068.341115654941;5115.616328775432;5908.763649453974;6078.696065196634;6192.566520343533;5638.23883775685;5683.943160568341;5741.827745167651;6038.456538911519;6060.696965151813 05:49:34 INFO - PROCESS | 1986 | |1;ext.html;788.8264581792006;812.6911773526059;861.9396642235042;885.1369914333529;886.6320477002045;40041.3993790093;40773.79613101934;41009.7949510252;41071.79464102679;41155.58844411555;41277.79361103198;41484.17031659373;41525.58474415255;41645.58354416463;41807.37288940668;7299.30656587626;7450.217727138626;9218.907810921888;9339.206167475739;9353.392029518094;10906.34561926283;11135.610253641124;11259.4370281486;11265.943670281678;11277.210595258335;11106.888931110667;11133.944330278337;11145.387003714792;11157.2747771395;11188.66434006981;7274.345308922169;11081.889181108207;11094.667159985212;11095.167862410352;11102.444877756121;7321.37768289696;7371.447141464411;7371.520851144712;7373.631318434111;10764.869688682655;39168.41247381292;39473.802630986946;39518.60481395178;39559.01102472432;39616.80191599052;3609.151849315409;3619.2037751694584;3625.782453052825;3626.873059442933;3726.366517691999;27740.861295693594;28275.86896524157;28761.56857647137;29442.852785736148;29720.40559188826;3126.765492588065;3128.5463607776974;3158.731507821838;3184.7133757961897;3288.8026718396973;292961;355829;356180;357575;357858;42721.57278427238;43353.783231083646;50670.74664626653;51777;52066.73966630142;55068.44931550713;55324.2974347185;55332.17001744977;55334.446655533735;55426;14617.707645847024;14703.338349774285;14706.852931470548;14710.117392956457;14717.779233311509;12583.93708031454;12596.181248218836;12612.747745045232;12624.053196010336;12684.619461416172;12584.685382865318;12594.87405125937;12640.431180596896;12662.81005784914;12727.809082863765;4794.304825800239;5009.474005229471;5705.400932902068;5741.425857414225;5779.595428320062;1090.574675876409;1126.2116518436962;1130.4912789244872;1156.7339511912307;1179.4928180882303;26632.334191645365;27155.592666110024;27412.588811167847;28114.85942570274;28187.295317617223;1147.0823341327073;1162.6221478019677;1239.8450193725785;1251.4868903749418;1287.2083668543964;12339.814902776465;14121.85878141226;14214.806841286829;14278;14315.28423578817;504303;505904;506696;506760;524310;57873.71063144657;58159.70920145372;58171.54571135671;58175;58322;1428.292994967477;1433.5914264434587;1492.2091291615461;1493.1787516865681;1493.5295381954866;25462.618060728735;26449.33876653099;26723.866380667972;27014.594781077907;27069.86465067662;45249.77375113103;45499.545004550855;45528;45586.125179360126;45588.31617525806;467244.66377667896;469770;470030;470601;470981;29029.274268143465;29689;29714.95997640072;34627.4805877907;35798.8210058948;42806.571934280255;43006.78496607497;43452.78273608612;43521.78239108784;45038;29611.851940740158;29923.10230693083;30650.23374415568;30860.765569376974;30987.225319367197;29751;29780;29850.552241715955;30723;30837.229069273446;35872.4619130708;36618;36624.08439789026;36639;36655.71704990313;29699.554506681983;29714.851425742734;29866.253343666584;30289.394212115192;30911.845440772653;21522.784772152077;22936.311910642708;24182.879085605164;24769.876150619853;24773.62839557372 05:49:34 INFO - PROCESS | 1986 | |2;jquery.html;386.5496696348754;409.6436100592485;421.35953350906624;430.78030204595655;447.776111944028;14173.71652566948;21028.843413612245;21884.90575471226;22222.444438888997;22412.88793556034;21192;21607.243746468877;22064.669029964563;22141;22524.662130068064;6414.839629009265;6650.401463868251;6651.900221496681;6665.866682666344;6774.424173945221;6552.148220731322;6667.066610674485;6685.231198412196;6687.197536295651;6689.899651505231;3815.6565909068177;3940.6073228804516;7315.817104572375;7691.846163076763;7698.076230852277;7376.704931802775;7604.505707129019;7666.156722760492;7685.846283074307;7698.615069246515;6380.425761681471;7448.7392941247335;7458;7464.776056718253;7484.550926944401;25432;25884.74115258842;25887.482250355075;25941.870290648614;26496;2833.3624934389804;2842.786790990684;2846.7864910131825;2886.7257610526967;2888.740013398783;14286.428492865776;15968.105494156203;16222.918885405616;16272;16931.83068169327;2017.435118166901;2039.9694004589944;2044.366246463586;2047.7747447780732;2079;160610.59084113748;161491;163891;166895;169119.99999999878;14850.628734281514;15453.768193477106;15852;20221.797782022284;20581.48546286325;31614.525782112825;32480.675193247764;32535.837320813243;32946.67053329484;32959.835200824324;10127.037931396653;10509.579616815241;10681.465926703633;10734.624288150033;10886.346819190874;8811.867821982676;8814.603342849587;8841.425307355;9009.099090090938;9022.954885225663;7954.403419743542;9434.622615095319;9488.857667134998;9515.23878089751;9690.46702431373;3911.1395492991496;4006.8580454570892;4016.8393264269685;4022.798860057044;4045.6561192298395;793.738066438074;995.7012896131132;1000.4197565412044;1032.2825636182781;1037.2117190934944;22104.658423879107;23456.530869382517;24528.87735561311;24560.877195613906;24656;789.4749991255751;937.1425145991342;945.2249155692404;971.4802580619335;1000.5897581991494;5564.443555644403;6782.253952065269;6944.166699996033;7190;7196.352328290479;770613;782738;803951;807619;814025;166006;167696;168724;172619.13690431468;173942;1282.2562913510142;1314.9474021039243;1344.88568471681;1345.5156143788229;1347.5822495026378;12115.162917899997;12229.510819567118;12384.56654017105;12709.93645031769;12711;42115.7894210527;61472.69263653653;65239;66463.33536664765;66886.99669505059;69855;90729.54635227045;91359.08640913505;93417;93986;11514.36670983104;11835.11236657237;12019.81970270464;12154.392280386122;12199.817002745143;13246.602601921957;13247.271400072703;13257.005724570889;13351.732965340445;13683.315834208448;9157;11448.82826757616;11472.082233421139;11656.941715291368;11716.472758725708;9934.354266972623;10504.369737815756;10650.414227217578;10916.672499825017;10964.616238431616;11144.498497567467;11200.663980080612;11275.887241127484;11394.829077564009;11592.014678752063;11730.413479326171;11758.294502329887;11808.527658893549;12085.335306558223;12159.939200303941;10059.899401005896;11132.942370474791;11507.136964727511;11510.884891150981;11855.822162667739 05:49:34 INFO - PROCESS | 1986 | |3;mootools.html;1395.846456889742;1539.2303848075962;1554.33163739592;1585.26285277346;1599.8400159984003;10521.947390263058;11155.776884462306;11156.776864462707;11160.274582152155;11191.936766007237;10532.578696852117;11024.393658348788;11212.27120237184;11241.60654377097;11253.324800511975;2033.5831154613268;2396.209250947192;2425.721042080157;2432.0514999150346;2434.1480481831395;2337.275444612167;2399.0763556030965;2419;2427.9271621851285;2429.79346755526;1999.780024197337;2310.0875154314035;2343.742188359279;2390.5935990881503;2406.7352591214953;2099.4646365176936;2343.5195784864063;2354.8587084774967;2380.654805053266;2382.4996750682376;1971.5662554238045;2408.2052922535695;2408.7350391456926;2411.746766589518;2411.9035238590436;11035.558577656964;11111.944440277746;11114.944080312358;11123.777524449546;11132.888671113265;5648.717564121777;5755.827325180251;5960.04639257721;5973.133895585116;5979.252593425822;3465.549478567795;3560.6795388414907;3623.2934577757346;3694.9630503695157;3695.224002959355;1156.7917774800533;1200.9279443233347;1226.3439060102803;1236.715555422258;1242.0001898471726;13661.726765464635;14013.439462421491;14285.857141428556;15100.395984160621;15149.469768558047;4549.3176023596725;4668.533146685304;4693.296005599187;4698.859034228979;4713;11660.183787134989;11671;11672.70818229534;11676.591319303783;11704.297742135499;4765.356676848651;4968.22992436173;5006.0989021975665;5696.145578163226;5701.258836351248;4350.412694286294;5242.13504771716;5283.1546952487415;5286.20706893969;5286.8942621148135;3222.629397619257;3778.790786948205;3895.415687646819;3948.565657777642;3952.4861767970556;871.9694810681723;1042.4631314872847;1052.9631462898762;1054.6097943760858;1061.5382308695741;781.5974772991914;793.8372633610212;801.7674874286508;808.8261023879776;814.8288859339486;6333.746650134035;6380.361963803675;6515.837104072436;6602.207735071726;6754.864902701918;890.9910900890908;1034.6120204923154;1036.3108532825586;1046.4035499765214;1062.7768168684509;4057.229126465962;4067.471228740245;4074.0018695419813;4077.8368865245056;4202.3696445533415;13352.799708004388;14008.579742607739;14017.158970461805;14023.368948397347;14089.295535223402;13564.457421703219;13626.182429054288;13692.178469291874;13851.584452466443;13921.164730116225;8340.249377556049;9537.570809313598;9992.950740172322;10071.546780395047;10205.438700871524;6360.49116070704;6430.7749228776765;6432.581882177644;6462;6611.857456336292;12048.518059277882;12059.52779680181;12349.567765128177;12388.31864247439;12406.875931240573;10661.733456663645;10872.945635271773;12393.318367489514;12481.812772808233;12578.748425031632;7955.323797477048;7963.402744794048;7966.3626909848235;8050.919490805017;8055.395845311508;9648.276379271723;9836.016398360392;9838.655647052605;9843.0156984301;9852.458114803754;8200.794980125305;8432.53621050848;8435.24082832548;8478.152184781473;8543.615537300711;8270.586470676322;8283.213094755989;8303.543305118277;8336.458130221516;8354.707585234488;7531.849363012819;7538.811529711801;7625.123110842324;7634.312911837961;7642.923570764221;5527.309086364205;5554.1946417770005;5663.943360566342;5668.319801623831;5776.447484796904;4740.691855029412;5581.441855814386;5593.496585307342;5733.569982251264;5823.82528524145 05:49:34 INFO - PROCESS | 1986 | |4;prototype.html;364.37873425809;373.9177380976186;377.90741268389246;383.7505621346125;384.5251114873129;4790.305405716169;5141.794328226871;5149.30484384608;5220.243064755613;5315.574754019679;4392.209402307583;4695.788689508971;5166.5866730661555;5181.9740901295445;5209.479052094789;3649.4525821126776;4164.5210800758;4283.051211698669;4304.677149213806;4322.347616264259;3689.797061161635;3701.944470832926;4310.030243195271;4319.654427645796;4320.395144679732;3739.3643080676216;3739.439084137374;4245.639120674731;4303.35449682547;4337.21930052592;3557.9110522236892;4010.919781604366;4046.453728746611;4361.88125490276;4383.7150585212175;3646.507721457622;3905.519994803292;3947.230290093433;3965.286248475273;3997.8400863965408;4544.636429085665;5062;5121.974390128025;5155.7679904404395;5192.948070519285;4736.905261894743;4753.952460475385;4929.482404347564;5002.349694539723;5005.0990821652085;4776.737279449629;5048.671836330664;5461.808836690737;5550.389457159709;5588.966041282376;4319.913601727979;4343.283358245885;4406.700023493077;4432.667549933768;4450.777461126931;4315.567484662589;5328.49379308965;5551.174267787591;5917.704114794286;5996.760129594811;4073.205724883619;4365.345198220229;4542.502273249579;4557.589816916494;4589.908201835945;4152.065785198306;4620.67655264135;4635.6523260755575;4658.906821863544;4684.976575117103;4632.4672662644225;4734.313524538922;4805.831795887128;4885.267209918541;4950.430700469492;5253;5294.814681486129;5424.511793938485;5462.890742185134;5521.972390138104;1366.5285476510587;1481.037325738257;1549.7989058479543;1578.3213218316234;1589.5867074560697;1161.7850697620968;1170.8281138487982;1171.77736230116;1180.8287798269203;1200.3758045816128;4636.125602126703;4949.90100197994;5138.97430512845;5217.608679349064;5222.791088356423;4877.365942427533;5284.630075894651;5763.5216856751995;5803.448672376117;5818.207260514977;4355.73865568067;4663.595575230101;4682.6253899687945;5006.299118123466;5071.54356107952;2596.3257844420277;2608.973910260911;2651.64202832619;2944.617199764017;2958.2160727407254;5206.713630750345;5624.184493248538;5780.971095144498;5792.565557583198;5896.321922978912;5159.961815083021;5367.812126575551;5835.533157347402;5836.766529338779;5839.941600584025;4721.126591580569;5825.213596164548;5887.793927212527;5955.940440595538;5963.703973969966;5068.467810879952;5562.833115006556;5582.325302409342;5693.658380497183;5721.685307308138;4554.544545545419;4751.572358487752;4975.4278258000795;5361.35663720356;5478.479544443271;5151.815082530964;5473.480019398151;5568.1091025435735;5622.437756224344;5791.262621213535;4081.8775436736946;4092.9944327280014;4349.608125399968;4411.933820992624;4473.731576105444;4781.976090119527;4862.878428039327;4900.632452566143;5204.0857120012915;5673;5044.218146187347;5347.331583552056;5405.594580406564;5421.972890135524;5472.699001554953;4869.878253043702;5395.70323632204;5455.863603409788;5506.733451306142;5537;4824.734639594715;5111.667741596784;5262.447443018428;5291.3385826771655;5294;4762.3570817939135;5415.4313797050745;5453.700046497481;5460.426655201147;5462.371827239918;4586.564276393738;4986.376702912136;5111.539961403491;5189.948100518946;5264.78940842362 05:49:34 INFO - PROCESS | 1986 | |5;yui.html;725.3979197266269;729.4529103172621;748.985125155414;779.9298063174314;830.9281027474558;15268.465603703873;16008.83991160088;16016.11911344877;16076.919615401936;16140.757888631651;14418.639534011654;14431.42274309029;14437.566872993826;14437.927810360934;15008.324625391857;935.2471260635186;951.4957072751419;979.750163708257;983.1888691829233;990.0643891522515;955.7610597350663;962.9711108666717;968.2254196642693;969.4813274897931;971.7473456901186;1018.3329918903094;1018.9759291911655;1020.8519764634124;1022.049493970607;1023.7491814505456;1008.495752123938;1012.6202673997251;1013.7212266626663;1013.7212266626663;1014.5586669798624;753.7927070055724;754.8678981178326;755.1014292991323;755.5051441305953;756.213537920562;15922.283497242652;16199.91900040504;16240.187990600542;16240.675186496204;16507;11213.887861121366;14208;14303.856961430462;14401.423943042266;14605.342759575844;11630.127740419503;11720.296782193096;11867.228630139014;12044.337561434118;12411.379431028412;3622.402303619926;3667.1382225177063;3709.5733990591157;3746.3069332173636;3858.594847540996;115414.42292788567;116371.83628163779;117883.4105829474;118395;119571;10723.142148628247;11054;11145.888541114486;11280.830787538194;11400.94299528497;23117.768822311562;23431.765682342957;23463.41341466443;23463.53072938532;23567.882160589088;7646.082470103624;7659.08091029069;7767.2232776723;7823.022122234721;7930;3998.3802510610903;4021.1354558770004;4081.673466122703;4110.958890411118;4311.051568654891;3462.844172012215;3572.2319701264355;3573.088862340139;3579.1052236940764;3581.71346292296;548.8600406896215;628.4658040665398;629.2071989293523;630.7886857902562;641.0576452614649;674.2414783368711;688.2738710660301;699.4998576018171;707.5683832862053;727.3090563964149;8092.8381432371025;9649.614015439303;10013.24900632441;10306.044452385964;10458.633947811943;677.8881484554993;708.9578319869784;710.6056138842991;713.9178994415709;730.4594649582973;4787.8563643090765;5083.669561478492;5088.898222035538;5090.287359769635;5095.668781529263;83430;91519;95383;96588.51705741427;100701;55484;57028.71485642628;61105.08342374868;82637.58681206555;86217.27565448656;69407;69484;69699.60600787956;71163.64418177876;79026.4194716091;10845.53585265979;11040.779184416428;11163.162762792661;11210.943945280222;11321.943390282995;46183.53816461792;46738.065238695715;49508.50491495039;49994.75002624963;51279.23081153711;63154.68422658041;63273.683631583386;64380.67809661109;64428;64647.70704585788;13398.732025359634;13695.452181913011;13787.310634468036;13958.720825583228;14419.846412286783;13928.303584820516;13978;14770.852291477378;14790.482333118289;14819.555413337617;13062;13122.60632181036;13949.442022318994;14210.715785684435;14489.420423182955;13533.86466135326;13538;13956.09285396446;14215.431382744575;14444.927775361057;13585.660358491117;13630.591082267549;13635.79546306826;13697.178169309873;13702.383392747151;9840.704778856645;10099.14157296638;10412.32319899204;10624.71568612752;10707.143428525544;10734.624288149877;11387.487563059516;11598.768024639628;11603.709907252387;11817.409129543317 05:49:34 INFO - PROCESS | 1986 | __end_tp_report 05:49:34 INFO - PROCESS | 1986 | __start_cc_report 05:49:34 INFO - PROCESS | 1986 | _x_x_mozilla_cycle_collect,2246 05:49:34 INFO - PROCESS | 1986 | __end_cc_report 05:49:34 INFO - PROCESS | 1986 | __startTimestamp1490618974704__endTimestamp 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | ------- Summary: start ------- 05:49:34 INFO - PROCESS | 1986 | Number of tests: 6 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#0] dojo.html Cycles:165 Average:5736.75 Median:5908.97 stddev:640.29 (10.8%) stddev-sans-first:605.91 05:49:34 INFO - PROCESS | 1986 | Values: 3026.0 3345.0 3349.7 3357.3 3391.7 4759.8 5761.4 5774.9 5777.9 5783.3 5699.8 5795.6 5796.8 5801.9 5825.8 5222.7 5265.1 5272.7 5289.2 5337.9 5105.6 5114.4 5135.0 5336.7 5364.7 5263.6 5274.4 5300.2 5329.6 5335.2 5302.3 5318.2 5319.8 5325.2 5329.0 5050.1 5161.6 5244.4 5250.6 5284.8 5581.3 5585.2 5606.1 5622.2 5642.5 6022.7 6098.4 6100.8 6110.3 6123.0 6184.0 6261.8 6315.1 6329.8 6349.9 5877.6 5894.9 5909.0 5914.3 5942.3 5280.9 5449.7 6152.2 6329.4 6350.1 5972.9 6150.2 6194.3 6200.6 6226.4 6317.2 6339.3 6353.8 6354.0 6364.3 5977.7 6261.6 6292.4 6308.9 6315.4 6122.8 6134.4 6220.2 6261.9 6292.6 5024.1 5024.7 5034.6 5044.4 5087.9 4511.5 4514.4 4514.5 4523.4 4558.5 5439.2 5482.1 5515.7 5589.7 5719.7 6116.3 6140.3 6151.7 6259.8 6264.0 5774.8 5778.6 5782.2 5797.7 5819.9 5529.8 5533.5 5534.4 5538.5 5543.5 6201.8 6269.3 6386.6 6393.1 6423.1 6240.1 6274.2 6309.2 6334.5 6345.8 6299.3 6340.4 6345.3 6359.2 6362.1 6201.5 6206.9 6207.9 6229.3 6256.5 6051.6 6080.8 6136.4 6221.6 6263.3 5994.2 6148.8 6160.8 6185.6 6187.8 6088.9 6089.7 6134.9 6151.9 6152.0 5636.4 5740.2 5977.6 6006.1 6018.6 5068.3 5115.6 5908.8 6078.7 6192.6 5638.2 5683.9 5741.8 6038.5 6060.7 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#1] ext.html Cycles:180 Average:57810.35 Median:3143.64 stddev:118890.58 (3781.9%) stddev-sans-first:119147.02 05:49:34 INFO - PROCESS | 1986 | Values: 788.8 812.7 861.9 885.1 886.6 40041.4 40773.8 41009.8 41071.8 41155.6 41277.8 41484.2 41525.6 41645.6 41807.4 7299.3 7450.2 9218.9 9339.2 9353.4 10906.3 11135.6 11259.4 11265.9 11277.2 11106.9 11133.9 11145.4 11157.3 11188.7 7274.3 11081.9 11094.7 11095.2 11102.4 7321.4 7371.4 7371.5 7373.6 10764.9 39168.4 39473.8 39518.6 39559.0 39616.8 3609.2 3619.2 3625.8 3626.9 3726.4 27740.9 28275.9 28761.6 29442.9 29720.4 3126.8 3128.5 3158.7 3184.7 3288.8 292961.0 355829.0 356180.0 357575.0 357858.0 42721.6 43353.8 50670.7 51777.0 52066.7 55068.4 55324.3 55332.2 55334.4 55426.0 14617.7 14703.3 14706.9 14710.1 14717.8 12583.9 12596.2 12612.7 12624.1 12684.6 12584.7 12594.9 12640.4 12662.8 12727.8 4794.3 5009.5 5705.4 5741.4 5779.6 1090.6 1126.2 1130.5 1156.7 1179.5 26632.3 27155.6 27412.6 28114.9 28187.3 1147.1 1162.6 1239.8 1251.5 1287.2 12339.8 14121.9 14214.8 14278.0 14315.3 504303.0 505904.0 506696.0 506760.0 524310.0 57873.7 58159.7 58171.5 58175.0 58322.0 1428.3 1433.6 1492.2 1493.2 1493.5 25462.6 26449.3 26723.9 27014.6 27069.9 45249.8 45499.5 45528.0 45586.1 45588.3 467244.7 469770.0 470030.0 470601.0 470981.0 29029.3 29689.0 29715.0 34627.5 35798.8 42806.6 43006.8 43452.8 43521.8 45038.0 29611.9 29923.1 30650.2 30860.8 30987.2 29751.0 29780.0 29850.6 30723.0 30837.2 35872.5 36618.0 36624.1 36639.0 36655.7 29699.6 29714.9 29866.3 30289.4 30911.8 21522.8 22936.3 24182.9 24769.9 24773.6 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#2] jquery.html Cycles:180 Average:44784.87 Median:24608.44 stddev:133101.73 (540.9%) stddev-sans-first:133433.37 05:49:34 INFO - PROCESS | 1986 | Values: 386.5 409.6 421.4 430.8 447.8 14173.7 21028.8 21884.9 22222.4 22412.9 21192.0 21607.2 22064.7 22141.0 22524.7 6414.8 6650.4 6651.9 6665.9 6774.4 6552.1 6667.1 6685.2 6687.2 6689.9 3815.7 3940.6 7315.8 7691.8 7698.1 7376.7 7604.5 7666.2 7685.8 7698.6 6380.4 7448.7 7458.0 7464.8 7484.6 25432.0 25884.7 25887.5 25941.9 26496.0 2833.4 2842.8 2846.8 2886.7 2888.7 14286.4 15968.1 16222.9 16272.0 16931.8 2017.4 2040.0 2044.4 2047.8 2079.0 160610.6 161491.0 163891.0 166895.0 169120.0 14850.6 15453.8 15852.0 20221.8 20581.5 31614.5 32480.7 32535.8 32946.7 32959.8 10127.0 10509.6 10681.5 10734.6 10886.3 8811.9 8814.6 8841.4 9009.1 9023.0 7954.4 9434.6 9488.9 9515.2 9690.5 3911.1 4006.9 4016.8 4022.8 4045.7 793.7 995.7 1000.4 1032.3 1037.2 22104.7 23456.5 24528.9 24560.9 24656.0 789.5 937.1 945.2 971.5 1000.6 5564.4 6782.3 6944.2 7190.0 7196.4 770613.0 782738.0 803951.0 807619.0 814025.0 166006.0 167696.0 168724.0 172619.1 173942.0 1282.3 1314.9 1344.9 1345.5 1347.6 12115.2 12229.5 12384.6 12709.9 12711.0 42115.8 61472.7 65239.0 66463.3 66887.0 69855.0 90729.5 91359.1 93417.0 93986.0 11514.4 11835.1 12019.8 12154.4 12199.8 13246.6 13247.3 13257.0 13351.7 13683.3 9157.0 11448.8 11472.1 11656.9 11716.5 9934.4 10504.4 10650.4 10916.7 10964.6 11144.5 11200.7 11275.9 11394.8 11592.0 11730.4 11758.3 11808.5 12085.3 12159.9 10059.9 11132.9 11507.1 11510.9 11855.8 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#3] mootools.html Cycles:180 Average:6567.03 Median:3344.09 stddev:4150.87 (124.1%) stddev-sans-first:4144.33 05:49:34 INFO - PROCESS | 1986 | Values: 1395.8 1539.2 1554.3 1585.3 1599.8 10521.9 11155.8 11156.8 11160.3 11191.9 10532.6 11024.4 11212.3 11241.6 11253.3 2033.6 2396.2 2425.7 2432.1 2434.1 2337.3 2399.1 2419.0 2427.9 2429.8 1999.8 2310.1 2343.7 2390.6 2406.7 2099.5 2343.5 2354.9 2380.7 2382.5 1971.6 2408.2 2408.7 2411.7 2411.9 11035.6 11111.9 11114.9 11123.8 11132.9 5648.7 5755.8 5960.0 5973.1 5979.3 3465.5 3560.7 3623.3 3695.0 3695.2 1156.8 1200.9 1226.3 1236.7 1242.0 13661.7 14013.4 14285.9 15100.4 15149.5 4549.3 4668.5 4693.3 4698.9 4713.0 11660.2 11671.0 11672.7 11676.6 11704.3 4765.4 4968.2 5006.1 5696.1 5701.3 4350.4 5242.1 5283.2 5286.2 5286.9 3222.6 3778.8 3895.4 3948.6 3952.5 872.0 1042.5 1053.0 1054.6 1061.5 781.6 793.8 801.8 808.8 814.8 6333.7 6380.4 6515.8 6602.2 6754.9 891.0 1034.6 1036.3 1046.4 1062.8 4057.2 4067.5 4074.0 4077.8 4202.4 13352.8 14008.6 14017.2 14023.4 14089.3 13564.5 13626.2 13692.2 13851.6 13921.2 8340.2 9537.6 9993.0 10071.5 10205.4 6360.5 6430.8 6432.6 6462.0 6611.9 12048.5 12059.5 12349.6 12388.3 12406.9 10661.7 10872.9 12393.3 12481.8 12578.7 7955.3 7963.4 7966.4 8050.9 8055.4 9648.3 9836.0 9838.7 9843.0 9852.5 8200.8 8432.5 8435.2 8478.2 8543.6 8270.6 8283.2 8303.5 8336.5 8354.7 7531.8 7538.8 7625.1 7634.3 7642.9 5527.3 5554.2 5663.9 5668.3 5776.4 4740.7 5581.4 5593.5 5733.6 5823.8 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#4] prototype.html Cycles:180 Average:4559.81 Median:4892.95 stddev:1267.92 (25.9%) stddev-sans-first:1231.75 05:49:34 INFO - PROCESS | 1986 | Values: 364.4 373.9 377.9 383.8 384.5 4790.3 5141.8 5149.3 5220.2 5315.6 4392.2 4695.8 5166.6 5182.0 5209.5 3649.5 4164.5 4283.1 4304.7 4322.3 3689.8 3701.9 4310.0 4319.7 4320.4 3739.4 3739.4 4245.6 4303.4 4337.2 3557.9 4010.9 4046.5 4361.9 4383.7 3646.5 3905.5 3947.2 3965.3 3997.8 4544.6 5062.0 5122.0 5155.8 5192.9 4736.9 4754.0 4929.5 5002.3 5005.1 4776.7 5048.7 5461.8 5550.4 5589.0 4319.9 4343.3 4406.7 4432.7 4450.8 4315.6 5328.5 5551.2 5917.7 5996.8 4073.2 4365.3 4542.5 4557.6 4589.9 4152.1 4620.7 4635.7 4658.9 4685.0 4632.5 4734.3 4805.8 4885.3 4950.4 5253.0 5294.8 5424.5 5462.9 5522.0 1366.5 1481.0 1549.8 1578.3 1589.6 1161.8 1170.8 1171.8 1180.8 1200.4 4636.1 4949.9 5139.0 5217.6 5222.8 4877.4 5284.6 5763.5 5803.4 5818.2 4355.7 4663.6 4682.6 5006.3 5071.5 2596.3 2609.0 2651.6 2944.6 2958.2 5206.7 5624.2 5781.0 5792.6 5896.3 5160.0 5367.8 5835.5 5836.8 5839.9 4721.1 5825.2 5887.8 5955.9 5963.7 5068.5 5562.8 5582.3 5693.7 5721.7 4554.5 4751.6 4975.4 5361.4 5478.5 5151.8 5473.5 5568.1 5622.4 5791.3 4081.9 4093.0 4349.6 4411.9 4473.7 4782.0 4862.9 4900.6 5204.1 5673.0 5044.2 5347.3 5405.6 5422.0 5472.7 4869.9 5395.7 5455.9 5506.7 5537.0 4824.7 5111.7 5262.4 5291.3 5294.0 4762.4 5415.4 5453.7 5460.4 5462.4 4586.6 4986.4 5111.5 5189.9 5264.8 05:49:34 INFO - PROCESS | 1986 | 05:49:34 INFO - PROCESS | 1986 | [#5] yui.html Cycles:180 Average:19856.50 Median:23463.47 stddev:28065.41 (119.6%) stddev-sans-first:28107.38 05:49:34 INFO - PROCESS | 1986 | Values: 725.4 729.5 749.0 779.9 830.9 15268.5 16008.8 16016.1 16076.9 16140.8 14418.6 14431.4 14437.6 14437.9 15008.3 935.2 951.5 979.8 983.2 990.1 955.8 963.0 968.2 969.5 971.7 1018.3 1019.0 1020.9 1022.0 1023.7 1008.5 1012.6 1013.7 1013.7 1014.6 753.8 754.9 755.1 755.5 756.2 15922.3 16199.9 16240.2 16240.7 16507.0 11213.9 14208.0 14303.9 14401.4 14605.3 11630.1 11720.3 11867.2 12044.3 12411.4 3622.4 3667.1 3709.6 3746.3 3858.6 115414.4 116371.8 117883.4 118395.0 119571.0 10723.1 11054.0 11145.9 11280.8 11400.9 23117.8 23431.8 23463.4 23463.5 23567.9 7646.1 7659.1 7767.2 7823.0 7930.0 3998.4 4021.1 4081.7 4111.0 4311.1 3462.8 3572.2 3573.1 3579.1 3581.7 548.9 628.5 629.2 630.8 641.1 674.2 688.3 699.5 707.6 727.3 8092.8 9649.6 10013.2 10306.0 10458.6 677.9 709.0 710.6 713.9 730.5 4787.9 5083.7 5088.9 5090.3 5095.7 83430.0 91519.0 95383.0 96588.5 100701.0 55484.0 57028.7 61105.1 82637.6 86217.3 69407.0 69484.0 69699.6 71163.6 79026.4 10845.5 11040.8 11163.2 11210.9 11321.9 46183.5 46738.1 49508.5 49994.8 51279.2 63154.7 63273.7 64380.7 64428.0 64647.7 13398.7 13695.5 13787.3 13958.7 14419.8 13928.3 13978.0 14770.9 14790.5 14819.6 13062.0 13122.6 13949.4 14210.7 14489.4 13533.9 13538.0 13956.1 14215.4 14444.9 13585.7 13630.6 13635.8 13697.2 13702.4 9840.7 10099.1 10412.3 10624.7 10707.1 10734.6 11387.5 11598.8 11603.7 11817.4 05:49:34 INFO - PROCESS | 1986 | -------- Summary: end -------- 05:49:34 INFO - PROCESS | 1986 | 05:49:35 INFO - TEST-INFO | 1986: exit 0 05:49:35 INFO - TEST-OK | dromaeo_css | took 1120935ms 05:49:35 INFO - TEST-START | kraken 05:49:35 INFO - operating with platform_type : mac_ 05:49:35 INFO - Initialising browser for kraken test... 05:49:35 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpavqSp2/profile http://localhost:54068/getInfo.html) 05:49:37 INFO - PROCESS | 1989 | __metrics Screen width/height:1600/1200 05:49:37 INFO - PROCESS | 1989 | colorDepth:24 05:49:37 INFO - PROCESS | 1989 | Browser inner width/height: 1024/689 05:49:37 INFO - PROCESS | 1989 | __metrics 05:49:37 INFO - PROCESS | 1989 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:49:37 INFO - PROCESS | 1989 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:38 INFO - TEST-INFO | 1989: exit 0 05:49:38 INFO - Browser initialized. 05:49:38 INFO - Running cycle 1/1 for kraken test... 05:49:38 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpavqSp2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:50 INFO - PROCESS | 1990 | RSS: Main: 211288064 05:49:50 INFO - PROCESS | 1990 | 05:49:53 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:54 INFO - PROCESS | 1990 | RSS: Main: 265584640 05:49:54 INFO - PROCESS | 1990 | 05:49:56 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-dft) 05:49:57 INFO - PROCESS | 1990 | RSS: Main: 280350720 05:49:57 INFO - PROCESS | 1990 | 05:50:00 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-fft) 05:50:01 INFO - PROCESS | 1990 | RSS: Main: 375980032 05:50:01 INFO - PROCESS | 1990 | 05:50:03 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54068/tests/kraken/driver.html?testName=audio-oscillator) 05:50:03 INFO - PROCESS | 1990 | RSS: Main: 279584768 05:50:03 INFO - PROCESS | 1990 | 05:50:06 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:06 INFO - PROCESS | 1990 | RSS: Main: 280965120 05:50:06 INFO - PROCESS | 1990 | 05:50:09 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:10 INFO - PROCESS | 1990 | RSS: Main: 320966656 05:50:10 INFO - PROCESS | 1990 | 05:50:13 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54068/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:13 INFO - PROCESS | 1990 | RSS: Main: 322809856 05:50:13 INFO - PROCESS | 1990 | 05:50:16 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54068/tests/kraken/driver.html?testName=json-parse-financial) 05:50:17 INFO - PROCESS | 1990 | RSS: Main: 318541824 05:50:17 INFO - PROCESS | 1990 | 05:50:18 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:19 INFO - PROCESS | 1990 | RSS: Main: 296595456 05:50:19 INFO - PROCESS | 1990 | 05:50:21 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:22 INFO - PROCESS | 1990 | RSS: Main: 298024960 05:50:22 INFO - PROCESS | 1990 | 05:50:24 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:24 INFO - PROCESS | 1990 | RSS: Main: 301555712 05:50:24 INFO - PROCESS | 1990 | 05:50:27 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:28 INFO - PROCESS | 1990 | RSS: Main: 318214144 05:50:28 INFO - PROCESS | 1990 | 05:50:31 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:32 INFO - PROCESS | 1990 | RSS: Main: 311455744 05:50:32 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:54068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54068/tests/kraken/driver.html?testName=ai-astar) 05:50:33 INFO - PROCESS | 1990 | RSS: Main: 356278272 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | __start_tp_report 05:50:33 INFO - PROCESS | 1990 | _x_x_mozilla_page_load 05:50:33 INFO - PROCESS | 1990 | _x_x_mozilla_page_load_details 05:50:33 INFO - PROCESS | 1990 | |i|pagename|runs| 05:50:33 INFO - PROCESS | 1990 | |0;ai-astar;106;114;114;114;114;115;115;114;115;114 05:50:33 INFO - PROCESS | 1990 | |1;audio-beat-detection;145;109;116;146;110;111;109;111;157;133 05:50:33 INFO - PROCESS | 1990 | |2;audio-dft;187;184;170;228;265;240;187;184;185;185 05:50:33 INFO - PROCESS | 1990 | |3;audio-fft;83;62;60;92;62;59;60;60;78;61 05:50:33 INFO - PROCESS | 1990 | |4;audio-oscillator;92;69;88;70;70;69;99;99;76;85 05:50:33 INFO - PROCESS | 1990 | |5;imaging-gaussian-blur;89;88;89;88;89;88;89;89;89;90 05:50:33 INFO - PROCESS | 1990 | |6;imaging-darkroom;94;94;95;95;95;94;95;94;94;95 05:50:33 INFO - PROCESS | 1990 | |7;imaging-desaturate;86;84;83;86;84;87;86;87;84;83 05:50:33 INFO - PROCESS | 1990 | |8;json-parse-financial;62;62;61;61;63;63;62;62;64;63 05:50:33 INFO - PROCESS | 1990 | |9;json-stringify-tinderbox;55;61;62;65;61;57;58;78;50;55 05:50:33 INFO - PROCESS | 1990 | |10;stanford-crypto-aes;83;84;81;92;74;82;87;97;81;82 05:50:33 INFO - PROCESS | 1990 | |11;stanford-crypto-ccm;135;138;136;135;135;140;139;141;177;139 05:50:33 INFO - PROCESS | 1990 | |12;stanford-crypto-pbkdf2;163;164;162;164;162;163;162;155;162;166 05:50:33 INFO - PROCESS | 1990 | |13;stanford-crypto-sha256-iterative;67;65;65;64;64;65;64;64;64;64 05:50:33 INFO - PROCESS | 1990 | __end_tp_report 05:50:33 INFO - PROCESS | 1990 | __start_cc_report 05:50:33 INFO - PROCESS | 1990 | _x_x_mozilla_cycle_collect,2151 05:50:33 INFO - PROCESS | 1990 | __end_cc_report 05:50:33 INFO - PROCESS | 1990 | __startTimestamp1490619033971__endTimestamp 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | ------- Summary: start ------- 05:50:33 INFO - PROCESS | 1990 | Number of tests: 14 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.68 (2.3%) stddev-sans-first:0.50 05:50:33 INFO - PROCESS | 1990 | Values: 106.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 115.0 114.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:124.50 stddev:18.67 (15.0%) stddev-sans-first:18.30 05:50:33 INFO - PROCESS | 1990 | Values: 145.0 109.0 116.0 146.0 110.0 111.0 109.0 111.0 157.0 133.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#2] audio-dft Cycles:10 Average:201.50 Median:187.00 stddev:31.25 (16.7%) stddev-sans-first:32.70 05:50:33 INFO - PROCESS | 1990 | Values: 187.0 184.0 170.0 228.0 265.0 240.0 187.0 184.0 185.0 185.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#3] audio-fft Cycles:10 Average:67.70 Median:62.00 stddev:11.99 (19.3%) stddev-sans-first:11.37 05:50:33 INFO - PROCESS | 1990 | Values: 83.0 62.0 60.0 92.0 62.0 59.0 60.0 60.0 78.0 61.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:86.50 stddev:12.40 (14.3%) stddev-sans-first:12.58 05:50:33 INFO - PROCESS | 1990 | Values: 92.0 69.0 88.0 70.0 70.0 69.0 99.0 99.0 76.0 85.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:50:33 INFO - PROCESS | 1990 | Values: 89.0 88.0 89.0 88.0 89.0 88.0 89.0 89.0 89.0 90.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:50:33 INFO - PROCESS | 1990 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 05:50:33 INFO - PROCESS | 1990 | Values: 86.0 84.0 83.0 86.0 84.0 87.0 86.0 87.0 84.0 83.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 05:50:33 INFO - PROCESS | 1990 | Values: 62.0 62.0 61.0 61.0 63.0 63.0 62.0 62.0 64.0 63.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:61.00 stddev:7.58 (12.4%) stddev-sans-first:7.81 05:50:33 INFO - PROCESS | 1990 | Values: 55.0 61.0 62.0 65.0 61.0 57.0 58.0 78.0 50.0 55.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:6.40 (7.7%) stddev-sans-first:6.77 05:50:33 INFO - PROCESS | 1990 | Values: 83.0 84.0 81.0 92.0 74.0 82.0 87.0 97.0 81.0 82.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.00 stddev:12.67 (9.1%) stddev-sans-first:13.22 05:50:33 INFO - PROCESS | 1990 | Values: 135.0 138.0 136.0 135.0 135.0 140.0 139.0 141.0 177.0 139.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:2.87 (1.8%) stddev-sans-first:3.03 05:50:33 INFO - PROCESS | 1990 | Values: 163.0 164.0 162.0 164.0 162.0 163.0 162.0 155.0 162.0 166.0 05:50:33 INFO - PROCESS | 1990 | 05:50:33 INFO - PROCESS | 1990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:0.50 05:50:33 INFO - PROCESS | 1990 | Values: 67.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 05:50:33 INFO - PROCESS | 1990 | -------- Summary: end -------- 05:50:33 INFO - PROCESS | 1990 | 05:50:34 INFO - TEST-INFO | 1990: exit 0 05:50:34 INFO - TEST-OK | kraken | took 59528ms 05:50:34 INFO - SUITE-END | took 1180s 05:50:35 INFO - Completed test suite (00:19:40) 05:50:35 INFO - javascript benchmark 05:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7621.74590451928, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.9848700756493, 3344.966550334496, 3349.7320214382844, 3357.3117510910265, 3391.711704505117, 4759.762011899408, 5761.423857614242, 5774.884502309951, 5777.913331300028, 5783.3349164846, 5699.829005129843, 5795.565332600061, 5796.768129274835, 5801.9129713054235, 5825.766969321222, 5222.685355590265, 5265.131253343194, 5272.683638981654, 5289.20661900716, 5337.893242135155, 5105.642605017651, 5114.43741188469, 5134.974325128369, 5336.67979921204, 5364.678119312854, 5263.605229607776, 5274.4198138204765, 5300.151975683892, 5329.573634109282, 5335.1730481775385, 5302.310699609065, 5318.202269659543, 5319.813806516792, 5325.227841962894, 5328.973355133199, 5050.116229659795, 5161.638685292031, 5244.423113457517, 5250.579953603703, 5284.788608455658, 5581.302337207849, 5585.162225666142, 5606.131049687305, 5622.156676498517, 5642.548596112342, 6022.6687532185715, 6098.39016098391, 6100.847478813065, 6110.327863934964, 6122.969385153046, 6183.979643358841, 6261.780837670705, 6315.115883776275, 6329.810105696836, 6349.936500634981, 5877.588568800185, 5894.852628684317, 5908.970455147697, 5914.319853216849, 5942.286925568959, 5280.9207861882105, 5449.700266485302, 6152.200213972155, 6329.367063293634, 6350.110984462179, 5972.850678733066, 6150.169727086786, 6194.256689197235, 6200.596961197508, 6226.439620434183, 6317.241930968313, 6339.302676705559, 6353.809385718436, 6354.0, 6364.268109167505, 5977.671228082497, 6261.5616906816995, 6292.370762923762, 6308.905366419507, 6315.400036996478, 6122.846928826815, 6134.38656134383, 6220.191375121205, 6261.874762504815, 6292.622442653455, 5024.145895197825, 5024.748762561931, 5034.597232221414, 5044.369453818273, 5087.898242035212, 4511.458624965026, 4514.435695538058, 4514.503404625489, 4523.36672865799, 4558.49856515783, 5439.211314359475, 5482.122860342326, 5515.696636685021, 5589.692566908859, 5719.656820590778, 6116.274903966718, 6140.289530736458, 6151.72317245725, 6259.812205633838, 6263.96868015657, 5774.769009239583, 5778.56660750437, 5782.161586569924, 5797.739101740432, 5819.854503637358, 5529.806456774074, 5533.529649979716, 5534.418886016991, 5538.501534861801, 5543.473370029841, 6201.782937597343, 6269.279032911091, 6386.584871983307, 6393.073004414334, 6423.132877061724, 6240.063990401476, 6274.215723034621, 6309.179806625109, 6334.4932405406535, 6345.809625711236, 6299.338569450325, 6340.4293613575, 6345.270293916259, 6359.17330747, 6362.0774987627465, 6201.534884883742, 6206.906896396467, 6207.937920620736, 6229.345918678474, 6256.5307601930945, 6051.606645568024, 6080.787172448943, 6136.3965394158, 6221.595596286227, 6263.311035785969, 5994.220751302303, 6148.784792532419, 6160.7535698571555, 6185.567010309235, 6187.84530386744, 6088.908666370096, 6089.665068421279, 6134.907976380268, 6151.907721384094, 6152.0, 5636.436356364495, 5740.225069615549, 5977.6114552553945, 6006.129111278928, 6018.608790428608, 5068.341115654941, 5115.616328775432, 5908.763649453974, 6078.696065196634, 6192.566520343533, 5638.23883775685, 5683.943160568341, 5741.827745167651, 6038.456538911519, 6060.696965151813], "value": 5696.330174692256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.8264581792006, 812.6911773526059, 861.9396642235042, 885.1369914333529, 886.6320477002045, 40041.3993790093, 40773.79613101934, 41009.7949510252, 41071.79464102679, 41155.58844411555, 41277.79361103198, 41484.17031659373, 41525.58474415255, 41645.58354416463, 41807.37288940668, 7299.30656587626, 7450.217727138626, 9218.907810921888, 9339.206167475739, 9353.392029518094, 10906.34561926283, 11135.610253641124, 11259.4370281486, 11265.943670281678, 11277.210595258335, 11106.888931110667, 11133.944330278337, 11145.387003714792, 11157.2747771395, 11188.66434006981, 7274.345308922169, 11081.889181108207, 11094.667159985212, 11095.167862410352, 11102.444877756121, 7321.37768289696, 7371.447141464411, 7371.520851144712, 7373.631318434111, 10764.869688682655, 39168.41247381292, 39473.802630986946, 39518.60481395178, 39559.01102472432, 39616.80191599052, 3609.151849315409, 3619.2037751694584, 3625.782453052825, 3626.873059442933, 3726.366517691999, 27740.861295693594, 28275.86896524157, 28761.56857647137, 29442.852785736148, 29720.40559188826, 3126.765492588065, 3128.5463607776974, 3158.731507821838, 3184.7133757961897, 3288.8026718396973, 292961.0, 355829.0, 356180.0, 357575.0, 357858.0, 42721.57278427238, 43353.783231083646, 50670.74664626653, 51777.0, 52066.73966630142, 55068.44931550713, 55324.2974347185, 55332.17001744977, 55334.446655533735, 55426.0, 14617.707645847024, 14703.338349774285, 14706.852931470548, 14710.117392956457, 14717.779233311509, 12583.93708031454, 12596.181248218836, 12612.747745045232, 12624.053196010336, 12684.619461416172, 12584.685382865318, 12594.87405125937, 12640.431180596896, 12662.81005784914, 12727.809082863765, 4794.304825800239, 5009.474005229471, 5705.400932902068, 5741.425857414225, 5779.595428320062, 1090.574675876409, 1126.2116518436962, 1130.4912789244872, 1156.7339511912307, 1179.4928180882303, 26632.334191645365, 27155.592666110024, 27412.588811167847, 28114.85942570274, 28187.295317617223, 1147.0823341327073, 1162.6221478019677, 1239.8450193725785, 1251.4868903749418, 1287.2083668543964, 12339.814902776465, 14121.85878141226, 14214.806841286829, 14278.0, 14315.28423578817, 504303.0, 505904.0, 506696.0, 506760.0, 524310.0, 57873.71063144657, 58159.70920145372, 58171.54571135671, 58175.0, 58322.0, 1428.292994967477, 1433.5914264434587, 1492.2091291615461, 1493.1787516865681, 1493.5295381954866, 25462.618060728735, 26449.33876653099, 26723.866380667972, 27014.594781077907, 27069.86465067662, 45249.77375113103, 45499.545004550855, 45528.0, 45586.125179360126, 45588.31617525806, 467244.66377667896, 469770.0, 470030.0, 470601.0, 470981.0, 29029.274268143465, 29689.0, 29714.95997640072, 34627.4805877907, 35798.8210058948, 42806.571934280255, 43006.78496607497, 43452.78273608612, 43521.78239108784, 45038.0, 29611.851940740158, 29923.10230693083, 30650.23374415568, 30860.765569376974, 30987.225319367197, 29751.0, 29780.0, 29850.552241715955, 30723.0, 30837.229069273446, 35872.4619130708, 36618.0, 36624.08439789026, 36639.0, 36655.71704990313, 29699.554506681983, 29714.851425742734, 29866.253343666584, 30289.394212115192, 30911.845440772653, 21522.784772152077, 22936.311910642708, 24182.879085605164, 24769.876150619853, 24773.62839557372], "value": 18860.85906533564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.5496696348754, 409.6436100592485, 421.35953350906624, 430.78030204595655, 447.776111944028, 14173.71652566948, 21028.843413612245, 21884.90575471226, 22222.444438888997, 22412.88793556034, 21192.0, 21607.243746468877, 22064.669029964563, 22141.0, 22524.662130068064, 6414.839629009265, 6650.401463868251, 6651.900221496681, 6665.866682666344, 6774.424173945221, 6552.148220731322, 6667.066610674485, 6685.231198412196, 6687.197536295651, 6689.899651505231, 3815.6565909068177, 3940.6073228804516, 7315.817104572375, 7691.846163076763, 7698.076230852277, 7376.704931802775, 7604.505707129019, 7666.156722760492, 7685.846283074307, 7698.615069246515, 6380.425761681471, 7448.7392941247335, 7458.0, 7464.776056718253, 7484.550926944401, 25432.0, 25884.74115258842, 25887.482250355075, 25941.870290648614, 26496.0, 2833.3624934389804, 2842.786790990684, 2846.7864910131825, 2886.7257610526967, 2888.740013398783, 14286.428492865776, 15968.105494156203, 16222.918885405616, 16272.0, 16931.83068169327, 2017.435118166901, 2039.9694004589944, 2044.366246463586, 2047.7747447780732, 2079.0, 160610.59084113748, 161491.0, 163891.0, 166895.0, 169119.99999999878, 14850.628734281514, 15453.768193477106, 15852.0, 20221.797782022284, 20581.48546286325, 31614.525782112825, 32480.675193247764, 32535.837320813243, 32946.67053329484, 32959.835200824324, 10127.037931396653, 10509.579616815241, 10681.465926703633, 10734.624288150033, 10886.346819190874, 8811.867821982676, 8814.603342849587, 8841.425307355, 9009.099090090938, 9022.954885225663, 7954.403419743542, 9434.622615095319, 9488.857667134998, 9515.23878089751, 9690.46702431373, 3911.1395492991496, 4006.8580454570892, 4016.8393264269685, 4022.798860057044, 4045.6561192298395, 793.738066438074, 995.7012896131132, 1000.4197565412044, 1032.2825636182781, 1037.2117190934944, 22104.658423879107, 23456.530869382517, 24528.87735561311, 24560.877195613906, 24656.0, 789.4749991255751, 937.1425145991342, 945.2249155692404, 971.4802580619335, 1000.5897581991494, 5564.443555644403, 6782.253952065269, 6944.166699996033, 7190.0, 7196.352328290479, 770613.0, 782738.0, 803951.0, 807619.0, 814025.0, 166006.0, 167696.0, 168724.0, 172619.13690431468, 173942.0, 1282.2562913510142, 1314.9474021039243, 1344.88568471681, 1345.5156143788229, 1347.5822495026378, 12115.162917899997, 12229.510819567118, 12384.56654017105, 12709.93645031769, 12711.0, 42115.7894210527, 61472.69263653653, 65239.0, 66463.33536664765, 66886.99669505059, 69855.0, 90729.54635227045, 91359.08640913505, 93417.0, 93986.0, 11514.36670983104, 11835.11236657237, 12019.81970270464, 12154.392280386122, 12199.817002745143, 13246.602601921957, 13247.271400072703, 13257.005724570889, 13351.732965340445, 13683.315834208448, 9157.0, 11448.82826757616, 11472.082233421139, 11656.941715291368, 11716.472758725708, 9934.354266972623, 10504.369737815756, 10650.414227217578, 10916.672499825017, 10964.616238431616, 11144.498497567467, 11200.663980080612, 11275.887241127484, 11394.829077564009, 11592.014678752063, 11730.413479326171, 11758.294502329887, 11808.527658893549, 12085.335306558223, 12159.939200303941, 10059.899401005896, 11132.942370474791, 11507.136964727511, 11510.884891150981, 11855.822162667739], "value": 11382.423354495226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.846456889742, 1539.2303848075962, 1554.33163739592, 1585.26285277346, 1599.8400159984003, 10521.947390263058, 11155.776884462306, 11156.776864462707, 11160.274582152155, 11191.936766007237, 10532.578696852117, 11024.393658348788, 11212.27120237184, 11241.60654377097, 11253.324800511975, 2033.5831154613268, 2396.209250947192, 2425.721042080157, 2432.0514999150346, 2434.1480481831395, 2337.275444612167, 2399.0763556030965, 2419.0, 2427.9271621851285, 2429.79346755526, 1999.780024197337, 2310.0875154314035, 2343.742188359279, 2390.5935990881503, 2406.7352591214953, 2099.4646365176936, 2343.5195784864063, 2354.8587084774967, 2380.654805053266, 2382.4996750682376, 1971.5662554238045, 2408.2052922535695, 2408.7350391456926, 2411.746766589518, 2411.9035238590436, 11035.558577656964, 11111.944440277746, 11114.944080312358, 11123.777524449546, 11132.888671113265, 5648.717564121777, 5755.827325180251, 5960.04639257721, 5973.133895585116, 5979.252593425822, 3465.549478567795, 3560.6795388414907, 3623.2934577757346, 3694.9630503695157, 3695.224002959355, 1156.7917774800533, 1200.9279443233347, 1226.3439060102803, 1236.715555422258, 1242.0001898471726, 13661.726765464635, 14013.439462421491, 14285.857141428556, 15100.395984160621, 15149.469768558047, 4549.3176023596725, 4668.533146685304, 4693.296005599187, 4698.859034228979, 4713.0, 11660.183787134989, 11671.0, 11672.70818229534, 11676.591319303783, 11704.297742135499, 4765.356676848651, 4968.22992436173, 5006.0989021975665, 5696.145578163226, 5701.258836351248, 4350.412694286294, 5242.13504771716, 5283.1546952487415, 5286.20706893969, 5286.8942621148135, 3222.629397619257, 3778.790786948205, 3895.415687646819, 3948.565657777642, 3952.4861767970556, 871.9694810681723, 1042.4631314872847, 1052.9631462898762, 1054.6097943760858, 1061.5382308695741, 781.5974772991914, 793.8372633610212, 801.7674874286508, 808.8261023879776, 814.8288859339486, 6333.746650134035, 6380.361963803675, 6515.837104072436, 6602.207735071726, 6754.864902701918, 890.9910900890908, 1034.6120204923154, 1036.3108532825586, 1046.4035499765214, 1062.7768168684509, 4057.229126465962, 4067.471228740245, 4074.0018695419813, 4077.8368865245056, 4202.3696445533415, 13352.799708004388, 14008.579742607739, 14017.158970461805, 14023.368948397347, 14089.295535223402, 13564.457421703219, 13626.182429054288, 13692.178469291874, 13851.584452466443, 13921.164730116225, 8340.249377556049, 9537.570809313598, 9992.950740172322, 10071.546780395047, 10205.438700871524, 6360.49116070704, 6430.7749228776765, 6432.581882177644, 6462.0, 6611.857456336292, 12048.518059277882, 12059.52779680181, 12349.567765128177, 12388.31864247439, 12406.875931240573, 10661.733456663645, 10872.945635271773, 12393.318367489514, 12481.812772808233, 12578.748425031632, 7955.323797477048, 7963.402744794048, 7966.3626909848235, 8050.919490805017, 8055.395845311508, 9648.276379271723, 9836.016398360392, 9838.655647052605, 9843.0156984301, 9852.458114803754, 8200.794980125305, 8432.53621050848, 8435.24082832548, 8478.152184781473, 8543.615537300711, 8270.586470676322, 8283.213094755989, 8303.543305118277, 8336.458130221516, 8354.707585234488, 7531.849363012819, 7538.811529711801, 7625.123110842324, 7634.312911837961, 7642.923570764221, 5527.309086364205, 5554.1946417770005, 5663.943360566342, 5668.319801623831, 5776.447484796904, 4740.691855029412, 5581.441855814386, 5593.496585307342, 5733.569982251264, 5823.82528524145], "value": 4996.8229516481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.37873425809, 373.9177380976186, 377.90741268389246, 383.7505621346125, 384.5251114873129, 4790.305405716169, 5141.794328226871, 5149.30484384608, 5220.243064755613, 5315.574754019679, 4392.209402307583, 4695.788689508971, 5166.5866730661555, 5181.9740901295445, 5209.479052094789, 3649.4525821126776, 4164.5210800758, 4283.051211698669, 4304.677149213806, 4322.347616264259, 3689.797061161635, 3701.944470832926, 4310.030243195271, 4319.654427645796, 4320.395144679732, 3739.3643080676216, 3739.439084137374, 4245.639120674731, 4303.35449682547, 4337.21930052592, 3557.9110522236892, 4010.919781604366, 4046.453728746611, 4361.88125490276, 4383.7150585212175, 3646.507721457622, 3905.519994803292, 3947.230290093433, 3965.286248475273, 3997.8400863965408, 4544.636429085665, 5062.0, 5121.974390128025, 5155.7679904404395, 5192.948070519285, 4736.905261894743, 4753.952460475385, 4929.482404347564, 5002.349694539723, 5005.0990821652085, 4776.737279449629, 5048.671836330664, 5461.808836690737, 5550.389457159709, 5588.966041282376, 4319.913601727979, 4343.283358245885, 4406.700023493077, 4432.667549933768, 4450.777461126931, 4315.567484662589, 5328.49379308965, 5551.174267787591, 5917.704114794286, 5996.760129594811, 4073.205724883619, 4365.345198220229, 4542.502273249579, 4557.589816916494, 4589.908201835945, 4152.065785198306, 4620.67655264135, 4635.6523260755575, 4658.906821863544, 4684.976575117103, 4632.4672662644225, 4734.313524538922, 4805.831795887128, 4885.267209918541, 4950.430700469492, 5253.0, 5294.814681486129, 5424.511793938485, 5462.890742185134, 5521.972390138104, 1366.5285476510587, 1481.037325738257, 1549.7989058479543, 1578.3213218316234, 1589.5867074560697, 1161.7850697620968, 1170.8281138487982, 1171.77736230116, 1180.8287798269203, 1200.3758045816128, 4636.125602126703, 4949.90100197994, 5138.97430512845, 5217.608679349064, 5222.791088356423, 4877.365942427533, 5284.630075894651, 5763.5216856751995, 5803.448672376117, 5818.207260514977, 4355.73865568067, 4663.595575230101, 4682.6253899687945, 5006.299118123466, 5071.54356107952, 2596.3257844420277, 2608.973910260911, 2651.64202832619, 2944.617199764017, 2958.2160727407254, 5206.713630750345, 5624.184493248538, 5780.971095144498, 5792.565557583198, 5896.321922978912, 5159.961815083021, 5367.812126575551, 5835.533157347402, 5836.766529338779, 5839.941600584025, 4721.126591580569, 5825.213596164548, 5887.793927212527, 5955.940440595538, 5963.703973969966, 5068.467810879952, 5562.833115006556, 5582.325302409342, 5693.658380497183, 5721.685307308138, 4554.544545545419, 4751.572358487752, 4975.4278258000795, 5361.35663720356, 5478.479544443271, 5151.815082530964, 5473.480019398151, 5568.1091025435735, 5622.437756224344, 5791.262621213535, 4081.8775436736946, 4092.9944327280014, 4349.608125399968, 4411.933820992624, 4473.731576105444, 4781.976090119527, 4862.878428039327, 4900.632452566143, 5204.0857120012915, 5673.0, 5044.218146187347, 5347.331583552056, 5405.594580406564, 5421.972890135524, 5472.699001554953, 4869.878253043702, 5395.70323632204, 5455.863603409788, 5506.733451306142, 5537.0, 4824.734639594715, 5111.667741596784, 5262.447443018428, 5291.3385826771655, 5294.0, 4762.3570817939135, 5415.4313797050745, 5453.700046497481, 5460.426655201147, 5462.371827239918, 4586.564276393738, 4986.376702912136, 5111.539961403491, 5189.948100518946, 5264.78940842362], "value": 4191.895125745278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.3979197266269, 729.4529103172621, 748.985125155414, 779.9298063174314, 830.9281027474558, 15268.465603703873, 16008.83991160088, 16016.11911344877, 16076.919615401936, 16140.757888631651, 14418.639534011654, 14431.42274309029, 14437.566872993826, 14437.927810360934, 15008.324625391857, 935.2471260635186, 951.4957072751419, 979.750163708257, 983.1888691829233, 990.0643891522515, 955.7610597350663, 962.9711108666717, 968.2254196642693, 969.4813274897931, 971.7473456901186, 1018.3329918903094, 1018.9759291911655, 1020.8519764634124, 1022.049493970607, 1023.7491814505456, 1008.495752123938, 1012.6202673997251, 1013.7212266626663, 1013.7212266626663, 1014.5586669798624, 753.7927070055724, 754.8678981178326, 755.1014292991323, 755.5051441305953, 756.213537920562, 15922.283497242652, 16199.91900040504, 16240.187990600542, 16240.675186496204, 16507.0, 11213.887861121366, 14208.0, 14303.856961430462, 14401.423943042266, 14605.342759575844, 11630.127740419503, 11720.296782193096, 11867.228630139014, 12044.337561434118, 12411.379431028412, 3622.402303619926, 3667.1382225177063, 3709.5733990591157, 3746.3069332173636, 3858.594847540996, 115414.42292788567, 116371.83628163779, 117883.4105829474, 118395.0, 119571.0, 10723.142148628247, 11054.0, 11145.888541114486, 11280.830787538194, 11400.94299528497, 23117.768822311562, 23431.765682342957, 23463.41341466443, 23463.53072938532, 23567.882160589088, 7646.082470103624, 7659.08091029069, 7767.2232776723, 7823.022122234721, 7930.0, 3998.3802510610903, 4021.1354558770004, 4081.673466122703, 4110.958890411118, 4311.051568654891, 3462.844172012215, 3572.2319701264355, 3573.088862340139, 3579.1052236940764, 3581.71346292296, 548.8600406896215, 628.4658040665398, 629.2071989293523, 630.7886857902562, 641.0576452614649, 674.2414783368711, 688.2738710660301, 699.4998576018171, 707.5683832862053, 727.3090563964149, 8092.8381432371025, 9649.614015439303, 10013.24900632441, 10306.044452385964, 10458.633947811943, 677.8881484554993, 708.9578319869784, 710.6056138842991, 713.9178994415709, 730.4594649582973, 4787.8563643090765, 5083.669561478492, 5088.898222035538, 5090.287359769635, 5095.668781529263, 83430.0, 91519.0, 95383.0, 96588.51705741427, 100701.0, 55484.0, 57028.71485642628, 61105.08342374868, 82637.58681206555, 86217.27565448656, 69407.0, 69484.0, 69699.60600787956, 71163.64418177876, 79026.4194716091, 10845.53585265979, 11040.779184416428, 11163.162762792661, 11210.943945280222, 11321.943390282995, 46183.53816461792, 46738.065238695715, 49508.50491495039, 49994.75002624963, 51279.23081153711, 63154.68422658041, 63273.683631583386, 64380.67809661109, 64428.0, 64647.70704585788, 13398.732025359634, 13695.452181913011, 13787.310634468036, 13958.720825583228, 14419.846412286783, 13928.303584820516, 13978.0, 14770.852291477378, 14790.482333118289, 14819.555413337617, 13062.0, 13122.60632181036, 13949.442022318994, 14210.715785684435, 14489.420423182955, 13533.86466135326, 13538.0, 13956.09285396446, 14215.431382744575, 14444.927775361057, 13585.660358491117, 13630.591082267549, 13635.79546306826, 13697.178169309873, 13702.383392747151, 9840.704778856645, 10099.14157296638, 10412.32319899204, 10624.71568612752, 10707.143428525544, 10734.624288149877, 11387.487563059516, 11598.768024639628, 11603.709907252387, 11817.409129543317], "value": 7652.234506584025, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 116.0, 146.0, 110.0, 111.0, 109.0, 111.0, 157.0, 133.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 170.0, 228.0, 265.0, 240.0, 187.0, 184.0, 185.0, 185.0], "value": 201.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 60.0, 92.0, 62.0, 59.0, 60.0, 60.0, 78.0, 61.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 88.0, 70.0, 70.0, 69.0, 99.0, 99.0, 76.0, 85.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 88.0, 89.0, 89.0, 89.0, 90.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 86.0, 84.0, 87.0, 86.0, 87.0, 84.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 63.0, 62.0, 62.0, 64.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 62.0, 65.0, 61.0, 57.0, 58.0, 78.0, 50.0, 55.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 92.0, 74.0, 82.0, 87.0, 97.0, 81.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 136.0, 135.0, 135.0, 140.0, 139.0, 141.0, 177.0, 139.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 164.0, 162.0, 163.0, 162.0, 155.0, 162.0, 166.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 05:50:35 INFO - Return code: 0 05:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:35 ERROR - # TBPL SUCCESS # 05:50:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:50:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:50:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:50:35 INFO - 2017-03-27 05:50:35.311 screenresolution[1994:21230] starting screenresolution argv=screenresolution get 05:50:35 INFO - 2017-03-27 05:50:35.314 screenresolution[1994:21230] Display 0: 1600x1200x32@60 05:50:35 INFO - 2017-03-27 05:50:35.320 screenresolution[1995:21233] starting screenresolution argv=screenresolution list 05:50:35 INFO - Available Modes on Display 0 05:50:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:50:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:50:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:50:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:50:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:50:35 INFO - Intel Iris: 05:50:35 INFO - Chipset Model: Intel Iris 05:50:35 INFO - Type: GPU 05:50:35 INFO - Bus: Built-In 05:50:35 INFO - VRAM (Dynamic, Max): 1536 MB 05:50:35 INFO - Vendor: Intel (0x8086) 05:50:35 INFO - Device ID: 0x0a2e 05:50:35 INFO - Revision ID: 0x0009 05:50:35 INFO - Displays: 05:50:35 INFO - Display: 05:50:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:50:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:50:35 INFO - Display Serial Number: 1600x1200 60 05:50:35 INFO - Main Display: Yes 05:50:35 INFO - Mirror: Off 05:50:35 INFO - Online: Yes 05:50:35 INFO - Rotation: Supported 05:50:35 INFO - Return code: 0 05:50:35 INFO - Running post-action listener: _resource_record_post_action 05:50:35 INFO - [mozharness: 2017-03-27 12:50:35.555847Z] Finished run-tests step (success) 05:50:35 INFO - Running post-run listener: _resource_record_post_run 05:50:35 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 745472; Write bytes: 507708928; Read time: 6; Write time: 1584 05:50:35 INFO - TinderboxPrint: CPU usage
54.0% 05:50:35 INFO - TinderboxPrint: I/O read bytes / time
745,472 / 6 05:50:35 INFO - TinderboxPrint: I/O write bytes / time
507,708,928 / 1,584 05:50:35 INFO - TinderboxPrint: CPU idle
2,212.2 (46.0%) 05:50:35 INFO - TinderboxPrint: CPU system
961.2 (20.0%) 05:50:35 INFO - TinderboxPrint: CPU user
1,632.4 (34.0%) 05:50:35 INFO - TinderboxPrint: Swap in / out
208,199,680 / 0 05:50:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203448832; Write bytes: 201263104; Read time: 15706; Write time: 431 05:50:35 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 745472; Write bytes: 295677440; Read time: 6; Write time: 1117 05:50:36 INFO - Running post-run listener: _upload_blobber_files 05:50:36 INFO - Blob upload gear active. 05:50:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:50:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:37 INFO - (blobuploader) - INFO - Done attempting. 05:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:37 INFO - (blobuploader) - INFO - Done attempting. 05:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:39 INFO - (blobuploader) - INFO - Done attempting. 05:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:41 INFO - (blobuploader) - INFO - Done attempting. 05:50:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:41 INFO - Return code: 0 05:50:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e6181bf4bf1aaf749e3177562d43941ab42d6261719e9c573918f701a33a84126b1ca7e3b01003f1baf3689ac8649ed6535bc19d17247ccf21885315d1f97be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7de332fe1166f09c02db4124e86bca60863496ea1e0c164c6fe62f5a1e5f56743dfc985b667960539435ab07e49ed51c586ec8af8ff012cf2242653a6fabdfac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a54c6f647f3851d1e6ca4a9b8b8c369f4c63df443530217744c81d8dacc2710e6ef85017ec4f44f8aaeb66d05beed35cc33cb60b06c9d92ff78d97950fbbcc9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a8df0f110418a596b0afbc0ab5a0af3c5d84fca9a738a2fb0df0c6c1e2ad972f4c5daf16201cba5ad480d062795cdacc406213c44ddb4dbbfadfb5bbbc853e"} 05:50:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:41 INFO - Contents: 05:50:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e6181bf4bf1aaf749e3177562d43941ab42d6261719e9c573918f701a33a84126b1ca7e3b01003f1baf3689ac8649ed6535bc19d17247ccf21885315d1f97be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7de332fe1166f09c02db4124e86bca60863496ea1e0c164c6fe62f5a1e5f56743dfc985b667960539435ab07e49ed51c586ec8af8ff012cf2242653a6fabdfac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a54c6f647f3851d1e6ca4a9b8b8c369f4c63df443530217744c81d8dacc2710e6ef85017ec4f44f8aaeb66d05beed35cc33cb60b06c9d92ff78d97950fbbcc9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a8df0f110418a596b0afbc0ab5a0af3c5d84fca9a738a2fb0df0c6c1e2ad972f4c5daf16201cba5ad480d062795cdacc406213c44ddb4dbbfadfb5bbbc853e"} 05:50:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:41 INFO - Copying logs to upload dir... 05:50:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.671599 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-27 05:50:41.359816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:50:41.363166) ========= 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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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/9e6181bf4bf1aaf749e3177562d43941ab42d6261719e9c573918f701a33a84126b1ca7e3b01003f1baf3689ac8649ed6535bc19d17247ccf21885315d1f97be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7de332fe1166f09c02db4124e86bca60863496ea1e0c164c6fe62f5a1e5f56743dfc985b667960539435ab07e49ed51c586ec8af8ff012cf2242653a6fabdfac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a54c6f647f3851d1e6ca4a9b8b8c369f4c63df443530217744c81d8dacc2710e6ef85017ec4f44f8aaeb66d05beed35cc33cb60b06c9d92ff78d97950fbbcc9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a8df0f110418a596b0afbc0ab5a0af3c5d84fca9a738a2fb0df0c6c1e2ad972f4c5daf16201cba5ad480d062795cdacc406213c44ddb4dbbfadfb5bbbc853e"} build_url:https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/OmRqtK9pSYG9sHTxymn2Zg/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/9e6181bf4bf1aaf749e3177562d43941ab42d6261719e9c573918f701a33a84126b1ca7e3b01003f1baf3689ac8649ed6535bc19d17247ccf21885315d1f97be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7de332fe1166f09c02db4124e86bca60863496ea1e0c164c6fe62f5a1e5f56743dfc985b667960539435ab07e49ed51c586ec8af8ff012cf2242653a6fabdfac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a54c6f647f3851d1e6ca4a9b8b8c369f4c63df443530217744c81d8dacc2710e6ef85017ec4f44f8aaeb66d05beed35cc33cb60b06c9d92ff78d97950fbbcc9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a8df0f110418a596b0afbc0ab5a0af3c5d84fca9a738a2fb0df0c6c1e2ad972f4c5daf16201cba5ad480d062795cdacc406213c44ddb4dbbfadfb5bbbc853e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:50:41.402089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:50:41.402418) ========= 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.LPBqJ8pf1W/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.W7KlAsAlTW/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005411 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:50:41.451580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:50:41.451889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:50:41.452233) ========= ========= Total master_lag: 0.19 =========