builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0136 starttime: 1481778445.11 results: success (0) buildid: 20161214193959 builduid: 2432dd1c87a34017abae759cf0bbc683 revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.114261) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.114764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.115094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.140449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.140842) ========= 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.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-14 21:07:25-- 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% 8.40M=0.001s 2016-12-14 21:07:25 (8.40 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.300946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.301326) ========= 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.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.020520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:25.349795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-12-14 21:07:25.350192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-14 21:07:25,427 truncating revision to first 12 chars 2016-12-14 21:07:25,427 Setting DEBUG logging. 2016-12-14 21:07:25,427 attempt 1/10 2016-12-14 21:07:25,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7652a58efa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 21:07:27,522 unpacking tar archive at: mozilla-central-7652a58efa46/testing/mozharness/ program finished with exit code 0 elapsedTime=2.354204 ========= master_lag: 3.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-12-14 21:07:31.492267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:31.492625) ========= script_repo_revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:31.493086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:31.493360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 21:07:31.516128) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-14 21:07:31.516582) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:07:31 INFO - MultiFileLogger online at 20161214 21:07:31 in /builds/slave/test 21:07:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:07:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:07:31 INFO - {'append_to_log': False, 21:07:31 INFO - 'base_work_dir': '/builds/slave/test', 21:07:31 INFO - 'blob_upload_branch': 'Firefox', 21:07:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:07:31 INFO - 'branch': 'Firefox', 21:07:31 INFO - 'buildbot_json_path': 'buildprops.json', 21:07:31 INFO - 'config_files': ('talos/mac_config.py',), 21:07:31 INFO - 'default_actions': ('clobber', 21:07:31 INFO - 'read-buildbot-config', 21:07:31 INFO - 'download-and-extract', 21:07:31 INFO - 'populate-webroot', 21:07:31 INFO - 'create-virtualenv', 21:07:31 INFO - 'install', 21:07:31 INFO - 'run-tests'), 21:07:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:07:31 INFO - 'download_minidump_stackwalk': True, 21:07:31 INFO - 'download_symbols': 'ondemand', 21:07:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:07:31 INFO - 'tooltool.py': '/tools/tooltool.py', 21:07:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:07:31 INFO - '/tools/misc-python/virtualenv.py')}, 21:07:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:07:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:07:31 INFO - 'installer_path': 'installer.exe', 21:07:31 INFO - 'log_level': 'info', 21:07:31 INFO - 'log_name': 'talos', 21:07:31 INFO - 'log_to_console': True, 21:07:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:07:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:07:31 INFO - 'opt_config_files': (), 21:07:31 INFO - 'pip_index': False, 21:07:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:07:31 INFO - 'cmd': ('bash', 21:07:31 INFO - '-c', 21:07:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:07:31 INFO - 'enabled': True, 21:07:31 INFO - 'halt_on_failure': False, 21:07:31 INFO - 'name': 'check_screen_resolution'},), 21:07:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:07:31 INFO - 'cmd': ('bash', 21:07:31 INFO - '-c', 21:07:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:07:31 INFO - 'enabled': True, 21:07:31 INFO - 'halt_on_failure': False, 21:07:31 INFO - 'name': 'check_screen_resolution'},), 21:07:31 INFO - 'run_cmd_checks_enabled': True, 21:07:31 INFO - 'sps_profile': False, 21:07:31 INFO - 'sps_profile_interval': 0, 21:07:31 INFO - 'suite': 'dromaeojs', 21:07:31 INFO - 'system_bits': '32', 21:07:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:07:31 INFO - 'title': 't-yosemite-r7-0136', 21:07:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:07:31 INFO - 'use_talos_json': True, 21:07:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:07:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:07:31 INFO - 'work_dir': 'build'} 21:07:31 INFO - [mozharness: 2016-12-15 05:07:31.721492Z] Running clobber step. 21:07:31 INFO - Running pre-action listener: _resource_record_pre_action 21:07:31 INFO - Running main action method: clobber 21:07:31 INFO - rmtree: /builds/slave/test/build 21:07:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:07:31 INFO - Running post-action listener: _resource_record_post_action 21:07:31 INFO - [mozharness: 2016-12-15 05:07:31.916923Z] Finished clobber step (success) 21:07:31 INFO - [mozharness: 2016-12-15 05:07:31.917086Z] Running read-buildbot-config step. 21:07:31 INFO - Running pre-action listener: _resource_record_pre_action 21:07:31 INFO - Running main action method: read_buildbot_config 21:07:31 INFO - Using buildbot properties: 21:07:31 INFO - { 21:07:31 INFO - "project": "", 21:07:31 INFO - "product": "firefox", 21:07:31 INFO - "script_repo_revision": "production", 21:07:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:07:31 INFO - "repository": "", 21:07:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:07:31 INFO - "buildid": "20161214193959", 21:07:31 INFO - "pgo_build": "False", 21:07:31 INFO - "basedir": "/builds/slave/test", 21:07:31 INFO - "buildnumber": 10, 21:07:31 INFO - "slavename": "t-yosemite-r7-0136", 21:07:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:07:31 INFO - "platform": "yosemite_r7", 21:07:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:07:31 INFO - "branch": "mozilla-central", 21:07:31 INFO - "repo_path": "mozilla-central", 21:07:31 INFO - "revision": "7652a58efa46f1c57c94bba26efc5d53b6184e83", 21:07:31 INFO - "stage_platform": "macosx64", 21:07:31 INFO - "builduid": "2432dd1c87a34017abae759cf0bbc683", 21:07:31 INFO - "slavebuilddir": "test" 21:07:31 INFO - } 21:07:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:07:31 INFO - Running post-action listener: _resource_record_post_action 21:07:31 INFO - [mozharness: 2016-12-15 05:07:31.920594Z] Finished read-buildbot-config step (success) 21:07:31 INFO - [mozharness: 2016-12-15 05:07:31.920746Z] Running download-and-extract step. 21:07:31 INFO - Running pre-action listener: _resource_record_pre_action 21:07:31 INFO - Running main action method: download_and_extract 21:07:31 INFO - mkdir: /builds/slave/test/build/tests 21:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:31 INFO - trying https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:07:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:07:33 INFO - Downloaded 1199 bytes. 21:07:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:07:33 INFO - Using the following test package requirements: 21:07:33 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:07:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:07:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:07:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'jsshell-mac.zip'], 21:07:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:07:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:07:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:07:33 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:07:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:07:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:07:33 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:07:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:07:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:07:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:07:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:07:34 INFO - Expected file size: 16276149 21:07:34 INFO - Obtained file size: 16276149 21:07:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:07:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:07:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:07:40 INFO - Fetch https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:07:41 INFO - Expected file size: 16276149 21:07:41 INFO - Obtained file size: 16276149 21:07:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:07:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:07:48 INFO - Fetch https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:07:49 INFO - Expected file size: 14409734 21:07:49 INFO - Obtained file size: 14409734 21:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:49 INFO - trying https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:07:49 INFO - Downloading https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:07:51 INFO - Downloaded 69666995 bytes. 21:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:07:51 INFO - mkdir: /builds/slave/test/properties 21:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:07:51 INFO - Writing to file /builds/slave/test/properties/build_url 21:07:51 INFO - Contents: 21:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:07:52 INFO - Running post-action listener: _resource_record_post_action 21:07:52 INFO - Running post-action listener: set_extra_try_arguments 21:07:52 INFO - [mozharness: 2016-12-15 05:07:52.353126Z] Finished download-and-extract step (success) 21:07:52 INFO - [mozharness: 2016-12-15 05:07:52.353241Z] Running populate-webroot step. 21:07:52 INFO - Running pre-action listener: _resource_record_pre_action 21:07:52 INFO - Running main action method: populate_webroot 21:07:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:07:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:07:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:07:52 INFO - '--tppagecycles', 21:07:52 INFO - '7'], 21:07:52 INFO - 'tests': ['tsvgm']}}, 21:07:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:07:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:07:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:07:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:07:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['damp', 'tps']}, 21:07:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'tests': ['damp', 'tps']}, 21:07:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['dromaeo_dom']}, 21:07:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:07:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['basic_compositor_video']}, 21:07:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:07:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'other-e10s': {'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['a11yr', 21:07:52 INFO - 'ts_paint', 21:07:52 INFO - 'tpaint', 21:07:52 INFO - 'sessionrestore', 21:07:52 INFO - 'sessionrestore_no_auto_restore', 21:07:52 INFO - 'tabpaint']}, 21:07:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['tsvgx', 21:07:52 INFO - 'tsvgr_opacity', 21:07:52 INFO - 'tart', 21:07:52 INFO - 'tscrollx', 21:07:52 INFO - 'cart', 21:07:52 INFO - 'tsvg_static']}, 21:07:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:07:52 INFO - 'tsvgr_opacity', 21:07:52 INFO - 'tart', 21:07:52 INFO - 'tscrollx', 21:07:52 INFO - 'cart', 21:07:52 INFO - 'tsvg_static']}, 21:07:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'talos_options': ['--disable-e10s'], 21:07:52 INFO - 'tests': ['tp5o']}, 21:07:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:07:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'talos_options': ['--disable-e10s', 21:07:52 INFO - '--xperf_path', 21:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:52 INFO - 'tests': ['tp5n']}, 21:07:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:07:52 INFO - 'talos_options': ['--xperf_path', 21:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:52 INFO - 'tests': ['tp5n']}}, 21:07:52 INFO - 'talos.zip': {'path': '', 21:07:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:07:52 INFO - Running post-action listener: _resource_record_post_action 21:07:52 INFO - [mozharness: 2016-12-15 05:07:52.371615Z] Finished populate-webroot step (success) 21:07:52 INFO - [mozharness: 2016-12-15 05:07:52.371709Z] Running create-virtualenv step. 21:07:52 INFO - Running pre-action listener: _resource_record_pre_action 21:07:52 INFO - Running main action method: create_virtualenv 21:07:52 INFO - Creating virtualenv /builds/slave/test/build/venv 21:07:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:07:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:07:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:07:52 INFO - Using real prefix '/tools/python27' 21:07:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:07:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:07:56 INFO - Installing pip.................done. 21:07:56 INFO - Return code: 0 21:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:07:56 INFO - Reading from file tmpfile_stdout 21:07:56 INFO - Output received: 21:07:56 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) 21:07:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:07:56 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')]} 21:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:56 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')]} 21:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:56 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:07:56 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 21:07:56 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 21:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:56 INFO - 'HOME': '/Users/cltbld', 21:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:56 INFO - 'LOGNAME': 'cltbld', 21:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:56 INFO - 'MOZ_NO_REMOTE': '1', 21:07:56 INFO - 'NO_EM_RESTART': '1', 21:07:56 INFO - 'PAGER': '/bin/cat', 21:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:56 INFO - 'PWD': '/builds/slave/test', 21:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:56 INFO - 'SHELL': '/bin/bash', 21:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:07:56 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:56 INFO - 'USER': 'cltbld', 21:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:56 INFO - 'XPC_FLAGS': '0x0', 21:07:56 INFO - 'XPC_SERVICE_NAME': '0', 21:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:56 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 21:07:56 INFO - Cleaning up... 21:07:56 INFO - Return code: 0 21:07:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:07:56 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')]} 21:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:56 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')]} 21:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:56 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:07:56 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 21:07:56 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 21:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:56 INFO - 'HOME': '/Users/cltbld', 21:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:56 INFO - 'LOGNAME': 'cltbld', 21:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:56 INFO - 'MOZ_NO_REMOTE': '1', 21:07:56 INFO - 'NO_EM_RESTART': '1', 21:07:56 INFO - 'PAGER': '/bin/cat', 21:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:56 INFO - 'PWD': '/builds/slave/test', 21:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:56 INFO - 'SHELL': '/bin/bash', 21:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:07:56 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:56 INFO - 'USER': 'cltbld', 21:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:56 INFO - 'XPC_FLAGS': '0x0', 21:07:56 INFO - 'XPC_SERVICE_NAME': '0', 21:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:56 INFO - Downloading/unpacking psutil>=3.1.1 21:07:56 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 21:07:56 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 21:07:56 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 21:07:56 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 21:07:56 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 21:07:56 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 21:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:00 INFO - Installing collected packages: psutil 21:08:00 INFO - Running setup.py install for psutil 21:08:00 INFO - building 'psutil._psutil_osx' extension 21:08:00 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 21:08:00 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 21:08:00 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 21:08:00 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 21:08:00 INFO - building 'psutil._psutil_posix' extension 21:08:00 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 21:08:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:08:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:08:00 INFO - ^ 21:08:01 INFO - 1 warning generated. 21:08:01 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 21:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:01 INFO - Successfully installed psutil 21:08:01 INFO - Cleaning up... 21:08:01 INFO - Return code: 0 21:08:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:08:01 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')]} 21:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:01 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')]} 21:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:01 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:01 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 21:08:01 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 21:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:01 INFO - 'HOME': '/Users/cltbld', 21:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:01 INFO - 'LOGNAME': 'cltbld', 21:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:01 INFO - 'MOZ_NO_REMOTE': '1', 21:08:01 INFO - 'NO_EM_RESTART': '1', 21:08:01 INFO - 'PAGER': '/bin/cat', 21:08:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:01 INFO - 'PWD': '/builds/slave/test', 21:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:01 INFO - 'SHELL': '/bin/bash', 21:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:01 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:01 INFO - 'USER': 'cltbld', 21:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:01 INFO - 'XPC_FLAGS': '0x0', 21:08:01 INFO - 'XPC_SERVICE_NAME': '0', 21:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:08:01 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 21:08:01 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 21:08:01 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 21:08:01 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 21:08:01 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 21:08:01 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 21:08:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:08:04 INFO - Installing collected packages: mozsystemmonitor 21:08:04 INFO - Running setup.py install for mozsystemmonitor 21:08:04 INFO - Successfully installed mozsystemmonitor 21:08:04 INFO - Cleaning up... 21:08:04 INFO - Return code: 0 21:08:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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', '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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:08: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 jsonschema==2.5.1 21:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:04 INFO - 'HOME': '/Users/cltbld', 21:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:04 INFO - 'LOGNAME': 'cltbld', 21:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:04 INFO - 'MOZ_NO_REMOTE': '1', 21:08:04 INFO - 'NO_EM_RESTART': '1', 21:08:04 INFO - 'PAGER': '/bin/cat', 21:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:04 INFO - 'PWD': '/builds/slave/test', 21:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:04 INFO - 'SHELL': '/bin/bash', 21:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:04 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:04 INFO - 'USER': 'cltbld', 21:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:04 INFO - 'XPC_FLAGS': '0x0', 21:08:04 INFO - 'XPC_SERVICE_NAME': '0', 21:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:04 INFO - Downloading/unpacking jsonschema==2.5.1 21:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:08:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:08:07 INFO - warning: no files found matching '*.txt' 21:08:07 INFO - no previously-included directories found matching 'build' 21:08:07 INFO - no previously-included directories found matching 'dist' 21:08:07 INFO - no previously-included directories found matching '.git*' 21:08:07 INFO - Installing collected packages: jsonschema, functools32 21:08:07 INFO - Running setup.py install for functools32 21:08:07 INFO - warning: no files found matching '*.txt' 21:08:07 INFO - no previously-included directories found matching 'build' 21:08:07 INFO - no previously-included directories found matching 'dist' 21:08:07 INFO - no previously-included directories found matching '.git*' 21:08:07 INFO - Successfully installed jsonschema functools32 21:08:07 INFO - Cleaning up... 21:08:07 INFO - Return code: 0 21:08:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:07 INFO - 'HOME': '/Users/cltbld', 21:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:07 INFO - 'LOGNAME': 'cltbld', 21:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:07 INFO - 'MOZ_NO_REMOTE': '1', 21:08:07 INFO - 'NO_EM_RESTART': '1', 21:08:07 INFO - 'PAGER': '/bin/cat', 21:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:07 INFO - 'PWD': '/builds/slave/test', 21:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:07 INFO - 'SHELL': '/bin/bash', 21:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:07 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:07 INFO - 'USER': 'cltbld', 21:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:07 INFO - 'XPC_FLAGS': '0x0', 21:08:07 INFO - 'XPC_SERVICE_NAME': '0', 21:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:08:08 INFO - Cleaning up... 21:08:08 INFO - Return code: 0 21:08:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:08 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:08 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 21:08:08 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 21:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:08 INFO - 'HOME': '/Users/cltbld', 21:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:08 INFO - 'LOGNAME': 'cltbld', 21:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:08 INFO - 'MOZ_NO_REMOTE': '1', 21:08:08 INFO - 'NO_EM_RESTART': '1', 21:08:08 INFO - 'PAGER': '/bin/cat', 21:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:08 INFO - 'PWD': '/builds/slave/test', 21:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:08 INFO - 'SHELL': '/bin/bash', 21:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:08 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:08 INFO - 'USER': 'cltbld', 21:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:08 INFO - 'XPC_FLAGS': '0x0', 21:08:08 INFO - 'XPC_SERVICE_NAME': '0', 21:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:08 INFO - Downloading/unpacking blobuploader==1.2.4 21:08:08 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 21:08:08 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 21:08:08 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 21:08:08 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 21:08:08 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 21:08:08 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 21:08:10 INFO - Downloading blobuploader-1.2.4.tar.gz 21:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:08:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:08:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:12 INFO - Downloading docopt-0.6.1.tar.gz 21:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:08:12 INFO - Installing collected packages: blobuploader, requests, docopt 21:08:12 INFO - Running setup.py install for blobuploader 21:08:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:08:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:08:12 INFO - Running setup.py install for requests 21:08:12 INFO - Running setup.py install for docopt 21:08:13 INFO - Successfully installed blobuploader requests docopt 21:08:13 INFO - Cleaning up... 21:08:13 INFO - Return code: 0 21:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:13 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:13 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 21:08:13 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 21:08:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:13 INFO - 'HOME': '/Users/cltbld', 21:08:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:13 INFO - 'LOGNAME': 'cltbld', 21:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:13 INFO - 'MOZ_NO_REMOTE': '1', 21:08:13 INFO - 'NO_EM_RESTART': '1', 21:08:13 INFO - 'PAGER': '/bin/cat', 21:08:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:13 INFO - 'PWD': '/builds/slave/test', 21:08:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:13 INFO - 'SHELL': '/bin/bash', 21:08:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:13 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:13 INFO - 'USER': 'cltbld', 21:08:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:13 INFO - 'XPC_FLAGS': '0x0', 21:08:13 INFO - 'XPC_SERVICE_NAME': '0', 21:08:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-CElYUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-lWhUDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-fWOnS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wzdAZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sWiFfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EJC_pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-KE6l13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-okncTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Rc_jNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wmdBOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4ESKS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-WU4mTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-z_ozDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7V8OrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-c2aD_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-r47UuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:15 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-52UDuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:08:15 INFO - Running setup.py install for manifestparser 21:08:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:08:15 INFO - Running setup.py install for mozcrash 21:08:15 INFO - Running setup.py install for mozdebug 21:08:15 INFO - Running setup.py install for mozdevice 21:08:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:08:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:08:15 INFO - Running setup.py install for mozfile 21:08:15 INFO - Running setup.py install for mozhttpd 21:08:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Running setup.py install for mozinfo 21:08:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Running setup.py install for mozInstall 21:08:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Running setup.py install for mozleak 21:08:16 INFO - Running setup.py install for mozlog 21:08:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Running setup.py install for moznetwork 21:08:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:08:16 INFO - Running setup.py install for mozprocess 21:08:16 INFO - Running setup.py install for mozprofile 21:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:08:17 INFO - Running setup.py install for mozrunner 21:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:08:17 INFO - Running setup.py install for mozscreenshot 21:08:17 INFO - Running setup.py install for moztest 21:08:17 INFO - Running setup.py install for mozversion 21:08:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:08:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:08:17 INFO - Cleaning up... 21:08:17 INFO - Return code: 0 21:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:18 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:18 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 21:08:18 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 21:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:18 INFO - 'HOME': '/Users/cltbld', 21:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:18 INFO - 'LOGNAME': 'cltbld', 21:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:18 INFO - 'MOZ_NO_REMOTE': '1', 21:08:18 INFO - 'NO_EM_RESTART': '1', 21:08:18 INFO - 'PAGER': '/bin/cat', 21:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:18 INFO - 'PWD': '/builds/slave/test', 21:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:18 INFO - 'SHELL': '/bin/bash', 21:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:18 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:18 INFO - 'USER': 'cltbld', 21:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:18 INFO - 'XPC_FLAGS': '0x0', 21:08:18 INFO - 'XPC_SERVICE_NAME': '0', 21:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4b8jxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:18 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)) 21:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vq3vNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:18 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)) 21:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Ht7kGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:18 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)) 21:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-57Dz8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-QgSG6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-i8zzi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7soXpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-datAxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-S7UICj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wsEUUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zbqaRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:19 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)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-DWy6O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-WSYjkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:20 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)) 21:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:20 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-hYG3HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:20 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)) 21:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:20 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Lt1kPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:20 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)) 21:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:20 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-3GcZBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:20 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-atEHAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:20 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)) 21:08:20 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)) 21:08:20 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)) 21:08:20 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)) 21:08:20 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)) 21:08:20 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)) 21:08:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:23 INFO - Downloading blessings-1.6.tar.gz 21:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:08:23 INFO - Installing collected packages: blessings 21:08:23 INFO - Running setup.py install for blessings 21:08:23 INFO - Successfully installed blessings 21:08:23 INFO - Cleaning up... 21:08:23 INFO - Return code: 0 21:08:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:24 INFO - Reading from file tmpfile_stdout 21:08:24 INFO - Current package versions: 21:08:24 INFO - blessings == 1.6 21:08:24 INFO - blobuploader == 1.2.4 21:08:24 INFO - docopt == 0.6.1 21:08:24 INFO - functools32 == 3.2.3-2 21:08:24 INFO - jsonschema == 2.5.1 21:08:24 INFO - manifestparser == 1.1 21:08:24 INFO - mozInstall == 1.12 21:08:24 INFO - mozcrash == 1.0 21:08:24 INFO - mozdebug == 0.1 21:08:24 INFO - mozdevice == 0.49 21:08:24 INFO - mozfile == 1.2 21:08:24 INFO - mozhttpd == 0.7 21:08:24 INFO - mozinfo == 0.9 21:08:24 INFO - mozleak == 0.1 21:08:24 INFO - mozlog == 3.4 21:08:24 INFO - moznetwork == 0.27 21:08:24 INFO - mozprocess == 0.23 21:08:24 INFO - mozprofile == 0.28 21:08:24 INFO - mozrunner == 6.13 21:08:24 INFO - mozscreenshot == 0.1 21:08:24 INFO - mozsystemmonitor == 0.3 21:08:24 INFO - moztest == 0.7 21:08:24 INFO - mozversion == 1.4 21:08:24 INFO - psutil == 3.1.1 21:08:24 INFO - requests == 1.2.3 21:08:24 INFO - wsgiref == 0.1.2 21:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:24 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')]} 21:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:24 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')]} 21:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:24 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 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:24 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 21:08:24 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 21:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:24 INFO - 'HOME': '/Users/cltbld', 21:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:24 INFO - 'LOGNAME': 'cltbld', 21:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:24 INFO - 'MOZ_NO_REMOTE': '1', 21:08:24 INFO - 'NO_EM_RESTART': '1', 21:08:24 INFO - 'PAGER': '/bin/cat', 21:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:24 INFO - 'PWD': '/builds/slave/test', 21:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:24 INFO - 'SHELL': '/bin/bash', 21:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:24 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:24 INFO - 'USER': 'cltbld', 21:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:24 INFO - 'XPC_FLAGS': '0x0', 21:08:24 INFO - 'XPC_SERVICE_NAME': '0', 21:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 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)) 21:08:24 INFO - Cleaning up... 21:08:24 INFO - Return code: 0 21:08:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:08:24 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')]} 21:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:24 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')]} 21:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048ad3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb2bd73830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, '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.tLj0j259ku/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.YdyfEZDGJr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 21:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:24 INFO - 'HOME': '/Users/cltbld', 21:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:24 INFO - 'LOGNAME': 'cltbld', 21:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:24 INFO - 'MOZ_NO_REMOTE': '1', 21:08:24 INFO - 'NO_EM_RESTART': '1', 21:08:24 INFO - 'PAGER': '/bin/cat', 21:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:24 INFO - 'PWD': '/builds/slave/test', 21:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:24 INFO - 'SHELL': '/bin/bash', 21:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:24 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:24 INFO - 'USER': 'cltbld', 21:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:24 INFO - 'XPC_FLAGS': '0x0', 21:08:24 INFO - 'XPC_SERVICE_NAME': '0', 21:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:08:24 INFO - Cleaning up... 21:08:24 INFO - Return code: 0 21:08:24 INFO - Running post-action listener: _resource_record_post_action 21:08:24 INFO - Running post-action listener: _start_resource_monitoring 21:08:24 INFO - Starting resource monitoring. 21:08:24 INFO - [mozharness: 2016-12-15 05:08:24.710870Z] Finished create-virtualenv step (success) 21:08:24 INFO - [mozharness: 2016-12-15 05:08:24.711909Z] Running install step. 21:08:24 INFO - Running pre-action listener: _resource_record_pre_action 21:08:24 INFO - Running main action method: install 21:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:24 INFO - Reading from file tmpfile_stdout 21:08:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:08:25 INFO - Reading from file tmpfile_stdout 21:08:25 INFO - Output received: 21:08:25 INFO - Usage: mozinstall [options] installer 21:08:25 INFO - Options: 21:08:25 INFO - -h, --help show this help message and exit 21:08:25 INFO - -d DEST, --destination=DEST 21:08:25 INFO - Directory to install application into. [default: 21:08:25 INFO - "/builds/slave/test"] 21:08:25 INFO - --app=APP Application being installed. [default: firefox] 21:08:25 INFO - mkdir: /builds/slave/test/build/application 21:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:08:47 INFO - Reading from file tmpfile_stdout 21:08:47 INFO - Output received: 21:08:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:08:47 INFO - Running post-action listener: _resource_record_post_action 21:08:47 INFO - [mozharness: 2016-12-15 05:08:47.332765Z] Finished install step (success) 21:08:47 INFO - [mozharness: 2016-12-15 05:08:47.332951Z] Running run-tests step. 21:08:47 INFO - Running pre-action listener: _resource_record_pre_action 21:08:47 INFO - Running main action method: run_tests 21:08:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:08:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:08:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:08:47 INFO - 2016-12-14 21:08:47.346 screenresolution[1882:8926] starting screenresolution argv=screenresolution get 21:08:47 INFO - 2016-12-14 21:08:47.349 screenresolution[1882:8926] Display 0: 1600x1200x32@60 21:08:47 INFO - 2016-12-14 21:08:47.355 screenresolution[1883:8928] starting screenresolution argv=screenresolution list 21:08:47 INFO - Available Modes on Display 0 21:08:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:08:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:08:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:08:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:08:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:08:47 INFO - Intel Iris: 21:08:47 INFO - Chipset Model: Intel Iris 21:08:47 INFO - Type: GPU 21:08:47 INFO - Bus: Built-In 21:08:47 INFO - VRAM (Dynamic, Max): 1536 MB 21:08:47 INFO - Vendor: Intel (0x8086) 21:08:47 INFO - Device ID: 0x0a2e 21:08:47 INFO - Revision ID: 0x0009 21:08:47 INFO - Displays: 21:08:47 INFO - Display: 21:08:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:08:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:08:47 INFO - Display Serial Number: 1600x1200 60 21:08:47 INFO - Main Display: Yes 21:08:47 INFO - Mirror: Off 21:08:47 INFO - Online: Yes 21:08:47 INFO - Rotation: Supported 21:08:47 INFO - Return code: 0 21:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:08:47 INFO - Python 2.7.3 21:08:47 INFO - Return code: 0 21:08:47 INFO - grabbing minidump binary from tooltool 21:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2d30>, '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 0x104529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046bab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:08:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:08:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:08:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:08:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:08:47 INFO - Return code: 0 21:08:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:08:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:08:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:08:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:08:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 21:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 21:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLj0j259ku/Render', 21:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:47 INFO - 'HOME': '/Users/cltbld', 21:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:47 INFO - 'LOGNAME': 'cltbld', 21:08:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:08:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:47 INFO - 'MOZ_NO_REMOTE': '1', 21:08:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:08:47 INFO - 'NO_EM_RESTART': '1', 21:08:47 INFO - 'PAGER': '/bin/cat', 21:08:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:47 INFO - 'PWD': '/builds/slave/test', 21:08:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:47 INFO - 'SHELL': '/bin/bash', 21:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdyfEZDGJr/Listeners', 21:08:47 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 21:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:47 INFO - 'USER': 'cltbld', 21:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:47 INFO - 'XPC_FLAGS': '0x0', 21:08:47 INFO - 'XPC_SERVICE_NAME': '0', 21:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 21:08:47 INFO - mozversion application_buildid: 20161214193959 21:08:47 INFO - mozversion application_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 21:08:47 INFO - mozversion application_display_name: Nightly 21:08:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:08:47 INFO - mozversion application_name: Firefox 21:08:47 INFO - mozversion application_remotingname: firefox 21:08:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:08:47 INFO - mozversion application_vendor: Mozilla 21:08:47 INFO - mozversion application_version: 53.0a1 21:08:47 INFO - mozversion platform_buildid: 20161214193959 21:08:47 INFO - mozversion platform_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 21:08:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:08:47 INFO - mozversion platform_version: 53.0a1 21:08:47 INFO - using testdate: 1481778527 21:08:47 INFO - actual date: 1481778527 21:08:47 INFO - starting webserver on 'localhost:49377' 21:08:47 INFO - SUITE-START | Running 2 tests 21:08:47 INFO - TEST-START | dromaeo_css 21:08:47 INFO - operating with platform_type : mac_ 21:08:47 INFO - Initialising browser for dromaeo_css test... 21:08:47 INFO - TEST-INFO | started process 1893 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpOsCoE3/profile http://localhost:49377/getInfo.html) 21:08:50 INFO - PROCESS | 1893 | __metrics Screen width/height:1600/1200 21:08:50 INFO - PROCESS | 1893 | colorDepth:24 21:08:50 INFO - PROCESS | 1893 | Browser inner width/height: 1024/689 21:08:50 INFO - PROCESS | 1893 | __metrics 21:08:50 INFO - PROCESS | 1893 | 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" 21:08:50 INFO - PROCESS | 1893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:08:50 INFO - TEST-INFO | 1893: exit 0 21:08:50 INFO - Browser initialized. 21:08:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:08:50 INFO - TEST-INFO | started process 1895 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpOsCoE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:09:02 INFO - PROCESS | 1895 | RSS: Main: 237170688 21:09:02 INFO - PROCESS | 1895 | 21:09:53 INFO - PROCESS | 1895 | 1481778593905 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:12:07 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49377/tests/dromaeo/cssquery-ext.html) 21:12:09 INFO - PROCESS | 1895 | RSS: Main: 411791360 21:12:09 INFO - PROCESS | 1895 | 21:15:12 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-ext.html (next: http://localhost:49377/tests/dromaeo/cssquery-jquery.html) 21:15:12 INFO - PROCESS | 1895 | RSS: Main: 379523072 21:15:12 INFO - PROCESS | 1895 | 21:18:15 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49377/tests/dromaeo/cssquery-mootools.html) 21:18:15 INFO - PROCESS | 1895 | RSS: Main: 343937024 21:18:15 INFO - PROCESS | 1895 | 21:21:18 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49377/tests/dromaeo/cssquery-prototype.html) 21:21:19 INFO - PROCESS | 1895 | RSS: Main: 351621120 21:21:19 INFO - PROCESS | 1895 | 21:24:22 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49377/tests/dromaeo/cssquery-yui.html) 21:24:23 INFO - PROCESS | 1895 | RSS: Main: 341147648 21:24:23 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-yui.html (next: http://localhost:49377/tests/dromaeo/cssquery-dojo.html) 21:27:26 INFO - PROCESS | 1895 | RSS: Main: 411287552 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | __start_tp_report 21:27:26 INFO - PROCESS | 1895 | _x_x_mozilla_page_load 21:27:26 INFO - PROCESS | 1895 | _x_x_mozilla_page_load_details 21:27:26 INFO - PROCESS | 1895 | |i|pagename|runs| 21:27:26 INFO - PROCESS | 1895 | |0;dojo.html;3307.470804671252;3323.235655799165;3338.2822693120975;3365.6802603752667;3379.121428428608;5572.4148964358765;5644.830655080349;5646.6894320812335;5674.120511320752;5700.258966334376;5647.802326918549;5649.548036157108;5717.085266357383;5750.05124154514;5795.82612521624;5123.5388815006645;5151.948480515203;5161.664491808039;5175.792968281265;5193.818216362428;5148.382194136709;5255.527002569768;5261.210818377255;5271.525562699357;5279.102552566073;5229.921551176735;5239.79040838366;5263.921041184385;5268.420473747885;5318.30861987941;5090.669106508102;5112.003159383921;5133.768980395891;5142.640015198937;5178.818741344073;5123.718195499246;5144.511271429208;5171.0692075426405;5204.635675502716;5207.895842083137;5568.276124103881;5616.073347897592;5625.043742563733;5630.014747419226;5729.742161602696;6066.939330606681;6113.449789518964;6133.1413602095745;6187.969060154715;6195.535334849859;6116.7553297868035;6183.628982261033;6214.937850621481;6216.129741836146;6216.689165541705;5788.768449261982;5791.9710401448565;5798.797042103506;5808.535317174658;5832.1834943108;6180.47465965398;6318.115463835067;6319.178506794179;6319.33646967071;6325.114483972247;4917.803287868445;5892.587518873637;5928.4960778334325;5998.400159983967;6008.939910600838;6127.80043271483;6128.747575574832;6129.847850912788;6131.0096813291075;6146.692665366714;6027.78902738402;6076.969615151896;6082.148499210114;6089.330173680892;6105.8473538161015;5016.322796422509;6102.420270074336;6108.664023478751;6120.479759220427;6129.96935015331;4414.830070031444;4632.976835115803;4856.854294371175;4861.246506791383;4862.659613826998;4330.17726631939;4334.263175260214;4334.718243314174;4384.210842048398;4432.468103827561;5612.7754889803955;5627.155926611041;5651.039323315046;5677.545796336283;5692.715364231854;6204.348543402968;6229.345918678564;6238.438540531283;6249.406306400884;6255.624662520263;5519.2824932758485;5596.076647353222;5670.036093864053;5673.6028478006965;5687.829365119053;4583.770811459413;5356.357237131491;5384.219288203267;5391.892162156735;5452.863678408072;6276.6547839868335;6280;6314.842128946813;6315.052742088816;6318.368163183645;6252.718627661675;6256.968715156577;6265.937340626535;6279.1209230708655;6289.276733175743;6213.844653883689;6243;6252.562320637512;6289.654069026247;6295.087212354275;6146.401935496892;6181.412765787243;6183.752649893954;6197.163382943425;6205.565610407228;6203.596766210182;6230.376962303914;6260.655663938527;6261.655608941552;6274.058891166362;5918.674472904032;5945.108233764797;5952.375000625046;6048.788292409745;6089.147519347206;6021.54838387114;6047.123167140828;6056.9697151513965;6085.391460853879;6136.938630613637;5909.379515151019;5912.852178695395;5922.585419020799;5928.3775203603;5930.288365396007;5825.563082768894;6012.158297838394;6033.0045542484995;6069.423404776539;6071.089336599545;4961.975190124026;5748.338941021836;5794.333651630117;5863.941360586339;5907 21:27:26 INFO - PROCESS | 1895 | |1;ext.html;456.36337309453313;481.4775968074639;493.5410068636167;494.71801073388184;496.63001064207174;31162.532562011587;34821.65178348216;37231.627683723156;38233.61766382339;39736.00659983498;41485.79257103718;41741.79129104358;41829.58170418295;41843;41859.58140418595;7023.859522809541;9340.15938565529;9546.379485333431;9555.044495550459;9558.426494410323;8560.529170895597;11151.553937842516;11422.371769552672;11435.313881167114;11602.941985290061;11306.491207895624;11337.319760814378;11352.716182095432;11392.829107563393;11411.54353825846;11269.098472122252;11352.48913798881;11363.715907102389;11364.204505684605;11367.261128026734;11264.380459074748;11355.261907976037;11355.43222838863;11356.545738170464;11361.43192840363;38757.41863872044;39054.21891562153;39117.60882391168;39161.60838391608;39205.80397098025;3267.9346413071844;3328.2012317043977;3476.704480119193;3541.734369922266;3673.8714145004797;26769.464610707677;27920;28325.291867703265;28514.429711405865;28547.714522854712;3078.5382192671054;3085.3829234153036;3246.5779448671756;3284.8850290239725;3290.0623322353013;393046;473109;477264;477795.6110219461;479041;50359.49640503621;50532;50692.49307506951;50704.746476267384;50779;57004;57119.71440142856;57147.42852571421;57232.42767572271;57237.71381143151;14613.488527901472;15153.090814551162;15166.924165379323;15177.013494122846;15186.316615752317;10604.787904241872;10824.188185885932;10832.512536935857;11638.76722465546;11755.000824929806;20152.89923550373;20203.797962020486;20244.696329555067;20568.897155514125;20608.969551522365;7200.315969982843;8218.383621228431;8275.917240827635;8346.4157508975;8387.790305242295;842.8735689646602;987.3680844259679;1006.8622456623968;1014.2139841622801;1049.8320268756963;29821.85089074541;29991.400171996436;30190.24524386864;30420.239494012825;30452;1067.2955849139687;1078.3795377233241;1095.8904109588977;1140.8573928258968;1155.5377848860523;14708.485203017843;15463.768043479356;15659.451919182773;15877.920610396874;15900.52298431049;665323;670743;672101;673019.9839008901;675603;47965.04069918652;58864.70567647134;58898;58903.41096589065;58932.410675892694;1361.761691703948;1401.4674423719125;1410.7531182043306;1410.9929450352683;1413.7879318102366;29188;29258.414831703674;29273.268168295963;29991.250218744706;30055;49244;49586.50413495963;49707.751461242464;49757.50242497674;49793.502064978886;473217;475911;477114;477625;478097;40267.597324026385;40508.39237411382;41610;41789.74630761082;41842.790786047095;44755.776221118685;45357.31964020476;45512.77243613761;45637;45697.77151114223;31141;37517.81241093777;37725.86822395332;37744;39316.410253846785;37102.44346334861;37496;38227;38466.615333846305;38620.420693689055;33818;36413.635863642085;36700.44949325709;36808;37121.25757484781;32647.510287346184;33955.49066763951;33989.66010339865;34098.659013409546;34230.65769342275;22234.221802236843;22252.554948901256;22949.88525057364;25104.62343064819;25188.748112519374 21:27:26 INFO - PROCESS | 1895 | |2;jquery.html;350.6423448082957;363.36229916496546;365.44269988267905;370.03974685690633;395.64392047157554;14519.927400362996;14791.926040369797;15620.453284135043;19483.220671173138;20076.69884951727;17874.553136171602;19525.21899124037;20095.899520502415;20206.888621125832;20331.695024574605;5554.1391084381885;5854.151148083525;5860.765569377241;5903.88192236155;5924.851878703045;5023.346964894558;5731.828045158631;5789.536837053026;5837.299524057098;5856.795012174574;5720.8283751487525;5792.884142317151;5798.971005144968;5811.0702287633985;5816.011278082715;5507.118860982244;5799.942000580004;5883.79406720767;5915.112733090028;5935.258092738408;4784.545468180518;5497.532709719679;5704.515116215127;5721.885562288731;5729.111987641881;13010.804837927439;13023.739525209443;13230.801537976939;13255.536056237985;13273.336333183302;2099.3387083068783;2135.4234356723755;2170.007117225171;2326.5230627721444;2717.8097533172686;9292.39599426042;9712.75718107046;9842.261830362751;9897.208223342115;10292.588296468133;1605.743081107029;1804.7744031996;1807.5842556212012;1862.8323450889486;1929.0836852495092;98692.50653746758;107215;108003;108212;111009.44495277472;8474.618642161118;10973.122150227962;11162.441877906234;11365;11524.193306468467;13728.45086196561;14162.716745665235;14185.574432767033;14221.715565688835;14266.714665706835;6564;8016.278534931767;8151.551664658382;8227.095019547845;8301.750947471464;7914.683412663429;7970.681172753025;7983.361331093614;8084.514929104273;8128.309093726981;3515.736319776027;3578.622230441299;4434.360635083092;4470.530594287618;4522.615577675934;1859.869809113349;1924.1341396371688;1927.3350694010544;1928.9517762056062;1933.337329896288;359.9310049154008;360.79795314623897;408.8936876412154;838.5681374092347;878.547548012774;11505.597304094317;11516.1362897783;11894.940525297317;11924.76150477003;11967.683554808964;405.27658130237387;413.23345194663466;417.2635298697801;420.55421253471417;426.6203079259462;10304.381737095799;11032.117430605533;11071.612493562687;11474.36890970988;11533.826992595117;418790.90604547394;423060;424434;492829;528118;125496;132611;133693;135828.64171358358;143118.5688143126;966.3960024984385;1001.1090129784643;1032.3031953431405;1032.9225308101772;1033.503918119307;16388.344466221217;17256.913715431845;18377.448676539727;18504.722429163303;19089.809101908802;50951;52945.70542945675;53242.20136697875;53807;55088.72455637696;74059.1485212874;76156.85764713422;76304.61847690726;78191.60904195442;79530.20469795229;7781.9610901945125;7853.56805375687;8002.399820013638;8050.87287779723;8205;11942.582009629621;12350.75298494007;12371.319577423328;12635.494580217057;12657.367131643565;10715.892841071489;10930.890691092987;10994.230403871972;11193.608223712132;11193.608223712132;10559.683209503728;10626;10658.573657053632;10810.35137891729;10855;10673.733156671145;10782.299150555189;11180.552777888794;11197.888021119685;11391.430428478378;6517.478601711757;7765.107012693613;7895.868115608869;7926.365890728844;8037.23646253605;9315.34792564514;9619.903800961902;9995.150412215044;10292.892456435351;10829.888171806737 21:27:26 INFO - PROCESS | 1895 | |3;mootools.html;1326.5423428917027;1354.790007548829;1466.4940595494554;1662.6591548732504;1874.5501079740857;7433.628318584069;7836.098848632409;8106.554139522324;8368;8384.538850363228;8268.214519620642;8350.665973361058;8356.874646880302;8368.0376756673;8371.372147088961;2027.2499175305084;2286.085565773687;2329.685492458522;2329.9981008166483;2332.8600283982933;2113.175861414042;2235.5864165129424;2333.9963815559304;2335.32275640065;2340.0171927790284;2254;2306.8731219782903;2309.145616122037;2322.96515552266;2324;2280.270313499681;2321.2339927823778;2322.953540929189;2325.2559181062065;2329.114936324186;2301.5742087713825;2306.3657494189065;2318.5594736999915;2344.2146880794953;2349.7180338359335;8196.959015204946;8240.299574536111;8260.793480162984;8278.461899976543;8293.875591866066;5056.82301119459;5220.216967454874;5225.503577160163;5247.449017853147;5251.501107394792;3364.6971772540346;3508.1405055761247;3602.2975519773654;3604.2431089471243;3611.1694310308512;1005.9849102263472;1054.177741361739;1076.43487169236;1090.2858627598935;1099.1371773158032;10561.788764224673;10801.621943232029;10803;10821.56713731442;10853.403062831541;4489.955100448954;4586.197415452282;4668.299755036772;4707.8587642370785;4730.385049943486;8632;8702.086280940537;8711.738647840575;8714.956425217833;8723.869141962876;5135.101357262539;5139.280500729901;5141.76862041209;5142.588592912558;5148.742562871917;3871;4275.935860962088;4722.079194557097;4760.976195119002;4826.903461930741;3068.4476794177262;3390.423627983249;3516.7889926604485;3576.195356044921;3696.796676182782;1074.4520294649628;1112.2103306652207;1147.9311241325547;1155.3299086529792;1156.5778490850946;716.6774951271949;895.5298468304193;901.2744740483843;902.120432578231;906.5693795447241;4381.78091095444;5225.425203227642;5517.889642207133;5765.048766953406;5833.416658334133;858.3176374782063;887.933404994628;902.5126431726925;913.6619450803246;975.7463059604412;2799.9860000699864;3642.925337025531;3730.291244663505;3928.155446578999;3978.5424676162033;7491.063617047869;9796.755081122887;9809.901900981042;9952.452615106238;9973.401595904124;8592.656293748305;9758.853617195748;9915.900840991499;9940.353876998117;9942.204623630092;6767.458603311723;7730.884036739453;7850.764477065697;7866.685332586632;7880.881786773203;4977.203647416396;5061.797528098835;5408.783023819609;5616.915746263891;5634.6337488063145;9136.588853501475;9172.266218702622;9221.815563688555;9251.121143491358;9322.813543729224;7909.881351779843;8830.381873268809;9418.717438476857;9474.763130921781;9519.857202141835;6956.513044086865;7291.927080729337;7306.671199796128;7307.890381644386;7319.487635865438;7197.712091516491;7431.29402706742;7476;7816.49192802466;7919.762407127565;7093.1488221413765;7126.857462850818;7137.464690148156;7214.494985351185;7353.080864891888;7014.964925175342;7058.11773528309;7068.151821781419;7083.7520686775715;7122.109736282965;6590.670466476753;6620.834479137868;6636.800895973129;6667.466602671678;6739.056532085414;4795.112904112751;4855;4865.391826021747;4874.707517548958;5029.572486338702;4064.9187016258916;4886.389201349832;4937.876553086202;4971.502849715;4991.825286114969 21:27:26 INFO - PROCESS | 1895 | |4;prototype.html;342.4230172159911;353.93098345822557;354.2525271676761;360.5655185501471;364.4260290043181;4506.887327816807;5151.2788209650635;5156.097682905486;5173.482651734829;5174.586033117346;5083.262926875601;5091.694498330103;5118.5905127589795;5133.486651334864;5160.896782064357;2903.12310052389;3708.4993525874065;3748.7375883688082;3845.9230815383676;3933.3903244996927;3935.724499285051;3964.958046606;3966.7223294369405;3992.321305378093;3997.6208208168136;3517.331706975679;3965.662918651918;3972.304846651839;3983.760974341534;4000.8599699010542;3085.938281234385;3342.4986252062263;3501.912452188703;3758.642928921748;4007.9599204007877;3428.777129486575;3428.971308607408;3506.4915587239707;3508.2632647144133;3546.308469848381;4189.853355132586;4307.944553584361;4448.488423831269;4897.681650692693;4933.358663373739;3531.6468353164737;4082.346824508094;4552.499225085238;4555.658325625592;4665.486796452387;4472;4552.839026048369;4607.571652787647;5161.767720452589;5328.387235467932;3153.2905096353365;3428.7428442866885;3442.3648766835804;3859.247446747885;3883.689304855605;4852.927206091911;4980.427250866161;5135.254013635382;5506.559475242051;5720.198137586647;3337.299167174872;3843.2889915365745;3957.604239576077;3969.325214713506;4000.959990400117;3463.2034632034774;3972.172800511797;3993.5806740292433;4017.397390391465;4029.5768944261017;4260.487526927958;4497.415336006298;4511.345854851028;4536.2762150383305;4564.863054108382;5159.17453207485;5322.962022405671;5375.704336261465;5378.650387724785;5421.972890135524;1108.9889101108886;1193.988060119405;1301.3493253373313;1303.7131830997166;1313.6978494946216;790.7864876483317;860.492309537376;900.5902314446911;926.4348747264163;933.2813733425224;4091.8926752722373;4595.448546174413;4654.5338218461075;4702.318163866289;4719.215662758988;4080.8571699990357;4464.330350447459;4513.571210735041;4837;5190.92213616796;4100.302948498763;4513.661475389359;4726.669133160714;4738.8341408050555;4740.478547359788;2233.8561967549963;2578.987105064463;2657.495075935566;2758.917232483029;2798.4263226038615;4796.56830885222;4883.389576302962;4993.852643363316;5327.200919861974;5540.418256083134;4548.840790572381;5267.947320526822;5392.487713667196;5413.83758487246;5436.755346009439;5696.23100881384;5702.173184888168;5766.625169364062;5783.681897495594;5806.303243610793;4647.628189744744;5205.687658740488;5425.186222066722;5554.250880655461;5573.495156307856;4286.828526858891;4591.376421482584;4784.521547845187;5427.213054107211;5502.669839809624;5015.699058056528;5222.582193424593;5251.975864706498;5263.6578622389425;5604.551635869202;3019.7131272529073;3046.7714921380543;3714.758540694846;3742.73800833939;3807.219519998449;4304.74171549708;4599.770011499345;5125.461826508163;5574.358948720949;5608.9158662619275;4618.953810461987;5090.909090909091;5372.543333816513;5389.272448219597;5508.504234618904;4552.362669226377;4620.537946205487;5168.664036837594;5460.426655201306;5470.5350045245;4755.595774359218;5317.415084340642;5325.467453254643;5330.560748597934;5341.75962081715;4687.945212327199;5044.486654003857;5336.412994570672;5383.389056307609;5401.432849550741;4455.554444555519;5288.5769138469595;5293.444188360167;5300.349825087456;5317.468253174807 21:27:26 INFO - PROCESS | 1895 | |5;yui.html;725.0031207090251;729.8613263479939;763.5151678684034;807.5760225881407;810.8540462716712;14791.704165916675;15814.76277855833;15823.9714418563;15850.60373490662;15899;14272.500462483815;14429.783553246709;14459.349329280181;14460.987730858844;14463.421463141489;676.796960911727;697.0868162706845;703.1456780012284;833.5540485840077;845.623697454633;836.1554829622065;837.857564214082;853.4665833853842;853.8335024670192;854.0647990450447;911.6626848066225;912.968046118386;913.7898283394824;914.4696076275777;917.3486824354716;702.8067281497629;905.6739573753443;907.034008780653;907.9727608171765;915.6566287642135;539.0970125040542;636.9808905732835;656.1568384625781;662.5130529061137;664.5215444879678;14403.639909002253;14755;14852.2573871306;14966.027208231539;15190.164540950243;11139.554417823278;13534.93232533831;13671.316434178252;13694.452221911111;13799.793003104962;10236.48817559119;12730.23618582888;12753;12759.85161335475;12836.294003829786;4471.128130014648;4486.753228572427;4633.096546173498;4669.369635099252;4670.276107203389;108424.4578777109;112083;112178.43910780475;115068.42465787618;115353;9398.765030874283;10938.343699377903;11156.219064665558;11225.943870280596;11258.66224013281;20824.58350832975;21920.45198870041;21981.67027494589;22145.889270553544;22174.667379989314;7977.282044616012;7981.840363192704;8016.71941482057;8048.476849004796;8331.250187483156;4248.893777655583;4382.890427739332;4407.360932664746;4482.282834746425;4524.457065152203;3573.6962358199326;3590.2281009583066;3681.2637472505608;3683.9447408288897;3688.188598508324;644.5423749138071;652.9706163222667;664.6211659354218;683.7401787320886;685.9451243900476;579.2007030298246;591.8875413671389;648.9415952564292;651.8044586623994;662.9834254143589;8989.820203595891;9071.455712657262;9122.133397327243;9165.220956218664;9258.675946341846;611.403881215811;620.7858288890326;652.9836754081091;658.4271683635172;697.5256825358704;3668.9360085575418;4415.536368681306;4474.149911516802;4482.39487669167;4520.88697782558;91823.54088229516;98734;104443.4777826106;104901.42647860288;105175.4741226289;77700.22299777043;90840.54579727059;94303.52848235714;95014;95426.52286738523;81581.59209203917;83061.16938830655;84135;84639.15360846436;86367;9421.62313507452;9504.239660827256;9827.950860245654;10003.799924001625;10045;48744.78138046577;50108.24837627366;50329.99340013106;52597.7370113147;52834.73582632062;74467.62766186135;75591.11022224488;75828;75834.62082689551;76100.61949690216;12738.808917866425;12965.546205882749;13118.934405328295;13206.273654948685;13489.299401885924;12724.74550508966;14547.78178327347;14687.339069741674;14707.836312976433;14742.63143421423;13565.005638778955;13624.727505450033;13803.378847951666;13831.723365532433;14102.788458173341;13460.730785384041;13595;13793;13804.240766757523;14177.29113544298;13249.337533123113;13533.323333833467;13672.589822305346;13675.589732308046;14006.859931400555;10835.566577336818;11543.5959741412;11657.892500212467;11750.529978801094;11818.231814932002;11108.833367499656;11165;11422.25755325901;11534.250273732181;11596.710082248012 21:27:26 INFO - PROCESS | 1895 | __end_tp_report 21:27:26 INFO - PROCESS | 1895 | __start_cc_report 21:27:26 INFO - PROCESS | 1895 | _x_x_mozilla_cycle_collect,1726 21:27:26 INFO - PROCESS | 1895 | __end_cc_report 21:27:26 INFO - PROCESS | 1895 | __startTimestamp1481779646979__endTimestamp 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | ------- Summary: start ------- 21:27:26 INFO - PROCESS | 1895 | Number of tests: 6 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | [#0] dojo.html Cycles:165 Average:5676.43 Median:5892.59 stddev:649.04 (11.0%) stddev-sans-first:623.86 21:27:26 INFO - PROCESS | 1895 | Values: 3307.5 3323.2 3338.3 3365.7 3379.1 5572.4 5644.8 5646.7 5674.1 5700.3 5647.8 5649.5 5717.1 5750.1 5795.8 5123.5 5151.9 5161.7 5175.8 5193.8 5148.4 5255.5 5261.2 5271.5 5279.1 5229.9 5239.8 5263.9 5268.4 5318.3 5090.7 5112.0 5133.8 5142.6 5178.8 5123.7 5144.5 5171.1 5204.6 5207.9 5568.3 5616.1 5625.0 5630.0 5729.7 6066.9 6113.4 6133.1 6188.0 6195.5 6116.8 6183.6 6214.9 6216.1 6216.7 5788.8 5792.0 5798.8 5808.5 5832.2 6180.5 6318.1 6319.2 6319.3 6325.1 4917.8 5892.6 5928.5 5998.4 6008.9 6127.8 6128.7 6129.8 6131.0 6146.7 6027.8 6077.0 6082.1 6089.3 6105.8 5016.3 6102.4 6108.7 6120.5 6130.0 4414.8 4633.0 4856.9 4861.2 4862.7 4330.2 4334.3 4334.7 4384.2 4432.5 5612.8 5627.2 5651.0 5677.5 5692.7 6204.3 6229.3 6238.4 6249.4 6255.6 5519.3 5596.1 5670.0 5673.6 5687.8 4583.8 5356.4 5384.2 5391.9 5452.9 6276.7 6280.0 6314.8 6315.1 6318.4 6252.7 6257.0 6265.9 6279.1 6289.3 6213.8 6243.0 6252.6 6289.7 6295.1 6146.4 6181.4 6183.8 6197.2 6205.6 6203.6 6230.4 6260.7 6261.7 6274.1 5918.7 5945.1 5952.4 6048.8 6089.1 6021.5 6047.1 6057.0 6085.4 6136.9 5909.4 5912.9 5922.6 5928.4 5930.3 5825.6 6012.2 6033.0 6069.4 6071.1 4962.0 5748.3 5794.3 5863.9 5907.0 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | [#1] ext.html Cycles:180 Average:67114.41 Median:36557.04 stddev:145532.97 (398.1%) stddev-sans-first:145855.17 21:27:26 INFO - PROCESS | 1895 | Values: 456.4 481.5 493.5 494.7 496.6 31162.5 34821.7 37231.6 38233.6 39736.0 41485.8 41741.8 41829.6 41843.0 41859.6 7023.9 9340.2 9546.4 9555.0 9558.4 8560.5 11151.6 11422.4 11435.3 11602.9 11306.5 11337.3 11352.7 11392.8 11411.5 11269.1 11352.5 11363.7 11364.2 11367.3 11264.4 11355.3 11355.4 11356.5 11361.4 38757.4 39054.2 39117.6 39161.6 39205.8 3267.9 3328.2 3476.7 3541.7 3673.9 26769.5 27920.0 28325.3 28514.4 28547.7 3078.5 3085.4 3246.6 3284.9 3290.1 393046.0 473109.0 477264.0 477795.6 479041.0 50359.5 50532.0 50692.5 50704.7 50779.0 57004.0 57119.7 57147.4 57232.4 57237.7 14613.5 15153.1 15166.9 15177.0 15186.3 10604.8 10824.2 10832.5 11638.8 11755.0 20152.9 20203.8 20244.7 20568.9 20609.0 7200.3 8218.4 8275.9 8346.4 8387.8 842.9 987.4 1006.9 1014.2 1049.8 29821.9 29991.4 30190.2 30420.2 30452.0 1067.3 1078.4 1095.9 1140.9 1155.5 14708.5 15463.8 15659.5 15877.9 15900.5 665323.0 670743.0 672101.0 673020.0 675603.0 47965.0 58864.7 58898.0 58903.4 58932.4 1361.8 1401.5 1410.8 1411.0 1413.8 29188.0 29258.4 29273.3 29991.3 30055.0 49244.0 49586.5 49707.8 49757.5 49793.5 473217.0 475911.0 477114.0 477625.0 478097.0 40267.6 40508.4 41610.0 41789.7 41842.8 44755.8 45357.3 45512.8 45637.0 45697.8 31141.0 37517.8 37725.9 37744.0 39316.4 37102.4 37496.0 38227.0 38466.6 38620.4 33818.0 36413.6 36700.4 36808.0 37121.3 32647.5 33955.5 33989.7 34098.7 34230.7 22234.2 22252.6 22949.9 25104.6 25188.7 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | [#2] jquery.html Cycles:180 Average:30027.54 Median:1933.19 stddev:78366.06 (4053.7%) stddev-sans-first:78554.22 21:27:26 INFO - PROCESS | 1895 | Values: 350.6 363.4 365.4 370.0 395.6 14519.9 14791.9 15620.5 19483.2 20076.7 17874.6 19525.2 20095.9 20206.9 20331.7 5554.1 5854.2 5860.8 5903.9 5924.9 5023.3 5731.8 5789.5 5837.3 5856.8 5720.8 5792.9 5799.0 5811.1 5816.0 5507.1 5799.9 5883.8 5915.1 5935.3 4784.5 5497.5 5704.5 5721.9 5729.1 13010.8 13023.7 13230.8 13255.5 13273.3 2099.3 2135.4 2170.0 2326.5 2717.8 9292.4 9712.8 9842.3 9897.2 10292.6 1605.7 1804.8 1807.6 1862.8 1929.1 98692.5 107215.0 108003.0 108212.0 111009.4 8474.6 10973.1 11162.4 11365.0 11524.2 13728.5 14162.7 14185.6 14221.7 14266.7 6564.0 8016.3 8151.6 8227.1 8301.8 7914.7 7970.7 7983.4 8084.5 8128.3 3515.7 3578.6 4434.4 4470.5 4522.6 1859.9 1924.1 1927.3 1929.0 1933.3 359.9 360.8 408.9 838.6 878.5 11505.6 11516.1 11894.9 11924.8 11967.7 405.3 413.2 417.3 420.6 426.6 10304.4 11032.1 11071.6 11474.4 11533.8 418790.9 423060.0 424434.0 492829.0 528118.0 125496.0 132611.0 133693.0 135828.6 143118.6 966.4 1001.1 1032.3 1032.9 1033.5 16388.3 17256.9 18377.4 18504.7 19089.8 50951.0 52945.7 53242.2 53807.0 55088.7 74059.1 76156.9 76304.6 78191.6 79530.2 7782.0 7853.6 8002.4 8050.9 8205.0 11942.6 12350.8 12371.3 12635.5 12657.4 10715.9 10930.9 10994.2 11193.6 11193.6 10559.7 10626.0 10658.6 10810.4 10855.0 10673.7 10782.3 11180.6 11197.9 11391.4 6517.5 7765.1 7895.9 7926.4 8037.2 9315.3 9619.9 9995.2 10292.9 10829.9 21:27:26 INFO - PROCESS | 1895 | 21:27:26 INFO - PROCESS | 1895 | [#3] mootools.html Cycles:180 Average:5336.00 Median:5225.46 stddev:2904.36 (55.6%) stddev-sans-first:2896.87 21:27:27 INFO - PROCESS | 1895 | Values: 1326.5 1354.8 1466.5 1662.7 1874.6 7433.6 7836.1 8106.6 8368.0 8384.5 8268.2 8350.7 8356.9 8368.0 8371.4 2027.2 2286.1 2329.7 2330.0 2332.9 2113.2 2235.6 2334.0 2335.3 2340.0 2254.0 2306.9 2309.1 2323.0 2324.0 2280.3 2321.2 2323.0 2325.3 2329.1 2301.6 2306.4 2318.6 2344.2 2349.7 8197.0 8240.3 8260.8 8278.5 8293.9 5056.8 5220.2 5225.5 5247.4 5251.5 3364.7 3508.1 3602.3 3604.2 3611.2 1006.0 1054.2 1076.4 1090.3 1099.1 10561.8 10801.6 10803.0 10821.6 10853.4 4490.0 4586.2 4668.3 4707.9 4730.4 8632.0 8702.1 8711.7 8715.0 8723.9 5135.1 5139.3 5141.8 5142.6 5148.7 3871.0 4275.9 4722.1 4761.0 4826.9 3068.4 3390.4 3516.8 3576.2 3696.8 1074.5 1112.2 1147.9 1155.3 1156.6 716.7 895.5 901.3 902.1 906.6 4381.8 5225.4 5517.9 5765.0 5833.4 858.3 887.9 902.5 913.7 975.7 2800.0 3642.9 3730.3 3928.2 3978.5 7491.1 9796.8 9809.9 9952.5 9973.4 8592.7 9758.9 9915.9 9940.4 9942.2 6767.5 7730.9 7850.8 7866.7 7880.9 4977.2 5061.8 5408.8 5616.9 5634.6 9136.6 9172.3 9221.8 9251.1 9322.8 7909.9 8830.4 9418.7 9474.8 9519.9 6956.5 7291.9 7306.7 7307.9 7319.5 7197.7 7431.3 7476.0 7816.5 7919.8 7093.1 7126.9 7137.5 7214.5 7353.1 7015.0 7058.1 7068.2 7083.8 7122.1 6590.7 6620.8 6636.8 6667.5 6739.1 4795.1 4855.0 4865.4 4874.7 5029.6 4064.9 4886.4 4937.9 4971.5 4991.8 21:27:27 INFO - PROCESS | 1895 | 21:27:27 INFO - PROCESS | 1895 | [#4] prototype.html Cycles:180 Average:4257.58 Median:4619.75 stddev:1291.16 (27.9%) stddev-sans-first:1260.90 21:27:27 INFO - PROCESS | 1895 | Values: 342.4 353.9 354.3 360.6 364.4 4506.9 5151.3 5156.1 5173.5 5174.6 5083.3 5091.7 5118.6 5133.5 5160.9 2903.1 3708.5 3748.7 3845.9 3933.4 3935.7 3965.0 3966.7 3992.3 3997.6 3517.3 3965.7 3972.3 3983.8 4000.9 3085.9 3342.5 3501.9 3758.6 4008.0 3428.8 3429.0 3506.5 3508.3 3546.3 4189.9 4307.9 4448.5 4897.7 4933.4 3531.6 4082.3 4552.5 4555.7 4665.5 4472.0 4552.8 4607.6 5161.8 5328.4 3153.3 3428.7 3442.4 3859.2 3883.7 4852.9 4980.4 5135.3 5506.6 5720.2 3337.3 3843.3 3957.6 3969.3 4001.0 3463.2 3972.2 3993.6 4017.4 4029.6 4260.5 4497.4 4511.3 4536.3 4564.9 5159.2 5323.0 5375.7 5378.7 5422.0 1109.0 1194.0 1301.3 1303.7 1313.7 790.8 860.5 900.6 926.4 933.3 4091.9 4595.4 4654.5 4702.3 4719.2 4080.9 4464.3 4513.6 4837.0 5190.9 4100.3 4513.7 4726.7 4738.8 4740.5 2233.9 2579.0 2657.5 2758.9 2798.4 4796.6 4883.4 4993.9 5327.2 5540.4 4548.8 5267.9 5392.5 5413.8 5436.8 5696.2 5702.2 5766.6 5783.7 5806.3 4647.6 5205.7 5425.2 5554.3 5573.5 4286.8 4591.4 4784.5 5427.2 5502.7 5015.7 5222.6 5252.0 5263.7 5604.6 3019.7 3046.8 3714.8 3742.7 3807.2 4304.7 4599.8 5125.5 5574.4 5608.9 4619.0 5090.9 5372.5 5389.3 5508.5 4552.4 4620.5 5168.7 5460.4 5470.5 4755.6 5317.4 5325.5 5330.6 5341.8 4687.9 5044.5 5336.4 5383.4 5401.4 4455.6 5288.6 5293.4 5300.3 5317.5 21:27:27 INFO - PROCESS | 1895 | 21:27:27 INFO - PROCESS | 1895 | [#5] yui.html Cycles:180 Average:21103.83 Median:4478.22 stddev:30646.88 (684.4%) stddev-sans-first:30694.65 21:27:27 INFO - PROCESS | 1895 | Values: 725.0 729.9 763.5 807.6 810.9 14791.7 15814.8 15824.0 15850.6 15899.0 14272.5 14429.8 14459.3 14461.0 14463.4 676.8 697.1 703.1 833.6 845.6 836.2 837.9 853.5 853.8 854.1 911.7 913.0 913.8 914.5 917.3 702.8 905.7 907.0 908.0 915.7 539.1 637.0 656.2 662.5 664.5 14403.6 14755.0 14852.3 14966.0 15190.2 11139.6 13534.9 13671.3 13694.5 13799.8 10236.5 12730.2 12753.0 12759.9 12836.3 4471.1 4486.8 4633.1 4669.4 4670.3 108424.5 112083.0 112178.4 115068.4 115353.0 9398.8 10938.3 11156.2 11225.9 11258.7 20824.6 21920.5 21981.7 22145.9 22174.7 7977.3 7981.8 8016.7 8048.5 8331.3 4248.9 4382.9 4407.4 4482.3 4524.5 3573.7 3590.2 3681.3 3683.9 3688.2 644.5 653.0 664.6 683.7 685.9 579.2 591.9 648.9 651.8 663.0 8989.8 9071.5 9122.1 9165.2 9258.7 611.4 620.8 653.0 658.4 697.5 3668.9 4415.5 4474.1 4482.4 4520.9 91823.5 98734.0 104443.5 104901.4 105175.5 77700.2 90840.5 94303.5 95014.0 95426.5 81581.6 83061.2 84135.0 84639.2 86367.0 9421.6 9504.2 9828.0 10003.8 10045.0 48744.8 50108.2 50330.0 52597.7 52834.7 74467.6 75591.1 75828.0 75834.6 76100.6 12738.8 12965.5 13118.9 13206.3 13489.3 12724.7 14547.8 14687.3 14707.8 14742.6 13565.0 13624.7 13803.4 13831.7 14102.8 13460.7 13595.0 13793.0 13804.2 14177.3 13249.3 13533.3 13672.6 13675.6 14006.9 10835.6 11543.6 11657.9 11750.5 11818.2 11108.8 11165.0 11422.3 11534.3 11596.7 21:27:27 INFO - PROCESS | 1895 | -------- Summary: end -------- 21:27:27 INFO - PROCESS | 1895 | 21:27:27 INFO - TEST-INFO | 1895: exit 0 21:27:27 INFO - TEST-OK | dromaeo_css | took 1119684ms 21:27:27 INFO - TEST-START | kraken 21:27:27 INFO - operating with platform_type : mac_ 21:27:27 INFO - Initialising browser for kraken test... 21:27:27 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp9FC0nq/profile http://localhost:49377/getInfo.html) 21:27:30 INFO - PROCESS | 1900 | __metrics Screen width/height:1600/1200 21:27:30 INFO - PROCESS | 1900 | colorDepth:24 21:27:30 INFO - PROCESS | 1900 | Browser inner width/height: 1024/689 21:27:30 INFO - PROCESS | 1900 | __metrics 21:27:30 INFO - PROCESS | 1900 | 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" 21:27:30 INFO - PROCESS | 1900 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:27:31 INFO - TEST-INFO | 1900: exit 0 21:27:31 INFO - Browser initialized. 21:27:31 INFO - Running cycle 1/1 for kraken test... 21:27:31 INFO - TEST-INFO | started process 1901 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp9FC0nq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:27:43 INFO - PROCESS | 1901 | RSS: Main: 238383104 21:27:43 INFO - PROCESS | 1901 | 21:27:45 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-beat-detection) 21:27:46 INFO - PROCESS | 1901 | RSS: Main: 289255424 21:27:46 INFO - PROCESS | 1901 | 21:27:49 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-dft) 21:27:50 INFO - PROCESS | 1901 | RSS: Main: 291442688 21:27:50 INFO - PROCESS | 1901 | 21:27:53 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-fft) 21:27:53 INFO - PROCESS | 1901 | RSS: Main: 382644224 21:27:53 INFO - PROCESS | 1901 | 21:27:56 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-oscillator) 21:27:56 INFO - PROCESS | 1901 | RSS: Main: 284819456 21:27:56 INFO - PROCESS | 1901 | 21:27:58 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:27:59 INFO - PROCESS | 1901 | RSS: Main: 289505280 21:27:59 INFO - PROCESS | 1901 | 21:28:02 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-darkroom) 21:28:03 INFO - PROCESS | 1901 | RSS: Main: 330420224 21:28:03 INFO - PROCESS | 1901 | 21:28:06 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-desaturate) 21:28:06 INFO - PROCESS | 1901 | RSS: Main: 332742656 21:28:06 INFO - PROCESS | 1901 | 21:28:09 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49377/tests/kraken/driver.html?testName=json-parse-financial) 21:28:10 INFO - PROCESS | 1901 | RSS: Main: 331091968 21:28:10 INFO - PROCESS | 1901 | 21:28:11 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:28:12 INFO - PROCESS | 1901 | RSS: Main: 305975296 21:28:12 INFO - PROCESS | 1901 | 21:28:14 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:28:14 INFO - PROCESS | 1901 | RSS: Main: 309731328 21:28:14 INFO - PROCESS | 1901 | 21:28:17 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:28:17 INFO - PROCESS | 1901 | RSS: Main: 311562240 21:28:17 INFO - PROCESS | 1901 | 21:28:20 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:28:21 INFO - PROCESS | 1901 | RSS: Main: 329187328 21:28:21 INFO - PROCESS | 1901 | 21:28:24 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:28:25 INFO - PROCESS | 1901 | RSS: Main: 322646016 21:28:25 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49377/tests/kraken/driver.html?testName=ai-astar) 21:28:27 INFO - PROCESS | 1901 | RSS: Main: 367656960 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | __start_tp_report 21:28:27 INFO - PROCESS | 1901 | _x_x_mozilla_page_load 21:28:27 INFO - PROCESS | 1901 | _x_x_mozilla_page_load_details 21:28:27 INFO - PROCESS | 1901 | |i|pagename|runs| 21:28:27 INFO - PROCESS | 1901 | |0;ai-astar;112;113;110;112;112;112;112;112;113;111 21:28:27 INFO - PROCESS | 1901 | |1;audio-beat-detection;188;118;117;156;113;116;115;114;133;115 21:28:27 INFO - PROCESS | 1901 | |2;audio-dft;184;183;184;185;183;182;183;179;183;184 21:28:27 INFO - PROCESS | 1901 | |3;audio-fft;81;60;65;111;87;49;74;76;96;83 21:28:27 INFO - PROCESS | 1901 | |4;audio-oscillator;89;69;87;69;69;69;83;68;70;83 21:28:27 INFO - PROCESS | 1901 | |5;imaging-gaussian-blur;108;110;108;109;107;110;108;112;107;124 21:28:27 INFO - PROCESS | 1901 | |6;imaging-darkroom;96;96;96;96;95;127;97;97;97;117 21:28:27 INFO - PROCESS | 1901 | |7;imaging-desaturate;85;87;88;88;88;86;86;87;85;84 21:28:27 INFO - PROCESS | 1901 | |8;json-parse-financial;58;56;55;56;56;56;56;55;55;56 21:28:27 INFO - PROCESS | 1901 | |9;json-stringify-tinderbox;65;73;75;76;75;71;70;72;73;73 21:28:27 INFO - PROCESS | 1901 | |10;stanford-crypto-aes;88;89;87;91;89;90;81;90;87;94 21:28:27 INFO - PROCESS | 1901 | |11;stanford-crypto-ccm;156;146;148;158;154;151;158;154;180;153 21:28:27 INFO - PROCESS | 1901 | |12;stanford-crypto-pbkdf2;177;178;221;238;196;177;177;179;181;177 21:28:27 INFO - PROCESS | 1901 | |13;stanford-crypto-sha256-iterative;67;69;68;68;67;68;67;67;67;67 21:28:27 INFO - PROCESS | 1901 | __end_tp_report 21:28:27 INFO - PROCESS | 1901 | __start_cc_report 21:28:27 INFO - PROCESS | 1901 | _x_x_mozilla_cycle_collect,2148 21:28:27 INFO - PROCESS | 1901 | __end_cc_report 21:28:27 INFO - PROCESS | 1901 | __startTimestamp1481779707286__endTimestamp 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | ------- Summary: start ------- 21:28:27 INFO - PROCESS | 1901 | Number of tests: 14 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 21:28:27 INFO - PROCESS | 1901 | Values: 112.0 113.0 110.0 112.0 112.0 112.0 112.0 112.0 113.0 111.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:117.50 stddev:24.79 (21.1%) stddev-sans-first:14.13 21:28:27 INFO - PROCESS | 1901 | Values: 188.0 118.0 117.0 156.0 113.0 116.0 115.0 114.0 133.0 115.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.63 (0.9%) stddev-sans-first:1.69 21:28:27 INFO - PROCESS | 1901 | Values: 184.0 183.0 184.0 185.0 183.0 182.0 183.0 179.0 183.0 184.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#3] audio-fft Cycles:10 Average:78.20 Median:78.50 stddev:17.89 (22.8%) stddev-sans-first:18.95 21:28:27 INFO - PROCESS | 1901 | Values: 81.0 60.0 65.0 111.0 87.0 49.0 74.0 76.0 96.0 83.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.71 (11.4%) stddev-sans-first:7.77 21:28:27 INFO - PROCESS | 1901 | Values: 89.0 69.0 87.0 69.0 69.0 69.0 83.0 68.0 70.0 83.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:109.50 stddev:5.06 (4.6%) stddev-sans-first:5.29 21:28:27 INFO - PROCESS | 1901 | Values: 108.0 110.0 108.0 109.0 107.0 110.0 108.0 112.0 107.0 124.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:96.00 stddev:11.13 (11.6%) stddev-sans-first:11.63 21:28:27 INFO - PROCESS | 1901 | Values: 96.0 96.0 96.0 96.0 95.0 127.0 97.0 97.0 97.0 117.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 21:28:27 INFO - PROCESS | 1901 | Values: 85.0 87.0 88.0 88.0 88.0 86.0 86.0 87.0 85.0 84.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.50 21:28:27 INFO - PROCESS | 1901 | Values: 58.0 56.0 55.0 56.0 56.0 56.0 56.0 55.0 55.0 56.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.00 stddev:3.16 (4.3%) stddev-sans-first:1.96 21:28:27 INFO - PROCESS | 1901 | Values: 65.0 73.0 75.0 76.0 75.0 71.0 70.0 72.0 73.0 73.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.50 stddev:3.37 (3.8%) stddev-sans-first:3.57 21:28:27 INFO - PROCESS | 1901 | Values: 88.0 89.0 87.0 91.0 89.0 90.0 81.0 90.0 87.0 94.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:155.00 stddev:9.37 (6.0%) stddev-sans-first:9.93 21:28:27 INFO - PROCESS | 1901 | Values: 156.0 146.0 148.0 158.0 154.0 151.0 158.0 154.0 180.0 153.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.10 Median:180.00 stddev:21.92 (12.2%) stddev-sans-first:22.73 21:28:27 INFO - PROCESS | 1901 | Values: 177.0 178.0 221.0 238.0 196.0 177.0 177.0 179.0 181.0 177.0 21:28:27 INFO - PROCESS | 1901 | 21:28:27 INFO - PROCESS | 1901 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 21:28:27 INFO - PROCESS | 1901 | Values: 67.0 69.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 21:28:27 INFO - PROCESS | 1901 | -------- Summary: end -------- 21:28:27 INFO - PROCESS | 1901 | 21:28:28 INFO - TEST-INFO | 1901: exit 0 21:28:28 INFO - TEST-OK | kraken | took 60551ms 21:28:28 INFO - SUITE-END | took 1180s 21:28:28 INFO - Completed test suite (00:19:40) 21:28:28 INFO - javascript benchmark 21:28:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.470804671252, 3323.235655799165, 3338.2822693120975, 3365.6802603752667, 3379.121428428608, 5572.4148964358765, 5644.830655080349, 5646.6894320812335, 5674.120511320752, 5700.258966334376, 5647.802326918549, 5649.548036157108, 5717.085266357383, 5750.05124154514, 5795.82612521624, 5123.5388815006645, 5151.948480515203, 5161.664491808039, 5175.792968281265, 5193.818216362428, 5148.382194136709, 5255.527002569768, 5261.210818377255, 5271.525562699357, 5279.102552566073, 5229.921551176735, 5239.79040838366, 5263.921041184385, 5268.420473747885, 5318.30861987941, 5090.669106508102, 5112.003159383921, 5133.768980395891, 5142.640015198937, 5178.818741344073, 5123.718195499246, 5144.511271429208, 5171.0692075426405, 5204.635675502716, 5207.895842083137, 5568.276124103881, 5616.073347897592, 5625.043742563733, 5630.014747419226, 5729.742161602696, 6066.939330606681, 6113.449789518964, 6133.1413602095745, 6187.969060154715, 6195.535334849859, 6116.7553297868035, 6183.628982261033, 6214.937850621481, 6216.129741836146, 6216.689165541705, 5788.768449261982, 5791.9710401448565, 5798.797042103506, 5808.535317174658, 5832.1834943108, 6180.47465965398, 6318.115463835067, 6319.178506794179, 6319.33646967071, 6325.114483972247, 4917.803287868445, 5892.587518873637, 5928.4960778334325, 5998.400159983967, 6008.939910600838, 6127.80043271483, 6128.747575574832, 6129.847850912788, 6131.0096813291075, 6146.692665366714, 6027.78902738402, 6076.969615151896, 6082.148499210114, 6089.330173680892, 6105.8473538161015, 5016.322796422509, 6102.420270074336, 6108.664023478751, 6120.479759220427, 6129.96935015331, 4414.830070031444, 4632.976835115803, 4856.854294371175, 4861.246506791383, 4862.659613826998, 4330.17726631939, 4334.263175260214, 4334.718243314174, 4384.210842048398, 4432.468103827561, 5612.7754889803955, 5627.155926611041, 5651.039323315046, 5677.545796336283, 5692.715364231854, 6204.348543402968, 6229.345918678564, 6238.438540531283, 6249.406306400884, 6255.624662520263, 5519.2824932758485, 5596.076647353222, 5670.036093864053, 5673.6028478006965, 5687.829365119053, 4583.770811459413, 5356.357237131491, 5384.219288203267, 5391.892162156735, 5452.863678408072, 6276.6547839868335, 6280.0, 6314.842128946813, 6315.052742088816, 6318.368163183645, 6252.718627661675, 6256.968715156577, 6265.937340626535, 6279.1209230708655, 6289.276733175743, 6213.844653883689, 6243.0, 6252.562320637512, 6289.654069026247, 6295.087212354275, 6146.401935496892, 6181.412765787243, 6183.752649893954, 6197.163382943425, 6205.565610407228, 6203.596766210182, 6230.376962303914, 6260.655663938527, 6261.655608941552, 6274.058891166362, 5918.674472904032, 5945.108233764797, 5952.375000625046, 6048.788292409745, 6089.147519347206, 6021.54838387114, 6047.123167140828, 6056.9697151513965, 6085.391460853879, 6136.938630613637, 5909.379515151019, 5912.852178695395, 5922.585419020799, 5928.3775203603, 5930.288365396007, 5825.563082768894, 6012.158297838394, 6033.0045542484995, 6069.423404776539, 6071.089336599545, 4961.975190124026, 5748.338941021836, 5794.333651630117, 5863.941360586339, 5907.0], "value": 5634.851278789928, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.36337309453313, 481.4775968074639, 493.5410068636167, 494.71801073388184, 496.63001064207174, 31162.532562011587, 34821.65178348216, 37231.627683723156, 38233.61766382339, 39736.00659983498, 41485.79257103718, 41741.79129104358, 41829.58170418295, 41843.0, 41859.58140418595, 7023.859522809541, 9340.15938565529, 9546.379485333431, 9555.044495550459, 9558.426494410323, 8560.529170895597, 11151.553937842516, 11422.371769552672, 11435.313881167114, 11602.941985290061, 11306.491207895624, 11337.319760814378, 11352.716182095432, 11392.829107563393, 11411.54353825846, 11269.098472122252, 11352.48913798881, 11363.715907102389, 11364.204505684605, 11367.261128026734, 11264.380459074748, 11355.261907976037, 11355.43222838863, 11356.545738170464, 11361.43192840363, 38757.41863872044, 39054.21891562153, 39117.60882391168, 39161.60838391608, 39205.80397098025, 3267.9346413071844, 3328.2012317043977, 3476.704480119193, 3541.734369922266, 3673.8714145004797, 26769.464610707677, 27920.0, 28325.291867703265, 28514.429711405865, 28547.714522854712, 3078.5382192671054, 3085.3829234153036, 3246.5779448671756, 3284.8850290239725, 3290.0623322353013, 393046.0, 473109.0, 477264.0, 477795.6110219461, 479041.0, 50359.49640503621, 50532.0, 50692.49307506951, 50704.746476267384, 50779.0, 57004.0, 57119.71440142856, 57147.42852571421, 57232.42767572271, 57237.71381143151, 14613.488527901472, 15153.090814551162, 15166.924165379323, 15177.013494122846, 15186.316615752317, 10604.787904241872, 10824.188185885932, 10832.512536935857, 11638.76722465546, 11755.000824929806, 20152.89923550373, 20203.797962020486, 20244.696329555067, 20568.897155514125, 20608.969551522365, 7200.315969982843, 8218.383621228431, 8275.917240827635, 8346.4157508975, 8387.790305242295, 842.8735689646602, 987.3680844259679, 1006.8622456623968, 1014.2139841622801, 1049.8320268756963, 29821.85089074541, 29991.400171996436, 30190.24524386864, 30420.239494012825, 30452.0, 1067.2955849139687, 1078.3795377233241, 1095.8904109588977, 1140.8573928258968, 1155.5377848860523, 14708.485203017843, 15463.768043479356, 15659.451919182773, 15877.920610396874, 15900.52298431049, 665323.0, 670743.0, 672101.0, 673019.9839008901, 675603.0, 47965.04069918652, 58864.70567647134, 58898.0, 58903.41096589065, 58932.410675892694, 1361.761691703948, 1401.4674423719125, 1410.7531182043306, 1410.9929450352683, 1413.7879318102366, 29188.0, 29258.414831703674, 29273.268168295963, 29991.250218744706, 30055.0, 49244.0, 49586.50413495963, 49707.751461242464, 49757.50242497674, 49793.502064978886, 473217.0, 475911.0, 477114.0, 477625.0, 478097.0, 40267.597324026385, 40508.39237411382, 41610.0, 41789.74630761082, 41842.790786047095, 44755.776221118685, 45357.31964020476, 45512.77243613761, 45637.0, 45697.77151114223, 31141.0, 37517.81241093777, 37725.86822395332, 37744.0, 39316.410253846785, 37102.44346334861, 37496.0, 38227.0, 38466.615333846305, 38620.420693689055, 33818.0, 36413.635863642085, 36700.44949325709, 36808.0, 37121.25757484781, 32647.510287346184, 33955.49066763951, 33989.66010339865, 34098.659013409546, 34230.65769342275, 22234.221802236843, 22252.554948901256, 22949.88525057364, 25104.62343064819, 25188.748112519374], "value": 19979.39480771521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.6423448082957, 363.36229916496546, 365.44269988267905, 370.03974685690633, 395.64392047157554, 14519.927400362996, 14791.926040369797, 15620.453284135043, 19483.220671173138, 20076.69884951727, 17874.553136171602, 19525.21899124037, 20095.899520502415, 20206.888621125832, 20331.695024574605, 5554.1391084381885, 5854.151148083525, 5860.765569377241, 5903.88192236155, 5924.851878703045, 5023.346964894558, 5731.828045158631, 5789.536837053026, 5837.299524057098, 5856.795012174574, 5720.8283751487525, 5792.884142317151, 5798.971005144968, 5811.0702287633985, 5816.011278082715, 5507.118860982244, 5799.942000580004, 5883.79406720767, 5915.112733090028, 5935.258092738408, 4784.545468180518, 5497.532709719679, 5704.515116215127, 5721.885562288731, 5729.111987641881, 13010.804837927439, 13023.739525209443, 13230.801537976939, 13255.536056237985, 13273.336333183302, 2099.3387083068783, 2135.4234356723755, 2170.007117225171, 2326.5230627721444, 2717.8097533172686, 9292.39599426042, 9712.75718107046, 9842.261830362751, 9897.208223342115, 10292.588296468133, 1605.743081107029, 1804.7744031996, 1807.5842556212012, 1862.8323450889486, 1929.0836852495092, 98692.50653746758, 107215.0, 108003.0, 108212.0, 111009.44495277472, 8474.618642161118, 10973.122150227962, 11162.441877906234, 11365.0, 11524.193306468467, 13728.45086196561, 14162.716745665235, 14185.574432767033, 14221.715565688835, 14266.714665706835, 6564.0, 8016.278534931767, 8151.551664658382, 8227.095019547845, 8301.750947471464, 7914.683412663429, 7970.681172753025, 7983.361331093614, 8084.514929104273, 8128.309093726981, 3515.736319776027, 3578.622230441299, 4434.360635083092, 4470.530594287618, 4522.615577675934, 1859.869809113349, 1924.1341396371688, 1927.3350694010544, 1928.9517762056062, 1933.337329896288, 359.9310049154008, 360.79795314623897, 408.8936876412154, 838.5681374092347, 878.547548012774, 11505.597304094317, 11516.1362897783, 11894.940525297317, 11924.76150477003, 11967.683554808964, 405.27658130237387, 413.23345194663466, 417.2635298697801, 420.55421253471417, 426.6203079259462, 10304.381737095799, 11032.117430605533, 11071.612493562687, 11474.36890970988, 11533.826992595117, 418790.90604547394, 423060.0, 424434.0, 492829.0, 528118.0, 125496.0, 132611.0, 133693.0, 135828.64171358358, 143118.5688143126, 966.3960024984385, 1001.1090129784643, 1032.3031953431405, 1032.9225308101772, 1033.503918119307, 16388.344466221217, 17256.913715431845, 18377.448676539727, 18504.722429163303, 19089.809101908802, 50951.0, 52945.70542945675, 53242.20136697875, 53807.0, 55088.72455637696, 74059.1485212874, 76156.85764713422, 76304.61847690726, 78191.60904195442, 79530.20469795229, 7781.9610901945125, 7853.56805375687, 8002.399820013638, 8050.87287779723, 8205.0, 11942.582009629621, 12350.75298494007, 12371.319577423328, 12635.494580217057, 12657.367131643565, 10715.892841071489, 10930.890691092987, 10994.230403871972, 11193.608223712132, 11193.608223712132, 10559.683209503728, 10626.0, 10658.573657053632, 10810.35137891729, 10855.0, 10673.733156671145, 10782.299150555189, 11180.552777888794, 11197.888021119685, 11391.430428478378, 6517.478601711757, 7765.107012693613, 7895.868115608869, 7926.365890728844, 8037.23646253605, 9315.34792564514, 9619.903800961902, 9995.150412215044, 10292.892456435351, 10829.888171806737], "value": 8600.089709413765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.5423428917027, 1354.790007548829, 1466.4940595494554, 1662.6591548732504, 1874.5501079740857, 7433.628318584069, 7836.098848632409, 8106.554139522324, 8368.0, 8384.538850363228, 8268.214519620642, 8350.665973361058, 8356.874646880302, 8368.0376756673, 8371.372147088961, 2027.2499175305084, 2286.085565773687, 2329.685492458522, 2329.9981008166483, 2332.8600283982933, 2113.175861414042, 2235.5864165129424, 2333.9963815559304, 2335.32275640065, 2340.0171927790284, 2254.0, 2306.8731219782903, 2309.145616122037, 2322.96515552266, 2324.0, 2280.270313499681, 2321.2339927823778, 2322.953540929189, 2325.2559181062065, 2329.114936324186, 2301.5742087713825, 2306.3657494189065, 2318.5594736999915, 2344.2146880794953, 2349.7180338359335, 8196.959015204946, 8240.299574536111, 8260.793480162984, 8278.461899976543, 8293.875591866066, 5056.82301119459, 5220.216967454874, 5225.503577160163, 5247.449017853147, 5251.501107394792, 3364.6971772540346, 3508.1405055761247, 3602.2975519773654, 3604.2431089471243, 3611.1694310308512, 1005.9849102263472, 1054.177741361739, 1076.43487169236, 1090.2858627598935, 1099.1371773158032, 10561.788764224673, 10801.621943232029, 10803.0, 10821.56713731442, 10853.403062831541, 4489.955100448954, 4586.197415452282, 4668.299755036772, 4707.8587642370785, 4730.385049943486, 8632.0, 8702.086280940537, 8711.738647840575, 8714.956425217833, 8723.869141962876, 5135.101357262539, 5139.280500729901, 5141.76862041209, 5142.588592912558, 5148.742562871917, 3871.0, 4275.935860962088, 4722.079194557097, 4760.976195119002, 4826.903461930741, 3068.4476794177262, 3390.423627983249, 3516.7889926604485, 3576.195356044921, 3696.796676182782, 1074.4520294649628, 1112.2103306652207, 1147.9311241325547, 1155.3299086529792, 1156.5778490850946, 716.6774951271949, 895.5298468304193, 901.2744740483843, 902.120432578231, 906.5693795447241, 4381.78091095444, 5225.425203227642, 5517.889642207133, 5765.048766953406, 5833.416658334133, 858.3176374782063, 887.933404994628, 902.5126431726925, 913.6619450803246, 975.7463059604412, 2799.9860000699864, 3642.925337025531, 3730.291244663505, 3928.155446578999, 3978.5424676162033, 7491.063617047869, 9796.755081122887, 9809.901900981042, 9952.452615106238, 9973.401595904124, 8592.656293748305, 9758.853617195748, 9915.900840991499, 9940.353876998117, 9942.204623630092, 6767.458603311723, 7730.884036739453, 7850.764477065697, 7866.685332586632, 7880.881786773203, 4977.203647416396, 5061.797528098835, 5408.783023819609, 5616.915746263891, 5634.6337488063145, 9136.588853501475, 9172.266218702622, 9221.815563688555, 9251.121143491358, 9322.813543729224, 7909.881351779843, 8830.381873268809, 9418.717438476857, 9474.763130921781, 9519.857202141835, 6956.513044086865, 7291.927080729337, 7306.671199796128, 7307.890381644386, 7319.487635865438, 7197.712091516491, 7431.29402706742, 7476.0, 7816.49192802466, 7919.762407127565, 7093.1488221413765, 7126.857462850818, 7137.464690148156, 7214.494985351185, 7353.080864891888, 7014.964925175342, 7058.11773528309, 7068.151821781419, 7083.7520686775715, 7122.109736282965, 6590.670466476753, 6620.834479137868, 6636.800895973129, 6667.466602671678, 6739.056532085414, 4795.112904112751, 4855.0, 4865.391826021747, 4874.707517548958, 5029.572486338702, 4064.9187016258916, 4886.389201349832, 4937.876553086202, 4971.502849715, 4991.825286114969], "value": 4331.967324672396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4230172159911, 353.93098345822557, 354.2525271676761, 360.5655185501471, 364.4260290043181, 4506.887327816807, 5151.2788209650635, 5156.097682905486, 5173.482651734829, 5174.586033117346, 5083.262926875601, 5091.694498330103, 5118.5905127589795, 5133.486651334864, 5160.896782064357, 2903.12310052389, 3708.4993525874065, 3748.7375883688082, 3845.9230815383676, 3933.3903244996927, 3935.724499285051, 3964.958046606, 3966.7223294369405, 3992.321305378093, 3997.6208208168136, 3517.331706975679, 3965.662918651918, 3972.304846651839, 3983.760974341534, 4000.8599699010542, 3085.938281234385, 3342.4986252062263, 3501.912452188703, 3758.642928921748, 4007.9599204007877, 3428.777129486575, 3428.971308607408, 3506.4915587239707, 3508.2632647144133, 3546.308469848381, 4189.853355132586, 4307.944553584361, 4448.488423831269, 4897.681650692693, 4933.358663373739, 3531.6468353164737, 4082.346824508094, 4552.499225085238, 4555.658325625592, 4665.486796452387, 4472.0, 4552.839026048369, 4607.571652787647, 5161.767720452589, 5328.387235467932, 3153.2905096353365, 3428.7428442866885, 3442.3648766835804, 3859.247446747885, 3883.689304855605, 4852.927206091911, 4980.427250866161, 5135.254013635382, 5506.559475242051, 5720.198137586647, 3337.299167174872, 3843.2889915365745, 3957.604239576077, 3969.325214713506, 4000.959990400117, 3463.2034632034774, 3972.172800511797, 3993.5806740292433, 4017.397390391465, 4029.5768944261017, 4260.487526927958, 4497.415336006298, 4511.345854851028, 4536.2762150383305, 4564.863054108382, 5159.17453207485, 5322.962022405671, 5375.704336261465, 5378.650387724785, 5421.972890135524, 1108.9889101108886, 1193.988060119405, 1301.3493253373313, 1303.7131830997166, 1313.6978494946216, 790.7864876483317, 860.492309537376, 900.5902314446911, 926.4348747264163, 933.2813733425224, 4091.8926752722373, 4595.448546174413, 4654.5338218461075, 4702.318163866289, 4719.215662758988, 4080.8571699990357, 4464.330350447459, 4513.571210735041, 4837.0, 5190.92213616796, 4100.302948498763, 4513.661475389359, 4726.669133160714, 4738.8341408050555, 4740.478547359788, 2233.8561967549963, 2578.987105064463, 2657.495075935566, 2758.917232483029, 2798.4263226038615, 4796.56830885222, 4883.389576302962, 4993.852643363316, 5327.200919861974, 5540.418256083134, 4548.840790572381, 5267.947320526822, 5392.487713667196, 5413.83758487246, 5436.755346009439, 5696.23100881384, 5702.173184888168, 5766.625169364062, 5783.681897495594, 5806.303243610793, 4647.628189744744, 5205.687658740488, 5425.186222066722, 5554.250880655461, 5573.495156307856, 4286.828526858891, 4591.376421482584, 4784.521547845187, 5427.213054107211, 5502.669839809624, 5015.699058056528, 5222.582193424593, 5251.975864706498, 5263.6578622389425, 5604.551635869202, 3019.7131272529073, 3046.7714921380543, 3714.758540694846, 3742.73800833939, 3807.219519998449, 4304.74171549708, 4599.770011499345, 5125.461826508163, 5574.358948720949, 5608.9158662619275, 4618.953810461987, 5090.909090909091, 5372.543333816513, 5389.272448219597, 5508.504234618904, 4552.362669226377, 4620.537946205487, 5168.664036837594, 5460.426655201306, 5470.5350045245, 4755.595774359218, 5317.415084340642, 5325.467453254643, 5330.560748597934, 5341.75962081715, 4687.945212327199, 5044.486654003857, 5336.412994570672, 5383.389056307609, 5401.432849550741, 4455.554444555519, 5288.5769138469595, 5293.444188360167, 5300.349825087456, 5317.468253174807], "value": 3870.113342804321, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.0031207090251, 729.8613263479939, 763.5151678684034, 807.5760225881407, 810.8540462716712, 14791.704165916675, 15814.76277855833, 15823.9714418563, 15850.60373490662, 15899.0, 14272.500462483815, 14429.783553246709, 14459.349329280181, 14460.987730858844, 14463.421463141489, 676.796960911727, 697.0868162706845, 703.1456780012284, 833.5540485840077, 845.623697454633, 836.1554829622065, 837.857564214082, 853.4665833853842, 853.8335024670192, 854.0647990450447, 911.6626848066225, 912.968046118386, 913.7898283394824, 914.4696076275777, 917.3486824354716, 702.8067281497629, 905.6739573753443, 907.034008780653, 907.9727608171765, 915.6566287642135, 539.0970125040542, 636.9808905732835, 656.1568384625781, 662.5130529061137, 664.5215444879678, 14403.639909002253, 14755.0, 14852.2573871306, 14966.027208231539, 15190.164540950243, 11139.554417823278, 13534.93232533831, 13671.316434178252, 13694.452221911111, 13799.793003104962, 10236.48817559119, 12730.23618582888, 12753.0, 12759.85161335475, 12836.294003829786, 4471.128130014648, 4486.753228572427, 4633.096546173498, 4669.369635099252, 4670.276107203389, 108424.4578777109, 112083.0, 112178.43910780475, 115068.42465787618, 115353.0, 9398.765030874283, 10938.343699377903, 11156.219064665558, 11225.943870280596, 11258.66224013281, 20824.58350832975, 21920.45198870041, 21981.67027494589, 22145.889270553544, 22174.667379989314, 7977.282044616012, 7981.840363192704, 8016.71941482057, 8048.476849004796, 8331.250187483156, 4248.893777655583, 4382.890427739332, 4407.360932664746, 4482.282834746425, 4524.457065152203, 3573.6962358199326, 3590.2281009583066, 3681.2637472505608, 3683.9447408288897, 3688.188598508324, 644.5423749138071, 652.9706163222667, 664.6211659354218, 683.7401787320886, 685.9451243900476, 579.2007030298246, 591.8875413671389, 648.9415952564292, 651.8044586623994, 662.9834254143589, 8989.820203595891, 9071.455712657262, 9122.133397327243, 9165.220956218664, 9258.675946341846, 611.403881215811, 620.7858288890326, 652.9836754081091, 658.4271683635172, 697.5256825358704, 3668.9360085575418, 4415.536368681306, 4474.149911516802, 4482.39487669167, 4520.88697782558, 91823.54088229516, 98734.0, 104443.4777826106, 104901.42647860288, 105175.4741226289, 77700.22299777043, 90840.54579727059, 94303.52848235714, 95014.0, 95426.52286738523, 81581.59209203917, 83061.16938830655, 84135.0, 84639.15360846436, 86367.0, 9421.62313507452, 9504.239660827256, 9827.950860245654, 10003.799924001625, 10045.0, 48744.78138046577, 50108.24837627366, 50329.99340013106, 52597.7370113147, 52834.73582632062, 74467.62766186135, 75591.11022224488, 75828.0, 75834.62082689551, 76100.61949690216, 12738.808917866425, 12965.546205882749, 13118.934405328295, 13206.273654948685, 13489.299401885924, 12724.74550508966, 14547.78178327347, 14687.339069741674, 14707.836312976433, 14742.63143421423, 13565.005638778955, 13624.727505450033, 13803.378847951666, 13831.723365532433, 14102.788458173341, 13460.730785384041, 13595.0, 13793.0, 13804.240766757523, 14177.29113544298, 13249.337533123113, 13533.323333833467, 13672.589822305346, 13675.589732308046, 14006.859931400555, 10835.566577336818, 11543.5959741412, 11657.892500212467, 11750.529978801094, 11818.231814932002, 11108.833367499656, 11165.0, 11422.25755325901, 11534.250273732181, 11596.710082248012], "value": 7553.380585738586, "unit": "score"}], "name": "dromaeo_css", "value": 7048.465749732108, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 110.0, 112.0, 112.0, 112.0, 112.0, 112.0, 113.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 118.0, 117.0, 156.0, 113.0, 116.0, 115.0, 114.0, 133.0, 115.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 185.0, 183.0, 182.0, 183.0, 179.0, 183.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 65.0, 111.0, 87.0, 49.0, 74.0, 76.0, 96.0, 83.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 87.0, 69.0, 69.0, 69.0, 83.0, 68.0, 70.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 108.0, 109.0, 107.0, 110.0, 108.0, 112.0, 107.0, 124.0], "value": 110.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 127.0, 97.0, 97.0, 97.0, 117.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 88.0, 88.0, 88.0, 86.0, 86.0, 87.0, 85.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 75.0, 76.0, 75.0, 71.0, 70.0, 72.0, 73.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 87.0, 91.0, 89.0, 90.0, 81.0, 90.0, 87.0, 94.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 146.0, 148.0, 158.0, 154.0, 151.0, 158.0, 154.0, 180.0, 153.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 221.0, 238.0, 196.0, 177.0, 177.0, 179.0, 181.0, 177.0], "value": 190.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1505.4999999999995, "alertThreshold": 2.0}]} 21:28:28 INFO - Return code: 0 21:28:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:28:28 INFO - # TBPL SUCCESS # 21:28:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:28:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:28:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:28:28 INFO - 2016-12-14 21:28:28.612 screenresolution[1905:10920] starting screenresolution argv=screenresolution get 21:28:28 INFO - 2016-12-14 21:28:28.615 screenresolution[1905:10920] Display 0: 1600x1200x32@60 21:28:28 INFO - 2016-12-14 21:28:28.621 screenresolution[1906:10923] starting screenresolution argv=screenresolution list 21:28:28 INFO - Available Modes on Display 0 21:28:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:28:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:28:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:28:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:28:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:28:28 INFO - Intel Iris: 21:28:28 INFO - Chipset Model: Intel Iris 21:28:28 INFO - Type: GPU 21:28:28 INFO - Bus: Built-In 21:28:28 INFO - VRAM (Dynamic, Max): 1536 MB 21:28:28 INFO - Vendor: Intel (0x8086) 21:28:28 INFO - Device ID: 0x0a2e 21:28:28 INFO - Revision ID: 0x0009 21:28:28 INFO - Displays: 21:28:28 INFO - Display: 21:28:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:28:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:28:28 INFO - Display Serial Number: 1600x1200 60 21:28:28 INFO - Main Display: Yes 21:28:28 INFO - Mirror: Off 21:28:28 INFO - Online: Yes 21:28:28 INFO - Rotation: Supported 21:28:28 INFO - Return code: 0 21:28:28 INFO - Running post-action listener: _resource_record_post_action 21:28:28 INFO - [mozharness: 2016-12-15 05:28:28.856401Z] Finished run-tests step (success) 21:28:28 INFO - Running post-run listener: _resource_record_post_run 21:28:28 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 2330624; Write bytes: 550210048; Read time: 23; Write time: 1659 21:28:28 INFO - TinderboxPrint: CPU usage
53.5% 21:28:28 INFO - TinderboxPrint: I/O read bytes / time
2,330,624 / 23 21:28:28 INFO - TinderboxPrint: I/O write bytes / time
550,210,048 / 1,659 21:28:28 INFO - TinderboxPrint: CPU idle
2,240.3 (46.5%) 21:28:28 INFO - TinderboxPrint: CPU system
959.4 (19.9%) 21:28:28 INFO - TinderboxPrint: CPU user
1,614.0 (33.5%) 21:28:28 INFO - TinderboxPrint: Swap in / out
251,920,384 / 0 21:28:28 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 236933632; Write bytes: 232920064; Read time: 17052; Write time: 476 21:28:28 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 1466368; Write bytes: 295523840; Read time: 19; Write time: 1140 21:28:29 INFO - Running post-run listener: _upload_blobber_files 21:28:29 INFO - Blob upload gear active. 21:28:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:28:29 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 21:28:29 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:28:29 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:28:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:31 INFO - (blobuploader) - INFO - Done attempting. 21:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:32 INFO - (blobuploader) - INFO - Done attempting. 21:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:34 INFO - (blobuploader) - INFO - Done attempting. 21:28:34 INFO - (blobuploader) - INFO - Iteration through files over. 21:28:34 INFO - Return code: 0 21:28:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:28:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:28:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7edc9ca157799c78a931b1112668811ae5920a649000bced3de93a472c35362cbcb19f5342831bf567d7e064c71a7b2d2175368f4ef4fb8e3c64c7acd51a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99de57e95cc47a8a8cec23579b24581647c18626f628937c46b38ce2a998a5318586abc7c5a6c264cad770ca918aa08ec7ab0ffecdfc8f2ab03a2eecf26d779", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f9e4d66ff83808bbf5aebe803ab05ddb0ab504fe03ea4178e2271afed4cafad0046a27cd6d628ba3dba5d3901e9b73d220051bba051f4e03619c82ac2e8834"} 21:28:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:28:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:28:34 INFO - Contents: 21:28:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7edc9ca157799c78a931b1112668811ae5920a649000bced3de93a472c35362cbcb19f5342831bf567d7e064c71a7b2d2175368f4ef4fb8e3c64c7acd51a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99de57e95cc47a8a8cec23579b24581647c18626f628937c46b38ce2a998a5318586abc7c5a6c264cad770ca918aa08ec7ab0ffecdfc8f2ab03a2eecf26d779", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f9e4d66ff83808bbf5aebe803ab05ddb0ab504fe03ea4178e2271afed4cafad0046a27cd6d628ba3dba5d3901e9b73d220051bba051f4e03619c82ac2e8834"} 21:28:34 INFO - Running post-run listener: copy_logs_to_upload_dir 21:28:34 INFO - Copying logs to upload dir... 21:28:34 INFO - mkdir: /builds/slave/test/build/upload/logs 21:28:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.845778 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-14 21:28:34.401873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 21:28:34.405193) ========= 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.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/Firefox/sha512/4f7edc9ca157799c78a931b1112668811ae5920a649000bced3de93a472c35362cbcb19f5342831bf567d7e064c71a7b2d2175368f4ef4fb8e3c64c7acd51a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99de57e95cc47a8a8cec23579b24581647c18626f628937c46b38ce2a998a5318586abc7c5a6c264cad770ca918aa08ec7ab0ffecdfc8f2ab03a2eecf26d779", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f9e4d66ff83808bbf5aebe803ab05ddb0ab504fe03ea4178e2271afed4cafad0046a27cd6d628ba3dba5d3901e9b73d220051bba051f4e03619c82ac2e8834"} build_url:https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/XI1mLPT9T0KFTWQbHSAhaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7edc9ca157799c78a931b1112668811ae5920a649000bced3de93a472c35362cbcb19f5342831bf567d7e064c71a7b2d2175368f4ef4fb8e3c64c7acd51a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99de57e95cc47a8a8cec23579b24581647c18626f628937c46b38ce2a998a5318586abc7c5a6c264cad770ca918aa08ec7ab0ffecdfc8f2ab03a2eecf26d779", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f9e4d66ff83808bbf5aebe803ab05ddb0ab504fe03ea4178e2271afed4cafad0046a27cd6d628ba3dba5d3901e9b73d220051bba051f4e03619c82ac2e8834"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 21:28:34.440324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:28:34.440660) ========= 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.tLj0j259ku/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.YdyfEZDGJr/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:28:34.489665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 21:28:34.490014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 21:28:34.490328) ========= ========= Total master_lag: 3.95 =========