builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1480492520.74 results: success (0) buildid: 20161129205059 builduid: 809270ef4bb14ebaa35d08052cb88d84 revision: 34c73c520f938e66c312dfe83bdd944c6363facc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:20.738551) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:20.739035) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:20.739320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:20.780171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 23:55:20.780573) ========= 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.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-29 23:55:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2016-11-29 23:55:20 (20.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141346 ========= master_lag: 1.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 23:55:22.547866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:22.551244) ========= 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.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.028118 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:22.602263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 23:55:22.602615) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 34c73c520f938e66c312dfe83bdd944c6363facc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 34c73c520f938e66c312dfe83bdd944c6363facc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-29 23:55:22,696 truncating revision to first 12 chars 2016-11-29 23:55:22,696 Setting DEBUG logging. 2016-11-29 23:55:22,696 attempt 1/10 2016-11-29 23:55:22,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/34c73c520f93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 23:55:24,262 unpacking tar archive at: mozilla-beta-34c73c520f93/testing/mozharness/ program finished with exit code 0 elapsedTime=1.829897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 23:55:24.456360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:24.456690) ========= script_repo_revision: 34c73c520f938e66c312dfe83bdd944c6363facc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:24.457260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:24.457534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 23:55:24.477719) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-29 23:55:24.478102) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:55:24 INFO - MultiFileLogger online at 20161129 23:55:24 in /builds/slave/test 23:55:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:55:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:55:24 INFO - {'append_to_log': False, 23:55:24 INFO - 'base_work_dir': '/builds/slave/test', 23:55:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:55:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:55:24 INFO - 'branch': 'Mozilla-Beta', 23:55:24 INFO - 'buildbot_json_path': 'buildprops.json', 23:55:24 INFO - 'config_files': ('talos/mac_config.py',), 23:55:24 INFO - 'default_actions': ('clobber', 23:55:24 INFO - 'read-buildbot-config', 23:55:24 INFO - 'download-and-extract', 23:55:24 INFO - 'populate-webroot', 23:55:24 INFO - 'create-virtualenv', 23:55:24 INFO - 'install', 23:55:24 INFO - 'run-tests'), 23:55:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:55:24 INFO - 'download_minidump_stackwalk': True, 23:55:24 INFO - 'download_symbols': 'ondemand', 23:55:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:55:24 INFO - 'tooltool.py': '/tools/tooltool.py', 23:55:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:55:24 INFO - '/tools/misc-python/virtualenv.py')}, 23:55:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:55:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:55:24 INFO - 'installer_path': 'installer.exe', 23:55:24 INFO - 'log_level': 'info', 23:55:24 INFO - 'log_name': 'talos', 23:55:24 INFO - 'log_to_console': True, 23:55:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:55:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:55:24 INFO - 'opt_config_files': (), 23:55:24 INFO - 'pip_index': False, 23:55:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:55:24 INFO - 'cmd': ('bash', 23:55:24 INFO - '-c', 23:55:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:55:24 INFO - 'enabled': True, 23:55:24 INFO - 'halt_on_failure': False, 23:55:24 INFO - 'name': 'check_screen_resolution'},), 23:55:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:55:24 INFO - 'cmd': ('bash', 23:55:24 INFO - '-c', 23:55:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:55:24 INFO - 'enabled': True, 23:55:24 INFO - 'halt_on_failure': False, 23:55:24 INFO - 'name': 'check_screen_resolution'},), 23:55:24 INFO - 'run_cmd_checks_enabled': True, 23:55:24 INFO - 'sps_profile': False, 23:55:24 INFO - 'sps_profile_interval': 0, 23:55:24 INFO - 'suite': 'dromaeojs', 23:55:24 INFO - 'system_bits': '32', 23:55:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:55:24 INFO - 'title': 't-yosemite-r7-0025', 23:55:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:55:24 INFO - 'use_talos_json': True, 23:55:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:55:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:55:24 INFO - 'work_dir': 'build'} 23:55:24 INFO - [mozharness: 2016-11-30 07:55:24.678042Z] Running clobber step. 23:55:24 INFO - Running pre-action listener: _resource_record_pre_action 23:55:24 INFO - Running main action method: clobber 23:55:24 INFO - rmtree: /builds/slave/test/build 23:55:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:55:26 INFO - Running post-action listener: _resource_record_post_action 23:55:26 INFO - [mozharness: 2016-11-30 07:55:26.945465Z] Finished clobber step (success) 23:55:26 INFO - [mozharness: 2016-11-30 07:55:26.945619Z] Running read-buildbot-config step. 23:55:26 INFO - Running pre-action listener: _resource_record_pre_action 23:55:26 INFO - Running main action method: read_buildbot_config 23:55:26 INFO - Using buildbot properties: 23:55:26 INFO - { 23:55:26 INFO - "project": "", 23:55:26 INFO - "product": "firefox", 23:55:26 INFO - "script_repo_revision": "production", 23:55:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 23:55:26 INFO - "repository": "", 23:55:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 23:55:26 INFO - "buildid": "20161129205059", 23:55:26 INFO - "pgo_build": "False", 23:55:26 INFO - "basedir": "/builds/slave/test", 23:55:26 INFO - "buildnumber": 2, 23:55:26 INFO - "slavename": "t-yosemite-r7-0025", 23:55:26 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 23:55:26 INFO - "platform": "yosemite_r7", 23:55:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:55:26 INFO - "branch": "mozilla-beta", 23:55:26 INFO - "repo_path": "releases/mozilla-beta", 23:55:26 INFO - "revision": "34c73c520f938e66c312dfe83bdd944c6363facc", 23:55:26 INFO - "stage_platform": "macosx64", 23:55:26 INFO - "builduid": "809270ef4bb14ebaa35d08052cb88d84", 23:55:26 INFO - "slavebuilddir": "test" 23:55:26 INFO - } 23:55:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 23:55:26 INFO - Running post-action listener: _resource_record_post_action 23:55:26 INFO - [mozharness: 2016-11-30 07:55:26.948891Z] Finished read-buildbot-config step (success) 23:55:26 INFO - [mozharness: 2016-11-30 07:55:26.949073Z] Running download-and-extract step. 23:55:26 INFO - Running pre-action listener: _resource_record_pre_action 23:55:26 INFO - Running main action method: download_and_extract 23:55:26 INFO - mkdir: /builds/slave/test/build/tests 23:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:26 INFO - trying https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 23:55:26 INFO - Downloading https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 23:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 23:55:27 INFO - Downloaded 1165 bytes. 23:55:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 23:55:27 INFO - Using the following test package requirements: 23:55:27 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 23:55:27 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 23:55:27 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 23:55:27 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 23:55:27 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 23:55:27 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 23:55:27 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 23:55:27 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 23:55:27 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 23:55:27 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 23:55:27 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 23:55:27 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 23:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 23:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 23:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 23:55:28 INFO - Expected file size: 16233249 23:55:35 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 23:55:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 23:55:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 23:55:35 INFO - Fetch https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 23:55:35 INFO - Expected file size: 16233249 23:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 23:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 23:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 23:55:43 INFO - Expected file size: 14414089 23:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:43 INFO - trying https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg 23:55:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 23:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 23:55:46 INFO - Downloaded 86055582 bytes. 23:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg 23:55:46 INFO - mkdir: /builds/slave/test/properties 23:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 23:55:46 INFO - Contents: 23:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg 23:55:46 INFO - Running post-action listener: _resource_record_post_action 23:55:46 INFO - Running post-action listener: set_extra_try_arguments 23:55:46 INFO - [mozharness: 2016-11-30 07:55:46.904132Z] Finished download-and-extract step (success) 23:55:46 INFO - [mozharness: 2016-11-30 07:55:46.904302Z] Running populate-webroot step. 23:55:46 INFO - Running pre-action listener: _resource_record_pre_action 23:55:46 INFO - Running main action method: populate_webroot 23:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:55:46 INFO - '--tppagecycles', 23:55:46 INFO - '7'], 23:55:46 INFO - 'tests': ['tsvgm']}}, 23:55:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:55:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:55:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:55:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['damp', 'tps']}, 23:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'tests': ['damp', 'tps']}, 23:55:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['dromaeo_dom']}, 23:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:55:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['basic_compositor_video']}, 23:55:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:55:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'other-e10s': {'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['a11yr', 23:55:46 INFO - 'ts_paint', 23:55:46 INFO - 'tpaint', 23:55:46 INFO - 'sessionrestore', 23:55:46 INFO - 'sessionrestore_no_auto_restore', 23:55:46 INFO - 'tabpaint']}, 23:55:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['tsvgx', 23:55:46 INFO - 'tsvgr_opacity', 23:55:46 INFO - 'tart', 23:55:46 INFO - 'tscrollx', 23:55:46 INFO - 'cart']}, 23:55:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:55:46 INFO - 'tsvgr_opacity', 23:55:46 INFO - 'tart', 23:55:46 INFO - 'tscrollx', 23:55:46 INFO - 'cart']}, 23:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'talos_options': ['--disable-e10s'], 23:55:46 INFO - 'tests': ['tp5o']}, 23:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'tests': ['tp5o']}, 23:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'talos_options': ['--disable-e10s', 23:55:46 INFO - '--xperf_path', 23:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:46 INFO - 'tests': ['tp5n']}, 23:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:46 INFO - 'talos_options': ['--xperf_path', 23:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:46 INFO - 'tests': ['tp5n']}}, 23:55:46 INFO - 'talos.zip': {'path': '', 23:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:55:46 INFO - Running post-action listener: _resource_record_post_action 23:55:46 INFO - [mozharness: 2016-11-30 07:55:46.922813Z] Finished populate-webroot step (success) 23:55:46 INFO - [mozharness: 2016-11-30 07:55:46.922898Z] Running create-virtualenv step. 23:55:46 INFO - Running pre-action listener: _resource_record_pre_action 23:55:46 INFO - Running main action method: create_virtualenv 23:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 23:55:46 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 23:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:55:47 INFO - Using real prefix '/tools/python27' 23:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 23:55:50 INFO - Installing pip.................done. 23:55:50 INFO - Return code: 0 23:55:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:55:50 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')]} 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 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')]} 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:55:50 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 23:55:50 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 23:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:50 INFO - 'HOME': '/Users/cltbld', 23:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:50 INFO - 'LOGNAME': 'cltbld', 23:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:50 INFO - 'MOZ_NO_REMOTE': '1', 23:55:50 INFO - 'NO_EM_RESTART': '1', 23:55:50 INFO - 'PAGER': '/bin/cat', 23:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:50 INFO - 'PWD': '/builds/slave/test', 23:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:50 INFO - 'SHELL': '/bin/bash', 23:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:55:50 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:50 INFO - 'USER': 'cltbld', 23:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:50 INFO - 'XPC_FLAGS': '0x0', 23:55:50 INFO - 'XPC_SERVICE_NAME': '0', 23:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:50 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 23:55:50 INFO - Cleaning up... 23:55:50 INFO - Return code: 0 23:55:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:55:50 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')]} 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 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')]} 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:55:50 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 23:55:50 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 23:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:50 INFO - 'HOME': '/Users/cltbld', 23:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:50 INFO - 'LOGNAME': 'cltbld', 23:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:50 INFO - 'MOZ_NO_REMOTE': '1', 23:55:50 INFO - 'NO_EM_RESTART': '1', 23:55:50 INFO - 'PAGER': '/bin/cat', 23:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:50 INFO - 'PWD': '/builds/slave/test', 23:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:50 INFO - 'SHELL': '/bin/bash', 23:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:55:50 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:50 INFO - 'USER': 'cltbld', 23:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:50 INFO - 'XPC_FLAGS': '0x0', 23:55:50 INFO - 'XPC_SERVICE_NAME': '0', 23:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:51 INFO - Downloading/unpacking psutil>=3.1.1 23:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:54 INFO - Installing collected packages: psutil 23:55:54 INFO - Running setup.py install for psutil 23:55:54 INFO - building 'psutil._psutil_osx' extension 23:55:54 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 23:55:55 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 23:55:55 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 23:55:55 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 23:55:55 INFO - building 'psutil._psutil_posix' extension 23:55:55 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 23:55:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:55:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:55:55 INFO - ^ 23:55:55 INFO - 1 warning generated. 23:55:55 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 23:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:55 INFO - Successfully installed psutil 23:55:55 INFO - Cleaning up... 23:55:56 INFO - Return code: 0 23:55:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:55: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')]} 23:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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')]} 23:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:55: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 mozsystemmonitor==0.3 23:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:56 INFO - 'HOME': '/Users/cltbld', 23:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:56 INFO - 'LOGNAME': 'cltbld', 23:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:56 INFO - 'MOZ_NO_REMOTE': '1', 23:55:56 INFO - 'NO_EM_RESTART': '1', 23:55:56 INFO - 'PAGER': '/bin/cat', 23:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:56 INFO - 'PWD': '/builds/slave/test', 23:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:56 INFO - 'SHELL': '/bin/bash', 23:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:55:56 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:56 INFO - 'USER': 'cltbld', 23:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:56 INFO - 'XPC_FLAGS': '0x0', 23:55:56 INFO - 'XPC_SERVICE_NAME': '0', 23:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:55:59 INFO - Installing collected packages: mozsystemmonitor 23:55:59 INFO - Running setup.py install for mozsystemmonitor 23:55:59 INFO - Successfully installed mozsystemmonitor 23:55:59 INFO - Cleaning up... 23:55:59 INFO - Return code: 0 23:55:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:55:59 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')]} 23:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:59 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')]} 23:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:59 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:55:59 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 23:55:59 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 23:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:59 INFO - 'HOME': '/Users/cltbld', 23:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:59 INFO - 'LOGNAME': 'cltbld', 23:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:59 INFO - 'MOZ_NO_REMOTE': '1', 23:55:59 INFO - 'NO_EM_RESTART': '1', 23:55:59 INFO - 'PAGER': '/bin/cat', 23:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:59 INFO - 'PWD': '/builds/slave/test', 23:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:59 INFO - 'SHELL': '/bin/bash', 23:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:55:59 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:59 INFO - 'USER': 'cltbld', 23:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:59 INFO - 'XPC_FLAGS': '0x0', 23:55:59 INFO - 'XPC_SERVICE_NAME': '0', 23:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:59 INFO - Downloading/unpacking jsonschema==2.5.1 23:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:56:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:56:02 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 23:56:02 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 23:56:02 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 23:56:02 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 23:56:02 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 23:56:02 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 23:56:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:56:02 INFO - warning: no files found matching '*.txt' 23:56:02 INFO - no previously-included directories found matching 'build' 23:56:02 INFO - no previously-included directories found matching 'dist' 23:56:02 INFO - no previously-included directories found matching '.git*' 23:56:02 INFO - Installing collected packages: jsonschema, functools32 23:56:02 INFO - Running setup.py install for functools32 23:56:02 INFO - warning: no files found matching '*.txt' 23:56:02 INFO - no previously-included directories found matching 'build' 23:56:02 INFO - no previously-included directories found matching 'dist' 23:56:02 INFO - no previously-included directories found matching '.git*' 23:56:02 INFO - Successfully installed jsonschema functools32 23:56:02 INFO - Cleaning up... 23:56:02 INFO - Return code: 0 23:56:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:02 INFO - 'HOME': '/Users/cltbld', 23:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:02 INFO - 'LOGNAME': 'cltbld', 23:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:02 INFO - 'MOZ_NO_REMOTE': '1', 23:56:02 INFO - 'NO_EM_RESTART': '1', 23:56:02 INFO - 'PAGER': '/bin/cat', 23:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:02 INFO - 'PWD': '/builds/slave/test', 23:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:02 INFO - 'SHELL': '/bin/bash', 23:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:02 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:02 INFO - 'USER': 'cltbld', 23:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:02 INFO - 'XPC_FLAGS': '0x0', 23:56:02 INFO - 'XPC_SERVICE_NAME': '0', 23:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:56:03 INFO - Cleaning up... 23:56:03 INFO - Return code: 0 23:56:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:03 INFO - 'HOME': '/Users/cltbld', 23:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:03 INFO - 'LOGNAME': 'cltbld', 23:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:03 INFO - 'MOZ_NO_REMOTE': '1', 23:56:03 INFO - 'NO_EM_RESTART': '1', 23:56:03 INFO - 'PAGER': '/bin/cat', 23:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:03 INFO - 'PWD': '/builds/slave/test', 23:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:03 INFO - 'SHELL': '/bin/bash', 23:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:03 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:03 INFO - 'USER': 'cltbld', 23:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:03 INFO - 'XPC_FLAGS': '0x0', 23:56:03 INFO - 'XPC_SERVICE_NAME': '0', 23:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:56:03 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 23:56:03 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 23:56:03 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 23:56:03 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 23:56:03 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 23:56:03 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 23:56:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:56:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:56:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:06 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 23:56:07 INFO - Downloading docopt-0.6.1.tar.gz 23:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 23:56:07 INFO - Running setup.py install for blobuploader 23:56:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:56:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:56:07 INFO - Running setup.py install for requests 23:56:08 INFO - Running setup.py install for docopt 23:56:08 INFO - Successfully installed blobuploader requests docopt 23:56:08 INFO - Cleaning up... 23:56:08 INFO - Return code: 0 23:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56: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')]} 23:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56: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')]} 23:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:08 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:08 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 23:56:08 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 23:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:08 INFO - 'HOME': '/Users/cltbld', 23:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:08 INFO - 'LOGNAME': 'cltbld', 23:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:08 INFO - 'MOZ_NO_REMOTE': '1', 23:56:08 INFO - 'NO_EM_RESTART': '1', 23:56:08 INFO - 'PAGER': '/bin/cat', 23:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:08 INFO - 'PWD': '/builds/slave/test', 23:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:08 INFO - 'SHELL': '/bin/bash', 23:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:08 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:08 INFO - 'USER': 'cltbld', 23:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:08 INFO - 'XPC_FLAGS': '0x0', 23:56:08 INFO - 'XPC_SERVICE_NAME': '0', 23:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:56:08 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IFLnLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:56:08 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-k3U9J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:56:08 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-7tjB_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:56:08 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-XHr48R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:56:08 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-M7Mo1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-7Dk7Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tcWkuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9794_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-cimjnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-OF9r_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IeKkzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-2N7uvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5fhu8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-mSzWQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:09 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-3Abn8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:56:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-RjWfAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:56:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fbPmrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:56:10 INFO - Running setup.py install for manifestparser 23:56:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for mozcrash 23:56:10 INFO - Running setup.py install for mozdebug 23:56:10 INFO - Running setup.py install for mozdevice 23:56:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for mozfile 23:56:11 INFO - Running setup.py install for mozhttpd 23:56:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozinfo 23:56:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozInstall 23:56:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozleak 23:56:11 INFO - Running setup.py install for mozlog 23:56:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for moznetwork 23:56:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozprocess 23:56:12 INFO - Running setup.py install for mozprofile 23:56:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:56:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:56:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:56:12 INFO - Running setup.py install for mozrunner 23:56:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:56:12 INFO - Running setup.py install for mozscreenshot 23:56:12 INFO - Running setup.py install for moztest 23:56:12 INFO - Running setup.py install for mozversion 23:56:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:56:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:56:12 INFO - Cleaning up... 23:56:12 INFO - Return code: 0 23:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56: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')]} 23:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:13 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:13 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 23:56:13 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 23:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:13 INFO - 'HOME': '/Users/cltbld', 23:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:13 INFO - 'LOGNAME': 'cltbld', 23:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:13 INFO - 'MOZ_NO_REMOTE': '1', 23:56:13 INFO - 'NO_EM_RESTART': '1', 23:56:13 INFO - 'PAGER': '/bin/cat', 23:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:13 INFO - 'PWD': '/builds/slave/test', 23:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:13 INFO - 'SHELL': '/bin/bash', 23:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:13 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:13 INFO - 'USER': 'cltbld', 23:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:13 INFO - 'XPC_FLAGS': '0x0', 23:56:13 INFO - 'XPC_SERVICE_NAME': '0', 23:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:56:13 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-iJzfzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:56:13 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)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:56:13 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-msUr6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:56:13 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Pvh_kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:56:13 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)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:56:13 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-T61ahZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:56:13 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wen7uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9CUDfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-KEWPXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-aG78qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-rwvjMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-AsKEi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Q_7USu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Vw9asX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-d9D1Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:56:14 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)) 23:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:56:14 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-TrbXI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-nboqd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:15 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)) 23:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:56:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-OE6QfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:56:15 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)) 23:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:56:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Y9ujO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:15 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)) 23:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:15 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)) 23:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:56:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:56:15 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 23:56:15 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 23:56:15 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 23:56:15 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 23:56:15 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 23:56:15 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 23:56:18 INFO - Downloading blessings-1.6.tar.gz 23:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:56:18 INFO - Installing collected packages: blessings 23:56:18 INFO - Running setup.py install for blessings 23:56:18 INFO - Successfully installed blessings 23:56:18 INFO - Cleaning up... 23:56:18 INFO - Return code: 0 23:56:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:18 INFO - Reading from file tmpfile_stdout 23:56:18 INFO - Current package versions: 23:56:18 INFO - blessings == 1.6 23:56:18 INFO - blobuploader == 1.2.4 23:56:18 INFO - docopt == 0.6.1 23:56:18 INFO - functools32 == 3.2.3-2 23:56:18 INFO - jsonschema == 2.5.1 23:56:18 INFO - manifestparser == 1.1 23:56:18 INFO - mozInstall == 1.12 23:56:18 INFO - mozcrash == 0.17 23:56:18 INFO - mozdebug == 0.1 23:56:18 INFO - mozdevice == 0.48 23:56:18 INFO - mozfile == 1.2 23:56:18 INFO - mozhttpd == 0.7 23:56:18 INFO - mozinfo == 0.9 23:56:18 INFO - mozleak == 0.1 23:56:18 INFO - mozlog == 3.4 23:56:18 INFO - moznetwork == 0.27 23:56:18 INFO - mozprocess == 0.23 23:56:18 INFO - mozprofile == 0.28 23:56:18 INFO - mozrunner == 6.12 23:56:18 INFO - mozscreenshot == 0.1 23:56:18 INFO - mozsystemmonitor == 0.3 23:56:18 INFO - moztest == 0.7 23:56:18 INFO - mozversion == 1.4 23:56:18 INFO - psutil == 3.1.1 23:56:18 INFO - requests == 1.2.3 23:56:18 INFO - wsgiref == 0.1.2 23:56:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56: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')]} 23:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56: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')]} 23:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:18 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:18 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 23:56:18 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 23:56:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:18 INFO - 'HOME': '/Users/cltbld', 23:56:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:18 INFO - 'LOGNAME': 'cltbld', 23:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:18 INFO - 'MOZ_NO_REMOTE': '1', 23:56:18 INFO - 'NO_EM_RESTART': '1', 23:56:18 INFO - 'PAGER': '/bin/cat', 23:56:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:18 INFO - 'PWD': '/builds/slave/test', 23:56:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:18 INFO - 'SHELL': '/bin/bash', 23:56:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:18 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:18 INFO - 'USER': 'cltbld', 23:56:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:18 INFO - 'XPC_FLAGS': '0x0', 23:56:18 INFO - 'XPC_SERVICE_NAME': '0', 23:56:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 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)) 23:56:19 INFO - Cleaning up... 23:56:19 INFO - Return code: 0 23:56:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:19 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 0x10e348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff179d7ceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, '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.BaiaE2xhLy/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.Scbv5o8m20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 23:56:19 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 23:56:19 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 23:56:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:19 INFO - 'HOME': '/Users/cltbld', 23:56:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:19 INFO - 'LOGNAME': 'cltbld', 23:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:19 INFO - 'MOZ_NO_REMOTE': '1', 23:56:19 INFO - 'NO_EM_RESTART': '1', 23:56:19 INFO - 'PAGER': '/bin/cat', 23:56:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:19 INFO - 'PWD': '/builds/slave/test', 23:56:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:19 INFO - 'SHELL': '/bin/bash', 23:56:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:19 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:19 INFO - 'USER': 'cltbld', 23:56:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:19 INFO - 'XPC_FLAGS': '0x0', 23:56:19 INFO - 'XPC_SERVICE_NAME': '0', 23:56:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:56:19 INFO - Cleaning up... 23:56:19 INFO - Return code: 0 23:56:19 INFO - Running post-action listener: _resource_record_post_action 23:56:19 INFO - Running post-action listener: _start_resource_monitoring 23:56:19 INFO - Starting resource monitoring. 23:56:19 INFO - [mozharness: 2016-11-30 07:56:19.517797Z] Finished create-virtualenv step (success) 23:56:19 INFO - [mozharness: 2016-11-30 07:56:19.518835Z] Running install step. 23:56:19 INFO - Running pre-action listener: _resource_record_pre_action 23:56:19 INFO - Running main action method: install 23:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:19 INFO - Reading from file tmpfile_stdout 23:56:19 INFO - Detecting whether we're running mozinstall >=1.0... 23:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:56:19 INFO - Reading from file tmpfile_stdout 23:56:19 INFO - Output received: 23:56:19 INFO - Usage: mozinstall [options] installer 23:56:19 INFO - Options: 23:56:19 INFO - -h, --help show this help message and exit 23:56:19 INFO - -d DEST, --destination=DEST 23:56:19 INFO - Directory to install application into. [default: 23:56:19 INFO - "/builds/slave/test"] 23:56:19 INFO - --app=APP Application being installed. [default: firefox] 23:56:19 INFO - mkdir: /builds/slave/test/build/application 23:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 23:56:41 INFO - Reading from file tmpfile_stdout 23:56:41 INFO - Output received: 23:56:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:56:41 INFO - Running post-action listener: _resource_record_post_action 23:56:41 INFO - [mozharness: 2016-11-30 07:56:41.615861Z] Finished install step (success) 23:56:41 INFO - [mozharness: 2016-11-30 07:56:41.615986Z] Running run-tests step. 23:56:41 INFO - Running pre-action listener: _resource_record_pre_action 23:56:41 INFO - Running main action method: run_tests 23:56:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:56:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:56:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:56:41 INFO - 2016-11-29 23:56:41.630 screenresolution[1617:7617] starting screenresolution argv=screenresolution get 23:56:41 INFO - 2016-11-29 23:56:41.633 screenresolution[1617:7617] Display 0: 1600x1200x32@60 23:56:41 INFO - 2016-11-29 23:56:41.638 screenresolution[1618:7619] starting screenresolution argv=screenresolution list 23:56:41 INFO - Available Modes on Display 0 23:56:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:56:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:56:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:56:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:56:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:56:41 INFO - Intel Iris: 23:56:41 INFO - Chipset Model: Intel Iris 23:56:41 INFO - Type: GPU 23:56:41 INFO - Bus: Built-In 23:56:41 INFO - VRAM (Dynamic, Max): 1536 MB 23:56:41 INFO - Vendor: Intel (0x8086) 23:56:41 INFO - Device ID: 0x0a2e 23:56:41 INFO - Revision ID: 0x0009 23:56:41 INFO - Displays: 23:56:41 INFO - Display: 23:56:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:56:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:56:41 INFO - Display Serial Number: 1600x1200 60 23:56:41 INFO - Main Display: Yes 23:56:41 INFO - Mirror: Off 23:56:41 INFO - Online: Yes 23:56:41 INFO - Rotation: Supported 23:56:41 INFO - Return code: 0 23:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:56:41 INFO - Python 2.7.3 23:56:41 INFO - Return code: 0 23:56:41 INFO - grabbing minidump binary from tooltool 23:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:56:41 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 0x10e15cd30>, '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 0x10dfc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e154b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:56:41 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 23:56:41 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 23:56:41 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 23:56:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:56:41 INFO - Return code: 0 23:56:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:56:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:56:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:56:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:56:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 23:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --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 23:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaiaE2xhLy/Render', 23:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:42 INFO - 'HOME': '/Users/cltbld', 23:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:42 INFO - 'LOGNAME': 'cltbld', 23:56:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:56:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:42 INFO - 'MOZ_NO_REMOTE': '1', 23:56:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:56:42 INFO - 'NO_EM_RESTART': '1', 23:56:42 INFO - 'PAGER': '/bin/cat', 23:56:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:42 INFO - 'PWD': '/builds/slave/test', 23:56:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:42 INFO - 'SHELL': '/bin/bash', 23:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Scbv5o8m20/Listeners', 23:56:42 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 23:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:42 INFO - 'USER': 'cltbld', 23:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:42 INFO - 'XPC_FLAGS': '0x0', 23:56:42 INFO - 'XPC_SERVICE_NAME': '0', 23:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 23:56:42 INFO - mozversion application_buildid: 20161129205059 23:56:42 INFO - mozversion application_changeset: 34c73c520f938e66c312dfe83bdd944c6363facc 23:56:42 INFO - mozversion application_display_name: Firefox 23:56:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:56:42 INFO - mozversion application_name: Firefox 23:56:42 INFO - mozversion application_remotingname: firefox 23:56:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:56:42 INFO - mozversion application_vendor: Mozilla 23:56:42 INFO - mozversion application_version: 51.0 23:56:42 INFO - mozversion platform_buildid: 20161129205059 23:56:42 INFO - mozversion platform_changeset: 34c73c520f938e66c312dfe83bdd944c6363facc 23:56:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:56:42 INFO - mozversion platform_version: 51.0 23:56:42 INFO - using testdate: 1480492602 23:56:42 INFO - actual date: 1480492602 23:56:42 INFO - starting webserver on 'localhost:49241' 23:56:42 INFO - SUITE-START | Running 2 tests 23:56:42 INFO - TEST-START | dromaeo_css 23:56:42 INFO - operating with platform_type : mac_ 23:56:42 INFO - Initialising browser for dromaeo_css test... 23:56:42 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpjLuE17/profile http://localhost:49241/getInfo.html) 23:56:44 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 23:56:44 INFO - PROCESS | 1628 | colorDepth:24 23:56:44 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 23:56:44 INFO - PROCESS | 1628 | __metrics 23:56:44 INFO - PROCESS | 1628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:56:44 INFO - PROCESS | 1628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:56:45 INFO - TEST-INFO | 1628: exit 0 23:56:45 INFO - Browser initialized. 23:56:45 INFO - Running cycle 1/1 for dromaeo_css test... 23:56:45 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpjLuE17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:56:57 INFO - PROCESS | 1630 | RSS: Main: 168497152 23:56:57 INFO - PROCESS | 1630 | 23:57:48 INFO - PROCESS | 1630 | 1480492668871 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] 23:59:59 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 00:00:00 INFO - PROCESS | 1630 | RSS: Main: 325500928 00:00:00 INFO - PROCESS | 1630 | 00:03:03 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 00:03:04 INFO - PROCESS | 1630 | RSS: Main: 302759936 00:03:04 INFO - PROCESS | 1630 | 00:06:06 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 00:06:07 INFO - PROCESS | 1630 | RSS: Main: 265068544 00:06:07 INFO - PROCESS | 1630 | 00:09:09 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 00:09:10 INFO - PROCESS | 1630 | RSS: Main: 267169792 00:09:10 INFO - PROCESS | 1630 | 00:12:13 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 00:12:13 INFO - PROCESS | 1630 | RSS: Main: 261091328 00:12:13 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 00:15:17 INFO - PROCESS | 1630 | RSS: Main: 420679680 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | __start_tp_report 00:15:17 INFO - PROCESS | 1630 | _x_x_mozilla_page_load 00:15:17 INFO - PROCESS | 1630 | _x_x_mozilla_page_load_details 00:15:17 INFO - PROCESS | 1630 | |i|pagename|runs| 00:15:17 INFO - PROCESS | 1630 | |0;dojo.html;3466.1681196512836;3488.9476657850123;3489.790612563245;3515.8417871195793;3553.9111522211942;5763.769449222032;5835.299764028312;5851.8537036574;5886.852828679285;5888.617239879411;5814.941850581493;5873.618214816044;5882.941170588293;5890.234269544953;5906.793262235823;5251.973740131294;5292.36491621006;5350.839474815762;5356.812511562096;5357.812476563321;5252.894942101156;5254.0805359062015;5274.4198138204765;5405.459454054583;5413.512783849453;5240.44975277596;5286.65636733613;5312.760925758331;5318.282031925699;5323.707196104213;5293.52358287754;5383.596230282745;5391.406945236021;5399.757010934517;5429.53848922842;4851.781669824866;5175.637705360627;5259.86850328741;5302.416734159239;5329.22726204702;5712.942870571283;5759.827205183851;5768.278965129359;5781.88436231273;5821.476067153976;6244.406781355764;6261.561690681654;6274;6294.590851594632;6306.337834527354;6262.78080267193;6263.96868015657;6265.530085243625;6269.216347956505;6274.623522588659;5788.189653448479;5836.649801011868;5842.795502157446;5866.530677545786;5983.850403739942;6294.402031806971;6334.714937827809;6356.555041147075;6360.363963603602;6366.9681651591445;6224.159738435344;6227.408396202353;6237.625742455467;6250.9062364064575;6262.279837818709;6143.539234557426;6180.783672571439;6185.567010309325;6237.126802247689;6259.123722678829;6216.316205217422;6281.183446152062;6282.183316168869;6302.369763023753;6311.842203944938;6275.6548389839;6301.8109456716375;6321.336259692758;6327.873442531216;6335.1447554579545;4994.750262486861;5031.823886163967;5036.294918711384;5039.7228152451235;5117.437081920985;4468.9106217876115;4525.796339164745;4556.476005259371;4560;4565.954340456553;6013.609115407485;6015.368386319374;6018.578699490994;6020.247469066367;6024.849378765566;6132.448079672851;6186.1648677427975;6254.937450625435;6256.937430625727;6272.2473303203;5878.735456904364;5914.852128696731;5965.13505541694;5980.910286345708;6025.15647809307;5568.693721845338;5573.972130139324;5576.581756368289;5585.413531579207;5595.440455954454;6421.357864213542;6429.710663020175;6436.967815160988;6443.677816109176;6445.097686323918;5168.71572063525;6210.192674952227;6257.7184026719815;6276.560640755103;6282.780102696383;6310.116583678197;6368.044793281045;6373.521985850987;6464.385883341075;6472.805815825533;6259;6305.716242769178;6311.526635502264;6321.1782468278825;6328.841778955563;6200.193974783249;6254.906176407267;6264.31092579825;6278.6546739929745;6284.183056202847;6119.41115851624;6142.98993493194;6180.4746596538;6197.070439434121;6292.402221788922;6258.812235632939;6268.059791031382;6273;6287.371262873859;6289.96855015722;4724.102420540086;5960.761569537343;6084.939150608438;6131.386861313833;6149.2313460817395;6095.05526643371;6132.967444181115;6139.653888630618;6141.301904043499;6141.662208578392;6143.143438301211;6145.446909778141;6157.0456579230295;6162.661053642093;6169.598976066542 00:15:17 INFO - PROCESS | 1630 | |1;ext.html;463.6777439679422;498.84785140532125;503.25015726567415;528.936527616686;546.6965833962151;32538.02385928423;33644.49533257;35464.64535354649;42726.572734272646;43981.900452488626;45719.77140114303;46028;46052.76973615127;46156;46171.07657846841;10080.848787268178;10262.846057309109;10283;10284.640037598685;10300.536475858604;9332.253419726405;9577.61689532418;10074.647387341445;10233.539490722898;12287.631371058838;12346.567870124547;12587;12593.685157871036;12601.936990315036;12657.17728347659;12483.937580312086;12567.497300107985;12581.93709031449;12584.370781460937;12608.369581520887;12380.319082450462;12450;12463.563775267821;12474.376281185996;12479.376031198404;43056;43441;43443;43479;43528.347074793906;3377.9155521111925;3494.1614012636783;3665.2303016366595;3861.575226725058;3933.3706606943038;32064.839675801704;32145.839270803495;32544.440623738534;32546.837265813756;32826.3434731304;2841.971580284212;3347.7991320520605;3402.4896265560365;3414.453687410027;3429.9828500857584;378652;380798;380939.9999999972;381208;382421;35368.11579710528;64272.357276427574;64621.67689161524;64732.02901956475;64766.35233647697;36059.639403606154;37769;37818.43272350917;37829.432558511646;37866.8106659465;15782.368705251662;15948.521544353687;15967.44113956006;15973.680526389408;16024.919875400781;11324.263922844988;13286.933565332305;13369.66575835612;13382.197068175941;13386.464541418234;7151.2848715128075;7633.923660763321;7849.332806711379;7930.048394192734;8285.378596605278;3350.095474221995;3393.5927688677516;3393.694567488938;3396.252824378633;3423.8288085595623;1015.3552494166257;1041.2919214933765;1048.030621064329;1130.8982191602795;1139.8119310313705;30811;31102.377952440824;31178.688213117577;31649;31744.206394840312;956.268454632207;1071.3786004117594;1092.382803715898;1143.3882872663085;1184.703824043989;15699.607509812118;16345.591360216089;16385.42651007209;16401.58996025109;16677.24952377146;717264;726354;726433;727428;729502;61336;62075.06887396693;62149.37850621436;62154.37845621486;62155.689221553606;1308.5223893278885;1329.6409969308233;1416.3060100550656;1442.6898216883421;1445.7975883376125;31979.520307195875;32043.198920027186;32806.67193328036;32891.671083288864;33394;51829.7408512955;52399;52405.47594524158;52442.95114097773;52473;588781;590862;592248;707689;728494;44094.89762755957;44475.77762111298;44629.77685111554;45127.32309015302;45249.77375113103;46993.29510057283;48114.759426204044;48307.75846120747;48908.510914890394;49623.25565116454;39400.24198306091;39532;40464.59535404608;41139.49857289196;41683.58316416797;40463.797681011405;40566.39150412687;40595.59404405918;41769.373459397524;41872.53446129371;39004.02489937774;39334.60665393309;39835.80082099571;39922.600773991886;40355;27821;30135.698643014166;33416.1645958853;33446.49830252597;35440.29119417649;21039.78960210378;21876.45308867291;26345.473090538464;26392.8680356597;26594.74671669772 00:15:17 INFO - PROCESS | 1630 | |2;jquery.html;367.3222903742594;371.12970085150323;373.9439084137379;383.1742594708404;392.24688597892043;19973.500662483446;21104.472388190305;21838.01728922198;22698.659520107212;22926.85365731715;20416.183352665874;21283;21378.46553836155;21581.56836863262;21678.024488897998;5599.972000140004;6013.639181649093;6256.343083976185;6338.271098823625;6372.808815735512;5827.213326200951;5996.045797040806;6319.684015799215;6370.458511026545;6388.936110638904;7008.19405768338;7058;7063.328983746535;7064.540804847668;7081.822954426155;6351.333110023427;6402.327755585643;6405.327440618715;6451.225852897659;7024.438044956417;5095.235714642833;5968.134620480006;6229.3459186785185;6233.844153896143;6236.688165591702;13785.655358616015;14021.369038393195;14231.857681423156;14258.358373873201;14262.286885655676;2381.5951288281035;2388.3073908566494;2422.2248880358293;2599.140276689115;2657.9335516612045;10134.949325253401;10233.232507561963;10314.432706201156;10624.840627390595;10761.408122553257;1672.765812786211;1839.5125291797685;1939.350317643591;1954.8631595788302;2007.5282308657454;79447.6027619864;79885.80171297435;80746.59626701887;114657;121383;10071.496425178711;11672.824907626393;11906.404679765978;11927.403629818475;12045.698857528456;15356.769648455282;15380;15388.076715396888;15400.383984640488;15463.304151313218;8820.294376449869;9052.230560402308;9074.228690561376;9095.454272743656;9240.8613870792;9062.546872656341;9064.410813297114;9089.409188402733;9208.217301529312;9222.723318300461;4662.813487460531;4666.370040044619;4666.603338716247;4675.4155730533685;4724.149653062482;1689.8056723476711;1947.5033866363985;2002.3792624286518;2005.1277694203068;2006.9598608027757;870.2472361407337;931.9860202096974;982.9066238707311;985.669800616787;1020.2450186861669;14099.718005640036;22208.55582888333;22422.887885560467;22503.324900253017;22600.434989125075;937.6858752317913;958.7679831416735;964.5996911281879;970.5729479029204;1003.9358280222987;8311;11258.831117533244;11927.940360298144;11929.28424294545;11949;628227.8588607119;634525;637381;649212;653186;129527;130395;134988;135830.32084839512;137001.31499342638;972.6206779356057;1038.7039693687263;1069.9144068474504;1070.400575677623;1073.9731506712394;19149.521261968563;19446.51383715362;19872.205111795367;19886.005699715246;19930.302439415133;38377.80811095927;53308.667283318224;55706.44293557013;55847.441525584225;56861;78682.60658696669;80340.19659803328;81241.18758812336;81250;81376.18623813686;7151.749688760869;7480.70077196906;8103.635336409758;8357.164283571594;8673.82652346937;10105.292629515863;10897;11056.391898445663;13665.043446958618;13793.758466760504;9467;9712.805743885225;11482.196246263016;11568.363739994382;12028.917397434272;11358.54565817391;11404.201705880509;11626.069914406997;11635.883641163819;11673.299602023906;9925.404475731479;11609.129315301218;11853.466594003117;12003.63989080329;12167.33079680626;8293.709720159766;8320.375971802017;8747.387682862138;8780.912190878009;8834.779130521789;4768.880777980439;9348.345615806827;11273.943630281796;11617.302961822317;11652.310414989948 00:15:17 INFO - PROCESS | 1630 | |3;mootools.html;1406.3319923036552;1504.7517159668653;1543.5909483986745;1796.3622913865577;1964.8624596278248;8050.557219352933;8581.656733730642;8586.09845966174;8588.613512391941;8594.527300998443;8670.349723770727;8934.955325223365;8948.731538053853;9088.909110908906;9095.454272743624;2418.455847434326;2452.2221389492565;2452.2765784093735;2452.5708001099824;2454.901803927841;2391.330427480308;2430.902763889442;2431.197704757426;2436.0986435019067;2448.90204391825;2395.9041638334447;2410.710714714237;2423.297243799296;2430.5138972205627;2431.051889762994;2376.560336337766;2392.928212153638;2405.6391541268777;2406.651035599837;2417.9153729619557;2387.570237357275;2412;2416.9274921752376;2417.5890098683267;2417.97582024181;8979.416337938013;9072.727818165466;9103.271738260923;9116.954415227949;9118.635254589808;4929.679570827885;5307.52232299095;5420.24116623673;5577.498025177713;5593.216949627014;3299.554560134375;3624.673779359844;3727.1613886875507;3793.393057110849;3808.6762625176616;1117.7261570915095;1117.7317443813508;1120.7142178744368;1147.4205526209212;1149.5804031528517;8869.645214191425;11859.466324015353;11919.344436056013;12023.218490798157;12144.696382590417;4554.24854898938;4561.178987782231;4767.713937163781;4769.880752981203;4774.092922344744;9418.340716149803;9489.098535639103;9506.239500839916;9517.143457088756;9560.760980975392;5415.187721841755;5424.538914192338;5429.375621803543;5435.728213589305;5440.455954404528;4319.762413067248;4594.425696787902;4745.83389581363;4746.691465054761;5093.592512598983;3893.3575959966856;3934.15415685629;3986.262541429845;4027.932597861569;4040.41413994975;1167.8511538768707;1180.6103985684874;1181.6824240971255;1188.3879801902028;1192.9940350298193;847.9067302596709;857.1171693156059;923.2890674180843;928.9442633442015;958.4872093429982;5762;5853.590248682636;5874.471297583153;6041.667708276087;6166.630002199882;449.10179640718565;455.3647661512172;467.6212268062812;469.8238160689741;471.07433892401593;3938.8424463021734;4017.972012746702;4060.4112403701297;4113.280175969194;4150.91698166041;8575.614097365633;11082.22424430282;11083.390413527171;11092.722681932855;11098.722531936766;10963.671089867317;10997.175211859143;11024.44877756125;11024.952629500185;11026.944865275622;8021.759347219593;8346.457480263885;8470.068292487822;8513.82972340562;8661.090585488684;5113.158012723127;5949.970250148895;5965.761369545169;6210.689465526796;6279.937200627935;10215.438150901771;10258.58965641366;10407.271490995558;10478.947605261925;10484.737881553023;9733.464659443798;10075.09324160829;10253.538590763284;10340.069393754296;10719.035286824223;7097.964510177416;7476.214997425192;7593.126790418952;7636.236376362319;7643.082830060428;8738.300935925237;8753.037165911617;8838.734837954871;8851.557422128997;8857.33569982241;7725.5364678119495;7831.295183433518;7881.881771773543;7938.483998540308;8034.87947680797;6681.198256209286;7631.1605723371495;7676.15562288159;7703.922960770321;7835.921640783519;7024.192217894803;7230.819229519304;7233.0597022386755;7244.094488188976;7250.238724933806;4452.443444569429;5076.568491678101;5111.361079865017;5160.045391602565;5168.121419358643;4998.350214472095;5122.359705036871;5133.358330208724;5251.501107394792;5289.497497737709 00:15:17 INFO - PROCESS | 1630 | |4;prototype.html;283.7233697145283;310.9207152176196;317.9602699173702;324.9983750081249;325.2632786738037;4469.553044695529;5249.790008399665;5318.414974352818;5393.622446428747;5408.35099788025;4266.2534056540135;4464.642828573715;4921.188003979348;5225.738713064351;5269.841904742864;4106.240345536071;4169.437125987991;4184.95376155961;4190.569469707578;4204.32730763078;4138.793060346986;4159.812808423613;4159.916801663965;4193.412922190896;4195.958040419588;4011.97994010031;4146.606072423115;4169.687273454503;4169.955932169518;4204.2222188895;4137.275976704095;4138.551506972565;4165.312723400651;4174.415581818548;4195.307774217251;3660.6089685919446;3661.0528524537735;3661.707063434919;3662.1210909381557;3673.5040769496045;5106.591472682177;5244.527992480657;5299.311089558371;5314.202869569595;5351.304330437058;4506.278995360759;4659.6505262105475;4708.529147085298;4744.6441516886025;4787.234042553209;4895.5838753705975;4929.9154186079;5416.537534865603;5644.604877658566;5670.574706896958;3848.9408166630997;3990.0274295649638;4006.799660017017;4044.3529035354204;4072.328065869128;5856.824295271149;5917.958304384981;5919.5560332974765;5935.881282374328;5954.345022047614;4098.426220329156;4121.258173528794;4135.710500264952;4151.6886233532605;4151.813168407369;3998.7200895937585;4185.853495127656;4189.958100418957;4192.538820729717;4202.453681021509;3936.4216438233;4713.481517033192;4729.881752956204;4737.549932756383;4821.252705830602;5306;5352.912364177973;5660.85847853807;5669.32754837324;5732.512736417451;1313.2711345203504;1404.8199512409626;1415.801787749716;1418.3759145975944;1419.6025112968384;837.2459696934911;838.6100463284602;863.2921004776024;864.7838040489878;869.2350731356366;3847.0572360957535;3886.2796042770174;4461.263891457873;4461.7992190351515;4478.731276123443;4443.822247110144;4714.114354258256;4764.571188593043;4766.689160480895;4848.612111031109;3875.6705680017512;3915.4126880967515;4207.768572728468;4323.610875021263;4446.288179051024;2066.762322332921;2218.057325636598;2264.365977526262;2462.9803561079743;2553.387187075126;4115.012397024692;4337.41923555484;4604.595598342471;4992.926520798046;5012.974935125301;4433.379326894237;4654.790534425959;4828.961773218774;4858.2146585613145;4962.652614316963;4623.65322600813;4660.091282199938;4708.364370809897;4890.559849613481;5027.698338099725;4196.636093269639;4595.9310610341545;4764.475907650225;4768.092762894731;4851.223804191312;3689.8120633081107;4479.9328010079225;4586.610138138296;4636.559526844944;5251.711155886463;6116.296625887901;6140.600860944024;6151.32335443092;6165.445109940127;6185.721642526007;3388;3948.427478015729;3964.900877477971;3982.7012974026484;3995.1610161866333;5693.914591281217;5854.209681692917;5881.94118058831;5911.91132133027;5936.970315148396;5702.515286200553;5733.082706766897;5765.8558536036935;5778.56660750437;5841.474267315962;5727.1695604138;5747.19539264495;5762.884742305214;5775.94224057754;5832.270966129234;5372.731363431734;5389.353277606712;5578.581606379456;5658.349289831722;5663.461971112738;4878.853634390974;5647.774089036392;5673.333533239371;5684.459976302244;5808.273965754281;5655.321361436654;5673.971630141823;5678.659280443187;5683.2895888014;5724.169995350568 00:15:17 INFO - PROCESS | 1630 | |5;yui.html;703.4836350628958;736.2674139231465;769.5305863423307;787.425179618878;810.667626273228;15833;17059.14704264788;17065.48803535893;17073.060981646006;17078.743818842697;15523.767143492829;15595.298211580477;15615.297311620976;15620;15696.37214511421;716.6488420673859;735.3455424672046;736.282124928196;864.8572985457407;874.3529787956898;878.7056336127405;892.7589550821274;894.2130924786179;894.6376717429451;897.2014906733012;942.1238248428958;942.4722155592856;948.4356807699407;948.4735971535795;951.5717926932908;938.2025278513278;939.3471537281558;940.4216406909701;941.4022095969075;941.8869735631699;701.3302296307014;702.2731472925549;702.8348338140584;703.2053779229489;705.270045502902;16320.75518867218;16605.252763625667;16758.16209189548;16787.580310492336;16804.831951680448;13399.263040532767;13569;15330.846691533054;15556.922215388964;15615.063096214264;11897.405129743565;12243.265404075784;12428.254304741744;13328.400221990034;13686.247256400893;3991.7006224533275;4017.27689015977;4032.0927791247027;4034.536028356718;4110.23960567296;137133.62866371308;139282.60717392797;140844;142749.99999999895;144694;8993.685221017233;10134.797304053878;10231.43727095017;10651.733706657396;10730.356178629307;16153.353865845234;19400.611987760167;19408.4177474676;19434.319798806973;19468.123934422983;7928.246816552418;8241;8510.829783404297;8532.658693652184;8534.189252021048;4338.566143385636;4545.181867263925;4575.931361029588;4643.141018911512;4714.787834547454;3724.1434470071495;3844.5002149720917;3859.3439115349897;3864.6715029222833;3869.903252418712;597.4712379544135;668.4117976180929;673.0812441018073;675.2369822100994;686.1320429656489;485.33993768474846;546.9308345906443;621.316551793024;700;711.7402148215864;7985.72049978248;9214.98635150133;9709.087273817826;9734.513274336256;9917.057879501435;596.6748122273372;659.8119535932236;669.8325418645338;678.1252184681804;681.7443458702986;3972.5828787977425;4357.281048626941;4758;4786.210275304606;4789.904201915942;103887;103942.48028759808;116687;155823.44176558315;168226;156407;157248.64127038105;159019;159511;160688;120746;130343.87592868597;130782.69217307895;133159.33420332836;135829;9265.119813617695;9270.165685088105;9287.86068208991;9308.255339572683;9316.580753865957;72412;72456.63771681108;73351.63324183559;73701;74806.62596686982;63550.68224658847;69882;78131.21868781239;88651.67022494797;111928;13254.933725331312;13528.120672156278;13587.102019771366;13979.301034948008;14349.928250359098;13407.195568265935;13820.687034731684;15002.67244781253;15690.529284121494;15998.360065597246;13472.259025753678;13506;14966.625834353792;15038.924805375904;15065.924670376578;14290.785638215228;14411.42354305816;15013.324400401789;15226.695466090838;15505.767413489033;13128.949684025065;13718.794218086538;14601.123932563656;15141.924290378478;15279;11007.449627518432;11874.168808183344;11905.82141267899;12233.388330583613;12379.442925068573;10943.890561094287;11419.828702569634;11680.76638467209;11964.222325548812;11998.700032499257 00:15:17 INFO - PROCESS | 1630 | __end_tp_report 00:15:17 INFO - PROCESS | 1630 | __start_cc_report 00:15:17 INFO - PROCESS | 1630 | _x_x_mozilla_cycle_collect,1610 00:15:17 INFO - PROCESS | 1630 | __end_cc_report 00:15:17 INFO - PROCESS | 1630 | __startTimestamp1480493717292__endTimestamp 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | ------- Summary: start ------- 00:15:17 INFO - PROCESS | 1630 | Number of tests: 6 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#0] dojo.html Cycles:165 Average:5836.92 Median:6132.45 stddev:630.07 (10.3%) stddev-sans-first:603.93 00:15:17 INFO - PROCESS | 1630 | Values: 3466.2 3488.9 3489.8 3515.8 3553.9 5763.8 5835.3 5851.9 5886.9 5888.6 5814.9 5873.6 5882.9 5890.2 5906.8 5252.0 5292.4 5350.8 5356.8 5357.8 5252.9 5254.1 5274.4 5405.5 5413.5 5240.4 5286.7 5312.8 5318.3 5323.7 5293.5 5383.6 5391.4 5399.8 5429.5 4851.8 5175.6 5259.9 5302.4 5329.2 5712.9 5759.8 5768.3 5781.9 5821.5 6244.4 6261.6 6274.0 6294.6 6306.3 6262.8 6264.0 6265.5 6269.2 6274.6 5788.2 5836.6 5842.8 5866.5 5983.9 6294.4 6334.7 6356.6 6360.4 6367.0 6224.2 6227.4 6237.6 6250.9 6262.3 6143.5 6180.8 6185.6 6237.1 6259.1 6216.3 6281.2 6282.2 6302.4 6311.8 6275.7 6301.8 6321.3 6327.9 6335.1 4994.8 5031.8 5036.3 5039.7 5117.4 4468.9 4525.8 4556.5 4560.0 4566.0 6013.6 6015.4 6018.6 6020.2 6024.8 6132.4 6186.2 6254.9 6256.9 6272.2 5878.7 5914.9 5965.1 5980.9 6025.2 5568.7 5574.0 5576.6 5585.4 5595.4 6421.4 6429.7 6437.0 6443.7 6445.1 5168.7 6210.2 6257.7 6276.6 6282.8 6310.1 6368.0 6373.5 6464.4 6472.8 6259.0 6305.7 6311.5 6321.2 6328.8 6200.2 6254.9 6264.3 6278.7 6284.2 6119.4 6143.0 6180.5 6197.1 6292.4 6258.8 6268.1 6273.0 6287.4 6290.0 4724.1 5960.8 6084.9 6131.4 6149.2 6095.1 6133.0 6139.7 6141.3 6141.7 6143.1 6145.4 6157.0 6162.7 6169.6 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#1] ext.html Cycles:180 Average:71611.94 Median:35404.20 stddev:161581.29 (456.4%) stddev-sans-first:161946.27 00:15:17 INFO - PROCESS | 1630 | Values: 463.7 498.8 503.3 528.9 546.7 32538.0 33644.5 35464.6 42726.6 43981.9 45719.8 46028.0 46052.8 46156.0 46171.1 10080.8 10262.8 10283.0 10284.6 10300.5 9332.3 9577.6 10074.6 10233.5 12287.6 12346.6 12587.0 12593.7 12601.9 12657.2 12483.9 12567.5 12581.9 12584.4 12608.4 12380.3 12450.0 12463.6 12474.4 12479.4 43056.0 43441.0 43443.0 43479.0 43528.3 3377.9 3494.2 3665.2 3861.6 3933.4 32064.8 32145.8 32544.4 32546.8 32826.3 2842.0 3347.8 3402.5 3414.5 3430.0 378652.0 380798.0 380940.0 381208.0 382421.0 35368.1 64272.4 64621.7 64732.0 64766.4 36059.6 37769.0 37818.4 37829.4 37866.8 15782.4 15948.5 15967.4 15973.7 16024.9 11324.3 13286.9 13369.7 13382.2 13386.5 7151.3 7633.9 7849.3 7930.0 8285.4 3350.1 3393.6 3393.7 3396.3 3423.8 1015.4 1041.3 1048.0 1130.9 1139.8 30811.0 31102.4 31178.7 31649.0 31744.2 956.3 1071.4 1092.4 1143.4 1184.7 15699.6 16345.6 16385.4 16401.6 16677.2 717264.0 726354.0 726433.0 727428.0 729502.0 61336.0 62075.1 62149.4 62154.4 62155.7 1308.5 1329.6 1416.3 1442.7 1445.8 31979.5 32043.2 32806.7 32891.7 33394.0 51829.7 52399.0 52405.5 52443.0 52473.0 588781.0 590862.0 592248.0 707689.0 728494.0 44094.9 44475.8 44629.8 45127.3 45249.8 46993.3 48114.8 48307.8 48908.5 49623.3 39400.2 39532.0 40464.6 41139.5 41683.6 40463.8 40566.4 40595.6 41769.4 41872.5 39004.0 39334.6 39835.8 39922.6 40355.0 27821.0 30135.7 33416.2 33446.5 35440.3 21039.8 21876.5 26345.5 26392.9 26594.7 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#2] jquery.html Cycles:180 Average:35673.20 Median:2628.54 stddev:106331.10 (4045.3%) stddev-sans-first:106596.34 00:15:17 INFO - PROCESS | 1630 | Values: 367.3 371.1 373.9 383.2 392.2 19973.5 21104.5 21838.0 22698.7 22926.9 20416.2 21283.0 21378.5 21581.6 21678.0 5600.0 6013.6 6256.3 6338.3 6372.8 5827.2 5996.0 6319.7 6370.5 6388.9 7008.2 7058.0 7063.3 7064.5 7081.8 6351.3 6402.3 6405.3 6451.2 7024.4 5095.2 5968.1 6229.3 6233.8 6236.7 13785.7 14021.4 14231.9 14258.4 14262.3 2381.6 2388.3 2422.2 2599.1 2657.9 10134.9 10233.2 10314.4 10624.8 10761.4 1672.8 1839.5 1939.4 1954.9 2007.5 79447.6 79885.8 80746.6 114657.0 121383.0 10071.5 11672.8 11906.4 11927.4 12045.7 15356.8 15380.0 15388.1 15400.4 15463.3 8820.3 9052.2 9074.2 9095.5 9240.9 9062.5 9064.4 9089.4 9208.2 9222.7 4662.8 4666.4 4666.6 4675.4 4724.1 1689.8 1947.5 2002.4 2005.1 2007.0 870.2 932.0 982.9 985.7 1020.2 14099.7 22208.6 22422.9 22503.3 22600.4 937.7 958.8 964.6 970.6 1003.9 8311.0 11258.8 11927.9 11929.3 11949.0 628227.9 634525.0 637381.0 649212.0 653186.0 129527.0 130395.0 134988.0 135830.3 137001.3 972.6 1038.7 1069.9 1070.4 1074.0 19149.5 19446.5 19872.2 19886.0 19930.3 38377.8 53308.7 55706.4 55847.4 56861.0 78682.6 80340.2 81241.2 81250.0 81376.2 7151.7 7480.7 8103.6 8357.2 8673.8 10105.3 10897.0 11056.4 13665.0 13793.8 9467.0 9712.8 11482.2 11568.4 12028.9 11358.5 11404.2 11626.1 11635.9 11673.3 9925.4 11609.1 11853.5 12003.6 12167.3 8293.7 8320.4 8747.4 8780.9 8834.8 4768.9 9348.3 11273.9 11617.3 11652.3 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#3] mootools.html Cycles:180 Average:5781.21 Median:4771.99 stddev:3254.51 (68.2%) stddev-sans-first:3247.03 00:15:17 INFO - PROCESS | 1630 | Values: 1406.3 1504.8 1543.6 1796.4 1964.9 8050.6 8581.7 8586.1 8588.6 8594.5 8670.3 8935.0 8948.7 9088.9 9095.5 2418.5 2452.2 2452.3 2452.6 2454.9 2391.3 2430.9 2431.2 2436.1 2448.9 2395.9 2410.7 2423.3 2430.5 2431.1 2376.6 2392.9 2405.6 2406.7 2417.9 2387.6 2412.0 2416.9 2417.6 2418.0 8979.4 9072.7 9103.3 9117.0 9118.6 4929.7 5307.5 5420.2 5577.5 5593.2 3299.6 3624.7 3727.2 3793.4 3808.7 1117.7 1117.7 1120.7 1147.4 1149.6 8869.6 11859.5 11919.3 12023.2 12144.7 4554.2 4561.2 4767.7 4769.9 4774.1 9418.3 9489.1 9506.2 9517.1 9560.8 5415.2 5424.5 5429.4 5435.7 5440.5 4319.8 4594.4 4745.8 4746.7 5093.6 3893.4 3934.2 3986.3 4027.9 4040.4 1167.9 1180.6 1181.7 1188.4 1193.0 847.9 857.1 923.3 928.9 958.5 5762.0 5853.6 5874.5 6041.7 6166.6 449.1 455.4 467.6 469.8 471.1 3938.8 4018.0 4060.4 4113.3 4150.9 8575.6 11082.2 11083.4 11092.7 11098.7 10963.7 10997.2 11024.4 11025.0 11026.9 8021.8 8346.5 8470.1 8513.8 8661.1 5113.2 5950.0 5965.8 6210.7 6279.9 10215.4 10258.6 10407.3 10478.9 10484.7 9733.5 10075.1 10253.5 10340.1 10719.0 7098.0 7476.2 7593.1 7636.2 7643.1 8738.3 8753.0 8838.7 8851.6 8857.3 7725.5 7831.3 7881.9 7938.5 8034.9 6681.2 7631.2 7676.2 7703.9 7835.9 7024.2 7230.8 7233.1 7244.1 7250.2 4452.4 5076.6 5111.4 5160.0 5168.1 4998.4 5122.4 5133.4 5251.5 5289.5 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#4] prototype.html Cycles:180 Average:4425.23 Median:4708.45 stddev:1350.05 (28.7%) stddev-sans-first:1317.56 00:15:17 INFO - PROCESS | 1630 | Values: 283.7 310.9 318.0 325.0 325.3 4469.6 5249.8 5318.4 5393.6 5408.4 4266.3 4464.6 4921.2 5225.7 5269.8 4106.2 4169.4 4185.0 4190.6 4204.3 4138.8 4159.8 4159.9 4193.4 4196.0 4012.0 4146.6 4169.7 4170.0 4204.2 4137.3 4138.6 4165.3 4174.4 4195.3 3660.6 3661.1 3661.7 3662.1 3673.5 5106.6 5244.5 5299.3 5314.2 5351.3 4506.3 4659.7 4708.5 4744.6 4787.2 4895.6 4929.9 5416.5 5644.6 5670.6 3848.9 3990.0 4006.8 4044.4 4072.3 5856.8 5918.0 5919.6 5935.9 5954.3 4098.4 4121.3 4135.7 4151.7 4151.8 3998.7 4185.9 4190.0 4192.5 4202.5 3936.4 4713.5 4729.9 4737.5 4821.3 5306.0 5352.9 5660.9 5669.3 5732.5 1313.3 1404.8 1415.8 1418.4 1419.6 837.2 838.6 863.3 864.8 869.2 3847.1 3886.3 4461.3 4461.8 4478.7 4443.8 4714.1 4764.6 4766.7 4848.6 3875.7 3915.4 4207.8 4323.6 4446.3 2066.8 2218.1 2264.4 2463.0 2553.4 4115.0 4337.4 4604.6 4992.9 5013.0 4433.4 4654.8 4829.0 4858.2 4962.7 4623.7 4660.1 4708.4 4890.6 5027.7 4196.6 4595.9 4764.5 4768.1 4851.2 3689.8 4479.9 4586.6 4636.6 5251.7 6116.3 6140.6 6151.3 6165.4 6185.7 3388.0 3948.4 3964.9 3982.7 3995.2 5693.9 5854.2 5881.9 5911.9 5937.0 5702.5 5733.1 5765.9 5778.6 5841.5 5727.2 5747.2 5762.9 5775.9 5832.3 5372.7 5389.4 5578.6 5658.3 5663.5 4878.9 5647.8 5673.3 5684.5 5808.3 5655.3 5674.0 5678.7 5683.3 5724.2 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - PROCESS | 1630 | [#5] yui.html Cycles:180 Average:26865.27 Median:3784.32 stddev:44001.57 (1162.7%) stddev-sans-first:44081.16 00:15:17 INFO - PROCESS | 1630 | Values: 703.5 736.3 769.5 787.4 810.7 15833.0 17059.1 17065.5 17073.1 17078.7 15523.8 15595.3 15615.3 15620.0 15696.4 716.6 735.3 736.3 864.9 874.4 878.7 892.8 894.2 894.6 897.2 942.1 942.5 948.4 948.5 951.6 938.2 939.3 940.4 941.4 941.9 701.3 702.3 702.8 703.2 705.3 16320.8 16605.3 16758.2 16787.6 16804.8 13399.3 13569.0 15330.8 15556.9 15615.1 11897.4 12243.3 12428.3 13328.4 13686.2 3991.7 4017.3 4032.1 4034.5 4110.2 137133.6 139282.6 140844.0 142750.0 144694.0 8993.7 10134.8 10231.4 10651.7 10730.4 16153.4 19400.6 19408.4 19434.3 19468.1 7928.2 8241.0 8510.8 8532.7 8534.2 4338.6 4545.2 4575.9 4643.1 4714.8 3724.1 3844.5 3859.3 3864.7 3869.9 597.5 668.4 673.1 675.2 686.1 485.3 546.9 621.3 700.0 711.7 7985.7 9215.0 9709.1 9734.5 9917.1 596.7 659.8 669.8 678.1 681.7 3972.6 4357.3 4758.0 4786.2 4789.9 103887.0 103942.5 116687.0 155823.4 168226.0 156407.0 157248.6 159019.0 159511.0 160688.0 120746.0 130343.9 130782.7 133159.3 135829.0 9265.1 9270.2 9287.9 9308.3 9316.6 72412.0 72456.6 73351.6 73701.0 74806.6 63550.7 69882.0 78131.2 88651.7 111928.0 13254.9 13528.1 13587.1 13979.3 14349.9 13407.2 13820.7 15002.7 15690.5 15998.4 13472.3 13506.0 14966.6 15038.9 15065.9 14290.8 14411.4 15013.3 15226.7 15505.8 13128.9 13718.8 14601.1 15141.9 15279.0 11007.4 11874.2 11905.8 12233.4 12379.4 10943.9 11419.8 11680.8 11964.2 11998.7 00:15:17 INFO - PROCESS | 1630 | -------- Summary: end -------- 00:15:17 INFO - PROCESS | 1630 | 00:15:17 INFO - TEST-INFO | 1630: exit 0 00:15:17 INFO - TEST-OK | dromaeo_css | took 1115681ms 00:15:17 INFO - TEST-START | kraken 00:15:17 INFO - operating with platform_type : mac_ 00:15:17 INFO - Initialising browser for kraken test... 00:15:17 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpVicJG9/profile http://localhost:49241/getInfo.html) 00:15:19 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 00:15:19 INFO - PROCESS | 1637 | colorDepth:24 00:15:19 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 00:15:19 INFO - PROCESS | 1637 | __metrics 00:15:20 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:15:20 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:15:20 INFO - TEST-INFO | 1637: exit 0 00:15:20 INFO - Browser initialized. 00:15:20 INFO - Running cycle 1/1 for kraken test... 00:15:20 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpVicJG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:32 INFO - PROCESS | 1639 | RSS: Main: 169197568 00:15:32 INFO - PROCESS | 1639 | 00:15:35 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 00:15:36 INFO - PROCESS | 1639 | RSS: Main: 218918912 00:15:36 INFO - PROCESS | 1639 | 00:15:38 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 00:15:39 INFO - PROCESS | 1639 | RSS: Main: 232427520 00:15:39 INFO - PROCESS | 1639 | 00:15:42 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 00:15:43 INFO - PROCESS | 1639 | RSS: Main: 330133504 00:15:43 INFO - PROCESS | 1639 | 00:15:45 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 00:15:45 INFO - PROCESS | 1639 | RSS: Main: 228564992 00:15:45 INFO - PROCESS | 1639 | 00:15:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:15:48 INFO - PROCESS | 1639 | RSS: Main: 229404672 00:15:48 INFO - PROCESS | 1639 | 00:15:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 00:15:51 INFO - PROCESS | 1639 | RSS: Main: 266539008 00:15:51 INFO - PROCESS | 1639 | 00:15:54 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 00:15:55 INFO - PROCESS | 1639 | RSS: Main: 267350016 00:15:55 INFO - PROCESS | 1639 | 00:15:57 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 00:15:58 INFO - PROCESS | 1639 | RSS: Main: 267497472 00:15:58 INFO - PROCESS | 1639 | 00:15:59 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:16:00 INFO - PROCESS | 1639 | RSS: Main: 240214016 00:16:00 INFO - PROCESS | 1639 | 00:16:02 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:16:03 INFO - PROCESS | 1639 | RSS: Main: 245149696 00:16:03 INFO - PROCESS | 1639 | 00:16:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:16:05 INFO - PROCESS | 1639 | RSS: Main: 249589760 00:16:05 INFO - PROCESS | 1639 | 00:16:08 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:16:09 INFO - PROCESS | 1639 | RSS: Main: 260427776 00:16:09 INFO - PROCESS | 1639 | 00:16:11 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:16:12 INFO - PROCESS | 1639 | RSS: Main: 260628480 00:16:12 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 00:16:14 INFO - PROCESS | 1639 | RSS: Main: 303898624 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | __start_tp_report 00:16:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 00:16:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 00:16:14 INFO - PROCESS | 1639 | |i|pagename|runs| 00:16:14 INFO - PROCESS | 1639 | |0;ai-astar;113;112;112;114;114;113;112;114;113;113 00:16:14 INFO - PROCESS | 1639 | |1;audio-beat-detection;141;107;111;167;139;138;107;108;139;140 00:16:14 INFO - PROCESS | 1639 | |2;audio-dft;183;180;181;184;185;186;182;182;185;181 00:16:14 INFO - PROCESS | 1639 | |3;audio-fft;80;59;59;87;61;59;57;58;81;59 00:16:14 INFO - PROCESS | 1639 | |4;audio-oscillator;88;71;94;69;67;68;92;67;68;89 00:16:14 INFO - PROCESS | 1639 | |5;imaging-gaussian-blur;89;84;86;85;88;85;88;85;92;130 00:16:14 INFO - PROCESS | 1639 | |6;imaging-darkroom;96;96;101;96;96;96;96;95;96;96 00:16:14 INFO - PROCESS | 1639 | |7;imaging-desaturate;85;84;85;83;84;82;85;85;85;83 00:16:14 INFO - PROCESS | 1639 | |8;json-parse-financial;56;53;52;53;56;60;57;56;58;56 00:16:14 INFO - PROCESS | 1639 | |9;json-stringify-tinderbox;62;69;71;75;74;66;65;66;68;68 00:16:14 INFO - PROCESS | 1639 | |10;stanford-crypto-aes;93;99;92;82;84;82;81;82;81;83 00:16:14 INFO - PROCESS | 1639 | |11;stanford-crypto-ccm;136;131;135;134;136;136;139;135;164;149 00:16:14 INFO - PROCESS | 1639 | |12;stanford-crypto-pbkdf2;161;159;161;161;162;161;159;164;160;163 00:16:14 INFO - PROCESS | 1639 | |13;stanford-crypto-sha256-iterative;75;68;67;67;89;85;82;86;65;65 00:16:14 INFO - PROCESS | 1639 | __end_tp_report 00:16:14 INFO - PROCESS | 1639 | __start_cc_report 00:16:14 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1884 00:16:14 INFO - PROCESS | 1639 | __end_cc_report 00:16:14 INFO - PROCESS | 1639 | __startTimestamp1480493774651__endTimestamp 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | ------- Summary: start ------- 00:16:14 INFO - PROCESS | 1639 | Number of tests: 14 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 00:16:14 INFO - PROCESS | 1639 | Values: 113.0 112.0 112.0 114.0 114.0 113.0 112.0 114.0 113.0 113.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:139.00 stddev:20.33 (14.6%) stddev-sans-first:21.14 00:16:14 INFO - PROCESS | 1639 | Values: 141.0 107.0 111.0 167.0 139.0 138.0 107.0 108.0 139.0 140.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:2.02 (1.1%) stddev-sans-first:2.15 00:16:14 INFO - PROCESS | 1639 | Values: 183.0 180.0 181.0 184.0 185.0 186.0 182.0 182.0 185.0 181.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:11.24 00:16:14 INFO - PROCESS | 1639 | Values: 80.0 59.0 59.0 87.0 61.0 59.0 57.0 58.0 81.0 59.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.50 stddev:11.74 (14.8%) stddev-sans-first:11.79 00:16:14 INFO - PROCESS | 1639 | Values: 88.0 71.0 94.0 69.0 67.0 68.0 92.0 67.0 68.0 89.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.00 stddev:13.85 (15.9%) stddev-sans-first:14.66 00:16:14 INFO - PROCESS | 1639 | Values: 89.0 84.0 86.0 85.0 88.0 85.0 88.0 85.0 92.0 130.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 00:16:14 INFO - PROCESS | 1639 | Values: 96.0 96.0 101.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:85.00 stddev:1.10 (1.3%) stddev-sans-first:1.12 00:16:14 INFO - PROCESS | 1639 | Values: 85.0 84.0 85.0 83.0 84.0 82.0 85.0 85.0 85.0 83.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:2.45 (4.4%) stddev-sans-first:2.60 00:16:14 INFO - PROCESS | 1639 | Values: 56.0 53.0 52.0 53.0 56.0 60.0 57.0 56.0 58.0 56.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:4.03 (5.9%) stddev-sans-first:3.55 00:16:14 INFO - PROCESS | 1639 | Values: 62.0 69.0 71.0 75.0 74.0 66.0 65.0 66.0 68.0 68.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:83.50 stddev:6.37 (7.6%) stddev-sans-first:6.21 00:16:14 INFO - PROCESS | 1639 | Values: 93.0 99.0 92.0 82.0 84.0 82.0 81.0 82.0 81.0 83.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:136.00 stddev:9.83 (7.2%) stddev-sans-first:10.35 00:16:14 INFO - PROCESS | 1639 | Values: 136.0 131.0 135.0 134.0 136.0 136.0 139.0 135.0 164.0 149.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 00:16:14 INFO - PROCESS | 1639 | Values: 161.0 159.0 161.0 161.0 162.0 161.0 159.0 164.0 160.0 163.0 00:16:14 INFO - PROCESS | 1639 | 00:16:14 INFO - PROCESS | 1639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:78.50 stddev:9.68 (12.3%) stddev-sans-first:10.26 00:16:14 INFO - PROCESS | 1639 | Values: 75.0 68.0 67.0 67.0 89.0 85.0 82.0 86.0 65.0 65.0 00:16:14 INFO - PROCESS | 1639 | -------- Summary: end -------- 00:16:14 INFO - PROCESS | 1639 | 00:16:15 INFO - TEST-INFO | 1639: exit 0 00:16:15 INFO - TEST-OK | kraken | took 57650ms 00:16:15 INFO - SUITE-END | took 1173s 00:16:15 INFO - Completed test suite (00:19:33) 00:16:15 INFO - javascript benchmark 00:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.1681196512836, 3488.9476657850123, 3489.790612563245, 3515.8417871195793, 3553.9111522211942, 5763.769449222032, 5835.299764028312, 5851.8537036574, 5886.852828679285, 5888.617239879411, 5814.941850581493, 5873.618214816044, 5882.941170588293, 5890.234269544953, 5906.793262235823, 5251.973740131294, 5292.36491621006, 5350.839474815762, 5356.812511562096, 5357.812476563321, 5252.894942101156, 5254.0805359062015, 5274.4198138204765, 5405.459454054583, 5413.512783849453, 5240.44975277596, 5286.65636733613, 5312.760925758331, 5318.282031925699, 5323.707196104213, 5293.52358287754, 5383.596230282745, 5391.406945236021, 5399.757010934517, 5429.53848922842, 4851.781669824866, 5175.637705360627, 5259.86850328741, 5302.416734159239, 5329.22726204702, 5712.942870571283, 5759.827205183851, 5768.278965129359, 5781.88436231273, 5821.476067153976, 6244.406781355764, 6261.561690681654, 6274.0, 6294.590851594632, 6306.337834527354, 6262.78080267193, 6263.96868015657, 6265.530085243625, 6269.216347956505, 6274.623522588659, 5788.189653448479, 5836.649801011868, 5842.795502157446, 5866.530677545786, 5983.850403739942, 6294.402031806971, 6334.714937827809, 6356.555041147075, 6360.363963603602, 6366.9681651591445, 6224.159738435344, 6227.408396202353, 6237.625742455467, 6250.9062364064575, 6262.279837818709, 6143.539234557426, 6180.783672571439, 6185.567010309325, 6237.126802247689, 6259.123722678829, 6216.316205217422, 6281.183446152062, 6282.183316168869, 6302.369763023753, 6311.842203944938, 6275.6548389839, 6301.8109456716375, 6321.336259692758, 6327.873442531216, 6335.1447554579545, 4994.750262486861, 5031.823886163967, 5036.294918711384, 5039.7228152451235, 5117.437081920985, 4468.9106217876115, 4525.796339164745, 4556.476005259371, 4560.0, 4565.954340456553, 6013.609115407485, 6015.368386319374, 6018.578699490994, 6020.247469066367, 6024.849378765566, 6132.448079672851, 6186.1648677427975, 6254.937450625435, 6256.937430625727, 6272.2473303203, 5878.735456904364, 5914.852128696731, 5965.13505541694, 5980.910286345708, 6025.15647809307, 5568.693721845338, 5573.972130139324, 5576.581756368289, 5585.413531579207, 5595.440455954454, 6421.357864213542, 6429.710663020175, 6436.967815160988, 6443.677816109176, 6445.097686323918, 5168.71572063525, 6210.192674952227, 6257.7184026719815, 6276.560640755103, 6282.780102696383, 6310.116583678197, 6368.044793281045, 6373.521985850987, 6464.385883341075, 6472.805815825533, 6259.0, 6305.716242769178, 6311.526635502264, 6321.1782468278825, 6328.841778955563, 6200.193974783249, 6254.906176407267, 6264.31092579825, 6278.6546739929745, 6284.183056202847, 6119.41115851624, 6142.98993493194, 6180.4746596538, 6197.070439434121, 6292.402221788922, 6258.812235632939, 6268.059791031382, 6273.0, 6287.371262873859, 6289.96855015722, 4724.102420540086, 5960.761569537343, 6084.939150608438, 6131.386861313833, 6149.2313460817395, 6095.05526643371, 6132.967444181115, 6139.653888630618, 6141.301904043499, 6141.662208578392, 6143.143438301211, 6145.446909778141, 6157.0456579230295, 6162.661053642093, 6169.598976066542], "value": 5798.44817904121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.6777439679422, 498.84785140532125, 503.25015726567415, 528.936527616686, 546.6965833962151, 32538.02385928423, 33644.49533257, 35464.64535354649, 42726.572734272646, 43981.900452488626, 45719.77140114303, 46028.0, 46052.76973615127, 46156.0, 46171.07657846841, 10080.848787268178, 10262.846057309109, 10283.0, 10284.640037598685, 10300.536475858604, 9332.253419726405, 9577.61689532418, 10074.647387341445, 10233.539490722898, 12287.631371058838, 12346.567870124547, 12587.0, 12593.685157871036, 12601.936990315036, 12657.17728347659, 12483.937580312086, 12567.497300107985, 12581.93709031449, 12584.370781460937, 12608.369581520887, 12380.319082450462, 12450.0, 12463.563775267821, 12474.376281185996, 12479.376031198404, 43056.0, 43441.0, 43443.0, 43479.0, 43528.347074793906, 3377.9155521111925, 3494.1614012636783, 3665.2303016366595, 3861.575226725058, 3933.3706606943038, 32064.839675801704, 32145.839270803495, 32544.440623738534, 32546.837265813756, 32826.3434731304, 2841.971580284212, 3347.7991320520605, 3402.4896265560365, 3414.453687410027, 3429.9828500857584, 378652.0, 380798.0, 380939.9999999972, 381208.0, 382421.0, 35368.11579710528, 64272.357276427574, 64621.67689161524, 64732.02901956475, 64766.35233647697, 36059.639403606154, 37769.0, 37818.43272350917, 37829.432558511646, 37866.8106659465, 15782.368705251662, 15948.521544353687, 15967.44113956006, 15973.680526389408, 16024.919875400781, 11324.263922844988, 13286.933565332305, 13369.66575835612, 13382.197068175941, 13386.464541418234, 7151.2848715128075, 7633.923660763321, 7849.332806711379, 7930.048394192734, 8285.378596605278, 3350.095474221995, 3393.5927688677516, 3393.694567488938, 3396.252824378633, 3423.8288085595623, 1015.3552494166257, 1041.2919214933765, 1048.030621064329, 1130.8982191602795, 1139.8119310313705, 30811.0, 31102.377952440824, 31178.688213117577, 31649.0, 31744.206394840312, 956.268454632207, 1071.3786004117594, 1092.382803715898, 1143.3882872663085, 1184.703824043989, 15699.607509812118, 16345.591360216089, 16385.42651007209, 16401.58996025109, 16677.24952377146, 717264.0, 726354.0, 726433.0, 727428.0, 729502.0, 61336.0, 62075.06887396693, 62149.37850621436, 62154.37845621486, 62155.689221553606, 1308.5223893278885, 1329.6409969308233, 1416.3060100550656, 1442.6898216883421, 1445.7975883376125, 31979.520307195875, 32043.198920027186, 32806.67193328036, 32891.671083288864, 33394.0, 51829.7408512955, 52399.0, 52405.47594524158, 52442.95114097773, 52473.0, 588781.0, 590862.0, 592248.0, 707689.0, 728494.0, 44094.89762755957, 44475.77762111298, 44629.77685111554, 45127.32309015302, 45249.77375113103, 46993.29510057283, 48114.759426204044, 48307.75846120747, 48908.510914890394, 49623.25565116454, 39400.24198306091, 39532.0, 40464.59535404608, 41139.49857289196, 41683.58316416797, 40463.797681011405, 40566.39150412687, 40595.59404405918, 41769.373459397524, 41872.53446129371, 39004.02489937774, 39334.60665393309, 39835.80082099571, 39922.600773991886, 40355.0, 27821.0, 30135.698643014166, 33416.1645958853, 33446.49830252597, 35440.29119417649, 21039.78960210378, 21876.45308867291, 26345.473090538464, 26392.8680356597, 26594.74671669772], "value": 19967.228653677834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3222903742594, 371.12970085150323, 373.9439084137379, 383.1742594708404, 392.24688597892043, 19973.500662483446, 21104.472388190305, 21838.01728922198, 22698.659520107212, 22926.85365731715, 20416.183352665874, 21283.0, 21378.46553836155, 21581.56836863262, 21678.024488897998, 5599.972000140004, 6013.639181649093, 6256.343083976185, 6338.271098823625, 6372.808815735512, 5827.213326200951, 5996.045797040806, 6319.684015799215, 6370.458511026545, 6388.936110638904, 7008.19405768338, 7058.0, 7063.328983746535, 7064.540804847668, 7081.822954426155, 6351.333110023427, 6402.327755585643, 6405.327440618715, 6451.225852897659, 7024.438044956417, 5095.235714642833, 5968.134620480006, 6229.3459186785185, 6233.844153896143, 6236.688165591702, 13785.655358616015, 14021.369038393195, 14231.857681423156, 14258.358373873201, 14262.286885655676, 2381.5951288281035, 2388.3073908566494, 2422.2248880358293, 2599.140276689115, 2657.9335516612045, 10134.949325253401, 10233.232507561963, 10314.432706201156, 10624.840627390595, 10761.408122553257, 1672.765812786211, 1839.5125291797685, 1939.350317643591, 1954.8631595788302, 2007.5282308657454, 79447.6027619864, 79885.80171297435, 80746.59626701887, 114657.0, 121383.0, 10071.496425178711, 11672.824907626393, 11906.404679765978, 11927.403629818475, 12045.698857528456, 15356.769648455282, 15380.0, 15388.076715396888, 15400.383984640488, 15463.304151313218, 8820.294376449869, 9052.230560402308, 9074.228690561376, 9095.454272743656, 9240.8613870792, 9062.546872656341, 9064.410813297114, 9089.409188402733, 9208.217301529312, 9222.723318300461, 4662.813487460531, 4666.370040044619, 4666.603338716247, 4675.4155730533685, 4724.149653062482, 1689.8056723476711, 1947.5033866363985, 2002.3792624286518, 2005.1277694203068, 2006.9598608027757, 870.2472361407337, 931.9860202096974, 982.9066238707311, 985.669800616787, 1020.2450186861669, 14099.718005640036, 22208.55582888333, 22422.887885560467, 22503.324900253017, 22600.434989125075, 937.6858752317913, 958.7679831416735, 964.5996911281879, 970.5729479029204, 1003.9358280222987, 8311.0, 11258.831117533244, 11927.940360298144, 11929.28424294545, 11949.0, 628227.8588607119, 634525.0, 637381.0, 649212.0, 653186.0, 129527.0, 130395.0, 134988.0, 135830.32084839512, 137001.31499342638, 972.6206779356057, 1038.7039693687263, 1069.9144068474504, 1070.400575677623, 1073.9731506712394, 19149.521261968563, 19446.51383715362, 19872.205111795367, 19886.005699715246, 19930.302439415133, 38377.80811095927, 53308.667283318224, 55706.44293557013, 55847.441525584225, 56861.0, 78682.60658696669, 80340.19659803328, 81241.18758812336, 81250.0, 81376.18623813686, 7151.749688760869, 7480.70077196906, 8103.635336409758, 8357.164283571594, 8673.82652346937, 10105.292629515863, 10897.0, 11056.391898445663, 13665.043446958618, 13793.758466760504, 9467.0, 9712.805743885225, 11482.196246263016, 11568.363739994382, 12028.917397434272, 11358.54565817391, 11404.201705880509, 11626.069914406997, 11635.883641163819, 11673.299602023906, 9925.404475731479, 11609.129315301218, 11853.466594003117, 12003.63989080329, 12167.33079680626, 8293.709720159766, 8320.375971802017, 8747.387682862138, 8780.912190878009, 8834.779130521789, 4768.880777980439, 9348.345615806827, 11273.943630281796, 11617.302961822317, 11652.310414989948], "value": 9655.571159053787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.3319923036552, 1504.7517159668653, 1543.5909483986745, 1796.3622913865577, 1964.8624596278248, 8050.557219352933, 8581.656733730642, 8586.09845966174, 8588.613512391941, 8594.527300998443, 8670.349723770727, 8934.955325223365, 8948.731538053853, 9088.909110908906, 9095.454272743624, 2418.455847434326, 2452.2221389492565, 2452.2765784093735, 2452.5708001099824, 2454.901803927841, 2391.330427480308, 2430.902763889442, 2431.197704757426, 2436.0986435019067, 2448.90204391825, 2395.9041638334447, 2410.710714714237, 2423.297243799296, 2430.5138972205627, 2431.051889762994, 2376.560336337766, 2392.928212153638, 2405.6391541268777, 2406.651035599837, 2417.9153729619557, 2387.570237357275, 2412.0, 2416.9274921752376, 2417.5890098683267, 2417.97582024181, 8979.416337938013, 9072.727818165466, 9103.271738260923, 9116.954415227949, 9118.635254589808, 4929.679570827885, 5307.52232299095, 5420.24116623673, 5577.498025177713, 5593.216949627014, 3299.554560134375, 3624.673779359844, 3727.1613886875507, 3793.393057110849, 3808.6762625176616, 1117.7261570915095, 1117.7317443813508, 1120.7142178744368, 1147.4205526209212, 1149.5804031528517, 8869.645214191425, 11859.466324015353, 11919.344436056013, 12023.218490798157, 12144.696382590417, 4554.24854898938, 4561.178987782231, 4767.713937163781, 4769.880752981203, 4774.092922344744, 9418.340716149803, 9489.098535639103, 9506.239500839916, 9517.143457088756, 9560.760980975392, 5415.187721841755, 5424.538914192338, 5429.375621803543, 5435.728213589305, 5440.455954404528, 4319.762413067248, 4594.425696787902, 4745.83389581363, 4746.691465054761, 5093.592512598983, 3893.3575959966856, 3934.15415685629, 3986.262541429845, 4027.932597861569, 4040.41413994975, 1167.8511538768707, 1180.6103985684874, 1181.6824240971255, 1188.3879801902028, 1192.9940350298193, 847.9067302596709, 857.1171693156059, 923.2890674180843, 928.9442633442015, 958.4872093429982, 5762.0, 5853.590248682636, 5874.471297583153, 6041.667708276087, 6166.630002199882, 449.10179640718565, 455.3647661512172, 467.6212268062812, 469.8238160689741, 471.07433892401593, 3938.8424463021734, 4017.972012746702, 4060.4112403701297, 4113.280175969194, 4150.91698166041, 8575.614097365633, 11082.22424430282, 11083.390413527171, 11092.722681932855, 11098.722531936766, 10963.671089867317, 10997.175211859143, 11024.44877756125, 11024.952629500185, 11026.944865275622, 8021.759347219593, 8346.457480263885, 8470.068292487822, 8513.82972340562, 8661.090585488684, 5113.158012723127, 5949.970250148895, 5965.761369545169, 6210.689465526796, 6279.937200627935, 10215.438150901771, 10258.58965641366, 10407.271490995558, 10478.947605261925, 10484.737881553023, 9733.464659443798, 10075.09324160829, 10253.538590763284, 10340.069393754296, 10719.035286824223, 7097.964510177416, 7476.214997425192, 7593.126790418952, 7636.236376362319, 7643.082830060428, 8738.300935925237, 8753.037165911617, 8838.734837954871, 8851.557422128997, 8857.33569982241, 7725.5364678119495, 7831.295183433518, 7881.881771773543, 7938.483998540308, 8034.87947680797, 6681.198256209286, 7631.1605723371495, 7676.15562288159, 7703.922960770321, 7835.921640783519, 7024.192217894803, 7230.819229519304, 7233.0597022386755, 7244.094488188976, 7250.238724933806, 4452.443444569429, 5076.568491678101, 5111.361079865017, 5160.045391602565, 5168.121419358643, 4998.350214472095, 5122.359705036871, 5133.358330208724, 5251.501107394792, 5289.497497737709], "value": 4568.794989570946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7233697145283, 310.9207152176196, 317.9602699173702, 324.9983750081249, 325.2632786738037, 4469.553044695529, 5249.790008399665, 5318.414974352818, 5393.622446428747, 5408.35099788025, 4266.2534056540135, 4464.642828573715, 4921.188003979348, 5225.738713064351, 5269.841904742864, 4106.240345536071, 4169.437125987991, 4184.95376155961, 4190.569469707578, 4204.32730763078, 4138.793060346986, 4159.812808423613, 4159.916801663965, 4193.412922190896, 4195.958040419588, 4011.97994010031, 4146.606072423115, 4169.687273454503, 4169.955932169518, 4204.2222188895, 4137.275976704095, 4138.551506972565, 4165.312723400651, 4174.415581818548, 4195.307774217251, 3660.6089685919446, 3661.0528524537735, 3661.707063434919, 3662.1210909381557, 3673.5040769496045, 5106.591472682177, 5244.527992480657, 5299.311089558371, 5314.202869569595, 5351.304330437058, 4506.278995360759, 4659.6505262105475, 4708.529147085298, 4744.6441516886025, 4787.234042553209, 4895.5838753705975, 4929.9154186079, 5416.537534865603, 5644.604877658566, 5670.574706896958, 3848.9408166630997, 3990.0274295649638, 4006.799660017017, 4044.3529035354204, 4072.328065869128, 5856.824295271149, 5917.958304384981, 5919.5560332974765, 5935.881282374328, 5954.345022047614, 4098.426220329156, 4121.258173528794, 4135.710500264952, 4151.6886233532605, 4151.813168407369, 3998.7200895937585, 4185.853495127656, 4189.958100418957, 4192.538820729717, 4202.453681021509, 3936.4216438233, 4713.481517033192, 4729.881752956204, 4737.549932756383, 4821.252705830602, 5306.0, 5352.912364177973, 5660.85847853807, 5669.32754837324, 5732.512736417451, 1313.2711345203504, 1404.8199512409626, 1415.801787749716, 1418.3759145975944, 1419.6025112968384, 837.2459696934911, 838.6100463284602, 863.2921004776024, 864.7838040489878, 869.2350731356366, 3847.0572360957535, 3886.2796042770174, 4461.263891457873, 4461.7992190351515, 4478.731276123443, 4443.822247110144, 4714.114354258256, 4764.571188593043, 4766.689160480895, 4848.612111031109, 3875.6705680017512, 3915.4126880967515, 4207.768572728468, 4323.610875021263, 4446.288179051024, 2066.762322332921, 2218.057325636598, 2264.365977526262, 2462.9803561079743, 2553.387187075126, 4115.012397024692, 4337.41923555484, 4604.595598342471, 4992.926520798046, 5012.974935125301, 4433.379326894237, 4654.790534425959, 4828.961773218774, 4858.2146585613145, 4962.652614316963, 4623.65322600813, 4660.091282199938, 4708.364370809897, 4890.559849613481, 5027.698338099725, 4196.636093269639, 4595.9310610341545, 4764.475907650225, 4768.092762894731, 4851.223804191312, 3689.8120633081107, 4479.9328010079225, 4586.610138138296, 4636.559526844944, 5251.711155886463, 6116.296625887901, 6140.600860944024, 6151.32335443092, 6165.445109940127, 6185.721642526007, 3388.0, 3948.427478015729, 3964.900877477971, 3982.7012974026484, 3995.1610161866333, 5693.914591281217, 5854.209681692917, 5881.94118058831, 5911.91132133027, 5936.970315148396, 5702.515286200553, 5733.082706766897, 5765.8558536036935, 5778.56660750437, 5841.474267315962, 5727.1695604138, 5747.19539264495, 5762.884742305214, 5775.94224057754, 5832.270966129234, 5372.731363431734, 5389.353277606712, 5578.581606379456, 5658.349289831722, 5663.461971112738, 4878.853634390974, 5647.774089036392, 5673.333533239371, 5684.459976302244, 5808.273965754281, 5655.321361436654, 5673.971630141823, 5678.659280443187, 5683.2895888014, 5724.169995350568], "value": 3998.8453701064855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.4836350628958, 736.2674139231465, 769.5305863423307, 787.425179618878, 810.667626273228, 15833.0, 17059.14704264788, 17065.48803535893, 17073.060981646006, 17078.743818842697, 15523.767143492829, 15595.298211580477, 15615.297311620976, 15620.0, 15696.37214511421, 716.6488420673859, 735.3455424672046, 736.282124928196, 864.8572985457407, 874.3529787956898, 878.7056336127405, 892.7589550821274, 894.2130924786179, 894.6376717429451, 897.2014906733012, 942.1238248428958, 942.4722155592856, 948.4356807699407, 948.4735971535795, 951.5717926932908, 938.2025278513278, 939.3471537281558, 940.4216406909701, 941.4022095969075, 941.8869735631699, 701.3302296307014, 702.2731472925549, 702.8348338140584, 703.2053779229489, 705.270045502902, 16320.75518867218, 16605.252763625667, 16758.16209189548, 16787.580310492336, 16804.831951680448, 13399.263040532767, 13569.0, 15330.846691533054, 15556.922215388964, 15615.063096214264, 11897.405129743565, 12243.265404075784, 12428.254304741744, 13328.400221990034, 13686.247256400893, 3991.7006224533275, 4017.27689015977, 4032.0927791247027, 4034.536028356718, 4110.23960567296, 137133.62866371308, 139282.60717392797, 140844.0, 142749.99999999895, 144694.0, 8993.685221017233, 10134.797304053878, 10231.43727095017, 10651.733706657396, 10730.356178629307, 16153.353865845234, 19400.611987760167, 19408.4177474676, 19434.319798806973, 19468.123934422983, 7928.246816552418, 8241.0, 8510.829783404297, 8532.658693652184, 8534.189252021048, 4338.566143385636, 4545.181867263925, 4575.931361029588, 4643.141018911512, 4714.787834547454, 3724.1434470071495, 3844.5002149720917, 3859.3439115349897, 3864.6715029222833, 3869.903252418712, 597.4712379544135, 668.4117976180929, 673.0812441018073, 675.2369822100994, 686.1320429656489, 485.33993768474846, 546.9308345906443, 621.316551793024, 700.0, 711.7402148215864, 7985.72049978248, 9214.98635150133, 9709.087273817826, 9734.513274336256, 9917.057879501435, 596.6748122273372, 659.8119535932236, 669.8325418645338, 678.1252184681804, 681.7443458702986, 3972.5828787977425, 4357.281048626941, 4758.0, 4786.210275304606, 4789.904201915942, 103887.0, 103942.48028759808, 116687.0, 155823.44176558315, 168226.0, 156407.0, 157248.64127038105, 159019.0, 159511.0, 160688.0, 120746.0, 130343.87592868597, 130782.69217307895, 133159.33420332836, 135829.0, 9265.119813617695, 9270.165685088105, 9287.86068208991, 9308.255339572683, 9316.580753865957, 72412.0, 72456.63771681108, 73351.63324183559, 73701.0, 74806.62596686982, 63550.68224658847, 69882.0, 78131.21868781239, 88651.67022494797, 111928.0, 13254.933725331312, 13528.120672156278, 13587.102019771366, 13979.301034948008, 14349.928250359098, 13407.195568265935, 13820.687034731684, 15002.67244781253, 15690.529284121494, 15998.360065597246, 13472.259025753678, 13506.0, 14966.625834353792, 15038.924805375904, 15065.924670376578, 14290.785638215228, 14411.42354305816, 15013.324400401789, 15226.695466090838, 15505.767413489033, 13128.949684025065, 13718.794218086538, 14601.123932563656, 15141.924290378478, 15279.0, 11007.449627518432, 11874.168808183344, 11905.82141267899, 12233.388330583613, 12379.442925068573, 10943.890561094287, 11419.828702569634, 11680.76638467209, 11964.222325548812, 11998.700032499257], "value": 8150.713919561088, "unit": "score"}], "name": "dromaeo_css", "value": 7417.048491266255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 114.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 111.0, 167.0, 139.0, 138.0, 107.0, 108.0, 139.0, 140.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 181.0, 184.0, 185.0, 186.0, 182.0, 182.0, 185.0, 181.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 61.0, 59.0, 57.0, 58.0, 81.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 69.0, 67.0, 68.0, 92.0, 67.0, 68.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 86.0, 85.0, 88.0, 85.0, 88.0, 85.0, 92.0, 130.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 101.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 83.0, 84.0, 82.0, 85.0, 85.0, 85.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 53.0, 56.0, 60.0, 57.0, 56.0, 58.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 71.0, 75.0, 74.0, 66.0, 65.0, 66.0, 68.0, 68.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 92.0, 82.0, 84.0, 82.0, 81.0, 82.0, 81.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 135.0, 134.0, 136.0, 136.0, 139.0, 135.0, 164.0, 149.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 161.0, 162.0, 161.0, 159.0, 164.0, 160.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 67.0, 67.0, 89.0, 85.0, 82.0, 86.0, 65.0, 65.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1426.1000000000001, "alertThreshold": 2.0}]} 00:16:15 INFO - Return code: 0 00:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:16:15 INFO - # TBPL SUCCESS # 00:16:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:16:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:16:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:16:16 INFO - 2016-11-30 00:16:16.004 screenresolution[1643:9967] starting screenresolution argv=screenresolution get 00:16:16 INFO - 2016-11-30 00:16:16.006 screenresolution[1643:9967] Display 0: 1600x1200x32@60 00:16:16 INFO - 2016-11-30 00:16:16.012 screenresolution[1644:9970] starting screenresolution argv=screenresolution list 00:16:16 INFO - Available Modes on Display 0 00:16:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:16:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:16:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:16:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:16:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:16:16 INFO - Intel Iris: 00:16:16 INFO - Chipset Model: Intel Iris 00:16:16 INFO - Type: GPU 00:16:16 INFO - Bus: Built-In 00:16:16 INFO - VRAM (Dynamic, Max): 1536 MB 00:16:16 INFO - Vendor: Intel (0x8086) 00:16:16 INFO - Device ID: 0x0a2e 00:16:16 INFO - Revision ID: 0x0009 00:16:16 INFO - Displays: 00:16:16 INFO - Display: 00:16:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:16:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:16:16 INFO - Display Serial Number: 1600x1200 60 00:16:16 INFO - Main Display: Yes 00:16:16 INFO - Mirror: Off 00:16:16 INFO - Online: Yes 00:16:16 INFO - Rotation: Supported 00:16:16 INFO - Return code: 0 00:16:16 INFO - Running post-action listener: _resource_record_post_action 00:16:16 INFO - [mozharness: 2016-11-30 08:16:16.256876Z] Finished run-tests step (success) 00:16:16 INFO - Running post-run listener: _resource_record_post_run 00:16:16 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 36817920; Write bytes: 505575936; Read time: 447; Write time: 2306 00:16:16 INFO - TinderboxPrint: CPU usage
53.3% 00:16:16 INFO - TinderboxPrint: I/O read bytes / time
36,817,920 / 447 00:16:16 INFO - TinderboxPrint: I/O write bytes / time
505,575,936 / 2,306 00:16:16 INFO - TinderboxPrint: CPU idle
2,235.0 (46.7%) 00:16:16 INFO - TinderboxPrint: CPU system
953.3 (19.9%) 00:16:16 INFO - TinderboxPrint: CPU user
1,597.4 (33.4%) 00:16:16 INFO - TinderboxPrint: Swap in / out
223,494,144 / 0 00:16:16 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196096512; Write bytes: 197953024; Read time: 17854; Write time: 426 00:16:16 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 34573312; Write bytes: 306205696; Read time: 421; Write time: 1873 00:16:16 INFO - Running post-run listener: _upload_blobber_files 00:16:16 INFO - Blob upload gear active. 00:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:16:16 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 00:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:16:17 INFO - (blobuploader) - INFO - Open directory for files ... 00:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:16:18 INFO - (blobuploader) - INFO - Done attempting. 00:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:16:19 INFO - (blobuploader) - INFO - Done attempting. 00:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:16:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:16:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:16:22 INFO - (blobuploader) - INFO - Done attempting. 00:16:22 INFO - (blobuploader) - INFO - Iteration through files over. 00:16:22 INFO - Return code: 0 00:16:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:16:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:16:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e62540e477be759238799ad034252e10b6b2620819b2b5d6fb8d9e431cf9c0ea110a337f88475a300f7e47ebb42e827c12c3c323fea9341c061cbd12bbeb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a8fe674f34d8f7175060019de6ff623f35ba432cf1969376450798623927801fb9d0d68aa1b682100cd32faf54add1843576449ce07aab7ec25ce0f246a0fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046fb4d16ad8336f584539e236ca30e8209303c4f05403d6b44456b2005e44115bb8fa0f8ba2a5fa0bb565b8f1670687012332afd8aef477435825bf49e68d95"} 00:16:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:16:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:16:22 INFO - Contents: 00:16:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e62540e477be759238799ad034252e10b6b2620819b2b5d6fb8d9e431cf9c0ea110a337f88475a300f7e47ebb42e827c12c3c323fea9341c061cbd12bbeb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a8fe674f34d8f7175060019de6ff623f35ba432cf1969376450798623927801fb9d0d68aa1b682100cd32faf54add1843576449ce07aab7ec25ce0f246a0fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046fb4d16ad8336f584539e236ca30e8209303c4f05403d6b44456b2005e44115bb8fa0f8ba2a5fa0bb565b8f1670687012332afd8aef477435825bf49e68d95"} 00:16:22 INFO - Running post-run listener: copy_logs_to_upload_dir 00:16:22 INFO - Copying logs to upload dir... 00:16:22 INFO - mkdir: /builds/slave/test/build/upload/logs 00:16:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.279939 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-30 00:16:22.798919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 00:16:22.802397) ========= 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.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e62540e477be759238799ad034252e10b6b2620819b2b5d6fb8d9e431cf9c0ea110a337f88475a300f7e47ebb42e827c12c3c323fea9341c061cbd12bbeb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a8fe674f34d8f7175060019de6ff623f35ba432cf1969376450798623927801fb9d0d68aa1b682100cd32faf54add1843576449ce07aab7ec25ce0f246a0fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046fb4d16ad8336f584539e236ca30e8209303c4f05403d6b44456b2005e44115bb8fa0f8ba2a5fa0bb565b8f1670687012332afd8aef477435825bf49e68d95"} build_url:https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/SDwjFm8iTIyRqNpJv0kc7w/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e62540e477be759238799ad034252e10b6b2620819b2b5d6fb8d9e431cf9c0ea110a337f88475a300f7e47ebb42e827c12c3c323fea9341c061cbd12bbeb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a8fe674f34d8f7175060019de6ff623f35ba432cf1969376450798623927801fb9d0d68aa1b682100cd32faf54add1843576449ce07aab7ec25ce0f246a0fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046fb4d16ad8336f584539e236ca30e8209303c4f05403d6b44456b2005e44115bb8fa0f8ba2a5fa0bb565b8f1670687012332afd8aef477435825bf49e68d95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 00:16:22.836010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 00:16:22.836333) ========= 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.BaiaE2xhLy/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.Scbv5o8m20/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005215 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 00:16:22.884703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 00:16:22.885026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 00:16:22.885338) ========= ========= Total master_lag: 1.78 =========