builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1482426979.83 results: success (0) buildid: 20161222071052 builduid: 161e872a16d742fd96a434d38f5eb11f revision: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:19.831748) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:19.832185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:19.832458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:19.858379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:19.858729) ========= 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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-22 09:16:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.4M=0s 2016-12-22 09:16:19 (23.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129899 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.013724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.014048) ========= 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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.026999 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.063166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-22 09:16:20.063509) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a --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 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-22 09:16:20,156 truncating revision to first 12 chars 2016-12-22 09:16:20,157 Setting DEBUG logging. 2016-12-22 09:16:20,157 attempt 1/10 2016-12-22 09:16:20,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6ff5553aea2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 09:16:21,982 unpacking tar archive at: mozilla-beta-6ff5553aea2a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.104130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-22 09:16:22.190620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:22.190939) ========= script_repo_revision: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:22.191333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:22.191598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:22.211022) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-12-22 09:16:22.211304) ========= /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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:16:22 INFO - MultiFileLogger online at 20161222 09:16:22 in /builds/slave/test 09:16:22 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 09:16:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:22 INFO - {'append_to_log': False, 09:16:22 INFO - 'base_work_dir': '/builds/slave/test', 09:16:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:16:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:22 INFO - 'branch': 'Mozilla-Beta', 09:16:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:22 INFO - 'config_files': ('talos/mac_config.py',), 09:16:22 INFO - 'default_actions': ('clobber', 09:16:22 INFO - 'read-buildbot-config', 09:16:22 INFO - 'download-and-extract', 09:16:22 INFO - 'populate-webroot', 09:16:22 INFO - 'create-virtualenv', 09:16:22 INFO - 'install', 09:16:22 INFO - 'run-tests'), 09:16:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:22 INFO - 'download_minidump_stackwalk': True, 09:16:22 INFO - 'download_symbols': 'ondemand', 09:16:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:22 INFO - 'installer_path': 'installer.exe', 09:16:22 INFO - 'log_level': 'info', 09:16:22 INFO - 'log_name': 'talos', 09:16:22 INFO - 'log_to_console': True, 09:16:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:16:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:16:22 INFO - 'opt_config_files': (), 09:16:22 INFO - 'pip_index': False, 09:16:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:22 INFO - 'cmd': ('bash', 09:16:22 INFO - '-c', 09:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:22 INFO - 'enabled': True, 09:16:22 INFO - 'halt_on_failure': False, 09:16:22 INFO - 'name': 'check_screen_resolution'},), 09:16:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:22 INFO - 'cmd': ('bash', 09:16:22 INFO - '-c', 09:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:22 INFO - 'enabled': True, 09:16:22 INFO - 'halt_on_failure': False, 09:16:22 INFO - 'name': 'check_screen_resolution'},), 09:16:22 INFO - 'run_cmd_checks_enabled': True, 09:16:22 INFO - 'sps_profile': False, 09:16:22 INFO - 'sps_profile_interval': 0, 09:16:22 INFO - 'suite': 'dromaeojs', 09:16:22 INFO - 'system_bits': '32', 09:16:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:22 INFO - 'title': 't-yosemite-r7-0131', 09:16:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:22 INFO - 'use_talos_json': True, 09:16:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:22 INFO - 'work_dir': 'build'} 09:16:22 INFO - [mozharness: 2016-12-22 17:16:22.410640Z] Running clobber step. 09:16:22 INFO - Running pre-action listener: _resource_record_pre_action 09:16:22 INFO - Running main action method: clobber 09:16:22 INFO - rmtree: /builds/slave/test/build 09:16:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:25 INFO - Running post-action listener: _resource_record_post_action 09:16:25 INFO - [mozharness: 2016-12-22 17:16:25.034466Z] Finished clobber step (success) 09:16:25 INFO - [mozharness: 2016-12-22 17:16:25.034730Z] Running read-buildbot-config step. 09:16:25 INFO - Running pre-action listener: _resource_record_pre_action 09:16:25 INFO - Running main action method: read_buildbot_config 09:16:25 INFO - Using buildbot properties: 09:16:25 INFO - { 09:16:25 INFO - "project": "", 09:16:25 INFO - "product": "firefox", 09:16:25 INFO - "script_repo_revision": "production", 09:16:25 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:16:25 INFO - "repository": "", 09:16:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:16:25 INFO - "buildid": "20161222071052", 09:16:25 INFO - "pgo_build": "False", 09:16:25 INFO - "basedir": "/builds/slave/test", 09:16:25 INFO - "buildnumber": 99, 09:16:25 INFO - "slavename": "t-yosemite-r7-0131", 09:16:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:16:25 INFO - "platform": "yosemite_r7", 09:16:25 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:16:25 INFO - "branch": "mozilla-beta", 09:16:25 INFO - "repo_path": "releases/mozilla-beta", 09:16:25 INFO - "revision": "6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a", 09:16:25 INFO - "stage_platform": "macosx64", 09:16:25 INFO - "builduid": "161e872a16d742fd96a434d38f5eb11f", 09:16:25 INFO - "slavebuilddir": "test" 09:16:25 INFO - } 09:16:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:16:25 INFO - Running post-action listener: _resource_record_post_action 09:16:25 INFO - [mozharness: 2016-12-22 17:16:25.040425Z] Finished read-buildbot-config step (success) 09:16:25 INFO - [mozharness: 2016-12-22 17:16:25.040601Z] Running download-and-extract step. 09:16:25 INFO - Running pre-action listener: _resource_record_pre_action 09:16:25 INFO - Running main action method: download_and_extract 09:16:25 INFO - mkdir: /builds/slave/test/build/tests 09:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:25 INFO - trying https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:16:25 INFO - Downloading https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:26 INFO - Downloaded 1165 bytes. 09:16:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:16:26 INFO - Using the following test package requirements: 09:16:26 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:16:26 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:16:26 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:16:26 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:16:26 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:16:26 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:16:26 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:16:26 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:16:26 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:16:26 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:26 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:16:26 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:16:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:16:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:16:26 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:16:26 INFO - Expected file size: 16232805 09:16:34 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 09:16:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:16:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:16:34 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:16:35 INFO - Expected file size: 16232805 09:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:16:42 INFO - Expected file size: 14414089 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - trying https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:44 INFO - Downloading https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:46 INFO - Downloaded 86034101 bytes. 09:16:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:46 INFO - mkdir: /builds/slave/test/properties 09:16:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:46 INFO - Contents: 09:16:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:48 INFO - Running post-action listener: _resource_record_post_action 09:16:48 INFO - Running post-action listener: set_extra_try_arguments 09:16:48 INFO - [mozharness: 2016-12-22 17:16:48.468426Z] Finished download-and-extract step (success) 09:16:48 INFO - [mozharness: 2016-12-22 17:16:48.468561Z] Running populate-webroot step. 09:16:48 INFO - Running pre-action listener: _resource_record_pre_action 09:16:48 INFO - Running main action method: populate_webroot 09:16:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:48 INFO - '--tppagecycles', 09:16:48 INFO - '7'], 09:16:48 INFO - 'tests': ['tsvgm']}}, 09:16:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['damp', 'tps']}, 09:16:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'tests': ['damp', 'tps']}, 09:16:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['dromaeo_dom']}, 09:16:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['basic_compositor_video']}, 09:16:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['a11yr', 09:16:48 INFO - 'ts_paint', 09:16:48 INFO - 'tpaint', 09:16:48 INFO - 'sessionrestore', 09:16:48 INFO - 'sessionrestore_no_auto_restore', 09:16:48 INFO - 'tabpaint']}, 09:16:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['tsvgx', 09:16:48 INFO - 'tsvgr_opacity', 09:16:48 INFO - 'tart', 09:16:48 INFO - 'tscrollx', 09:16:48 INFO - 'cart']}, 09:16:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:48 INFO - 'tsvgr_opacity', 09:16:48 INFO - 'tart', 09:16:48 INFO - 'tscrollx', 09:16:48 INFO - 'cart']}, 09:16:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'talos_options': ['--disable-e10s'], 09:16:48 INFO - 'tests': ['tp5o']}, 09:16:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'tests': ['tp5o']}, 09:16:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'talos_options': ['--disable-e10s', 09:16:48 INFO - '--xperf_path', 09:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:48 INFO - 'tests': ['tp5n']}, 09:16:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:48 INFO - 'talos_options': ['--xperf_path', 09:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:48 INFO - 'tests': ['tp5n']}}, 09:16:48 INFO - 'talos.zip': {'path': '', 09:16:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:48 INFO - Running post-action listener: _resource_record_post_action 09:16:48 INFO - [mozharness: 2016-12-22 17:16:48.488603Z] Finished populate-webroot step (success) 09:16:48 INFO - [mozharness: 2016-12-22 17:16:48.488719Z] Running create-virtualenv step. 09:16:48 INFO - Running pre-action listener: _resource_record_pre_action 09:16:48 INFO - Running main action method: create_virtualenv 09:16:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:16:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:48 INFO - Using real prefix '/tools/python27' 09:16:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:52 INFO - Installing pip.................done. 09:16:52 INFO - Return code: 0 09:16:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:52 INFO - 'HOME': '/Users/cltbld', 09:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:52 INFO - 'LOGNAME': 'cltbld', 09:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:52 INFO - 'MOZ_NO_REMOTE': '1', 09:16:52 INFO - 'NO_EM_RESTART': '1', 09:16:52 INFO - 'PAGER': '/bin/cat', 09:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:52 INFO - 'PWD': '/builds/slave/test', 09:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:52 INFO - 'SHELL': '/bin/bash', 09:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:16:52 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:52 INFO - 'USER': 'cltbld', 09:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:52 INFO - 'XPC_FLAGS': '0x0', 09:16:52 INFO - 'XPC_SERVICE_NAME': '0', 09:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:16:52 INFO - Cleaning up... 09:16:52 INFO - Return code: 0 09:16:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:52 INFO - 'HOME': '/Users/cltbld', 09:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:52 INFO - 'LOGNAME': 'cltbld', 09:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:52 INFO - 'MOZ_NO_REMOTE': '1', 09:16:52 INFO - 'NO_EM_RESTART': '1', 09:16:52 INFO - 'PAGER': '/bin/cat', 09:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:52 INFO - 'PWD': '/builds/slave/test', 09:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:52 INFO - 'SHELL': '/bin/bash', 09:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:16:52 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:52 INFO - 'USER': 'cltbld', 09:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:52 INFO - 'XPC_FLAGS': '0x0', 09:16:52 INFO - 'XPC_SERVICE_NAME': '0', 09:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:52 INFO - Downloading/unpacking psutil>=3.1.1 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:55 INFO - Installing collected packages: psutil 09:16:55 INFO - Running setup.py install for psutil 09:16:55 INFO - building 'psutil._psutil_osx' extension 09:16: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:16:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:16:56 INFO - building 'psutil._psutil_posix' extension 09:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:16:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:56 INFO - ^ 09:16:56 INFO - 1 warning generated. 09:16:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:57 INFO - Successfully installed psutil 09:16:57 INFO - Cleaning up... 09:16:57 INFO - Return code: 0 09:16:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:57 INFO - 'HOME': '/Users/cltbld', 09:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:57 INFO - 'LOGNAME': 'cltbld', 09:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:57 INFO - 'MOZ_NO_REMOTE': '1', 09:16:57 INFO - 'NO_EM_RESTART': '1', 09:16:57 INFO - 'PAGER': '/bin/cat', 09:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:57 INFO - 'PWD': '/builds/slave/test', 09:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:57 INFO - 'SHELL': '/bin/bash', 09:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:16:57 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:57 INFO - 'USER': 'cltbld', 09:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:57 INFO - 'XPC_FLAGS': '0x0', 09:16:57 INFO - 'XPC_SERVICE_NAME': '0', 09:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:17:00 INFO - Installing collected packages: mozsystemmonitor 09:17:00 INFO - Running setup.py install for mozsystemmonitor 09:17:00 INFO - Successfully installed mozsystemmonitor 09:17:00 INFO - Cleaning up... 09:17:00 INFO - Return code: 0 09:17:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:00 INFO - 'HOME': '/Users/cltbld', 09:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:00 INFO - 'LOGNAME': 'cltbld', 09:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:00 INFO - 'MOZ_NO_REMOTE': '1', 09:17:00 INFO - 'NO_EM_RESTART': '1', 09:17:00 INFO - 'PAGER': '/bin/cat', 09:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:00 INFO - 'PWD': '/builds/slave/test', 09:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:00 INFO - 'SHELL': '/bin/bash', 09:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:00 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:00 INFO - 'USER': 'cltbld', 09:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:00 INFO - 'XPC_FLAGS': '0x0', 09:17:00 INFO - 'XPC_SERVICE_NAME': '0', 09:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:03 INFO - warning: no files found matching '*.txt' 09:17:03 INFO - no previously-included directories found matching 'build' 09:17:03 INFO - no previously-included directories found matching 'dist' 09:17:03 INFO - no previously-included directories found matching '.git*' 09:17:03 INFO - Installing collected packages: jsonschema, functools32 09:17:03 INFO - Running setup.py install for functools32 09:17:03 INFO - warning: no files found matching '*.txt' 09:17:03 INFO - no previously-included directories found matching 'build' 09:17:03 INFO - no previously-included directories found matching 'dist' 09:17:03 INFO - no previously-included directories found matching '.git*' 09:17:04 INFO - Successfully installed jsonschema functools32 09:17:04 INFO - Cleaning up... 09:17:04 INFO - Return code: 0 09:17:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:04 INFO - 'HOME': '/Users/cltbld', 09:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:04 INFO - 'LOGNAME': 'cltbld', 09:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:04 INFO - 'MOZ_NO_REMOTE': '1', 09:17:04 INFO - 'NO_EM_RESTART': '1', 09:17:04 INFO - 'PAGER': '/bin/cat', 09:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:04 INFO - 'PWD': '/builds/slave/test', 09:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:04 INFO - 'SHELL': '/bin/bash', 09:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:04 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:04 INFO - 'USER': 'cltbld', 09:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:04 INFO - 'XPC_FLAGS': '0x0', 09:17:04 INFO - 'XPC_SERVICE_NAME': '0', 09:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:17:04 INFO - Cleaning up... 09:17:04 INFO - Return code: 0 09:17:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:04 INFO - 'HOME': '/Users/cltbld', 09:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:04 INFO - 'LOGNAME': 'cltbld', 09:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:04 INFO - 'MOZ_NO_REMOTE': '1', 09:17:04 INFO - 'NO_EM_RESTART': '1', 09:17:04 INFO - 'PAGER': '/bin/cat', 09:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:04 INFO - 'PWD': '/builds/slave/test', 09:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:04 INFO - 'SHELL': '/bin/bash', 09:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:04 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:04 INFO - 'USER': 'cltbld', 09:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:04 INFO - 'XPC_FLAGS': '0x0', 09:17:04 INFO - 'XPC_SERVICE_NAME': '0', 09:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:08 INFO - Downloading docopt-0.6.1.tar.gz 09:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:08 INFO - Running setup.py install for blobuploader 09:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:08 INFO - Running setup.py install for requests 09:17:09 INFO - Running setup.py install for docopt 09:17:09 INFO - Successfully installed blobuploader requests docopt 09:17:09 INFO - Cleaning up... 09:17:09 INFO - Return code: 0 09:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:09 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:17:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:09 INFO - 'HOME': '/Users/cltbld', 09:17:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:09 INFO - 'LOGNAME': 'cltbld', 09:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:09 INFO - 'MOZ_NO_REMOTE': '1', 09:17:09 INFO - 'NO_EM_RESTART': '1', 09:17:09 INFO - 'PAGER': '/bin/cat', 09:17:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:09 INFO - 'PWD': '/builds/slave/test', 09:17:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:09 INFO - 'SHELL': '/bin/bash', 09:17:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:09 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:09 INFO - 'USER': 'cltbld', 09:17:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:09 INFO - 'XPC_FLAGS': '0x0', 09:17:09 INFO - 'XPC_SERVICE_NAME': '0', 09:17:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-xwZg8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Kc9axO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-9g608D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jb2Wxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ef07CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Ah2ka8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-T5PyV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-P5cFNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-QbCj2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-j9lDCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GLI7sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:10 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-dtLiah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:11 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jS2fMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:11 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-nAONHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:11 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-stKHtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:11 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ewW2vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:11 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ZYD5sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:11 INFO - Running setup.py install for manifestparser 09:17:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Running setup.py install for mozcrash 09:17:11 INFO - Running setup.py install for mozdebug 09:17:11 INFO - Running setup.py install for mozdevice 09:17:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Running setup.py install for mozfile 09:17:12 INFO - Running setup.py install for mozhttpd 09:17:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Running setup.py install for mozinfo 09:17:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Running setup.py install for mozInstall 09:17:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Running setup.py install for mozleak 09:17:12 INFO - Running setup.py install for mozlog 09:17:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Running setup.py install for moznetwork 09:17:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Running setup.py install for mozprocess 09:17:13 INFO - Running setup.py install for mozprofile 09:17:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Running setup.py install for mozrunner 09:17:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:13 INFO - Running setup.py install for mozscreenshot 09:17:13 INFO - Running setup.py install for moztest 09:17:13 INFO - Running setup.py install for mozversion 09:17:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:14 INFO - Cleaning up... 09:17:14 INFO - Return code: 0 09:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:17:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:14 INFO - 'HOME': '/Users/cltbld', 09:17:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:14 INFO - 'LOGNAME': 'cltbld', 09:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:14 INFO - 'MOZ_NO_REMOTE': '1', 09:17:14 INFO - 'NO_EM_RESTART': '1', 09:17:14 INFO - 'PAGER': '/bin/cat', 09:17:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:14 INFO - 'PWD': '/builds/slave/test', 09:17:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:14 INFO - 'SHELL': '/bin/bash', 09:17:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:14 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:14 INFO - 'USER': 'cltbld', 09:17:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:14 INFO - 'XPC_FLAGS': '0x0', 09:17:14 INFO - 'XPC_SERVICE_NAME': '0', 09:17:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Ni3x5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hfdtVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:14 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)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-QMtEku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-qpRZUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:14 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)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-oj3vCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17: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)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-n1XEIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-gaDeIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BonWxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ejA97x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-b3x_uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Pp7RQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-m1JC4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:15 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)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_TjZ3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-9QEeZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17: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)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-S1OTym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17: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)) 09:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:15 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-56l1OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:16 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)) 09:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:16 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-6qdTKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:17:16 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)) 09:17:16 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)) 09:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:17:16 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)) 09:17:16 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)) 09:17:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:19 INFO - Downloading blessings-1.6.tar.gz 09:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:19 INFO - Installing collected packages: blessings 09:17:19 INFO - Running setup.py install for blessings 09:17:19 INFO - Successfully installed blessings 09:17:19 INFO - Cleaning up... 09:17:19 INFO - Return code: 0 09:17:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:20 INFO - Reading from file tmpfile_stdout 09:17:20 INFO - Current package versions: 09:17:20 INFO - blessings == 1.6 09:17:20 INFO - blobuploader == 1.2.4 09:17:20 INFO - docopt == 0.6.1 09:17:20 INFO - functools32 == 3.2.3-2 09:17:20 INFO - jsonschema == 2.5.1 09:17:20 INFO - manifestparser == 1.1 09:17:20 INFO - mozInstall == 1.12 09:17:20 INFO - mozcrash == 0.17 09:17:20 INFO - mozdebug == 0.1 09:17:20 INFO - mozdevice == 0.48 09:17:20 INFO - mozfile == 1.2 09:17:20 INFO - mozhttpd == 0.7 09:17:20 INFO - mozinfo == 0.9 09:17:20 INFO - mozleak == 0.1 09:17:20 INFO - mozlog == 3.4 09:17:20 INFO - moznetwork == 0.27 09:17:20 INFO - mozprocess == 0.23 09:17:20 INFO - mozprofile == 0.28 09:17:20 INFO - mozrunner == 6.12 09:17:20 INFO - mozscreenshot == 0.1 09:17:20 INFO - mozsystemmonitor == 0.3 09:17:20 INFO - moztest == 0.7 09:17:20 INFO - mozversion == 1.4 09:17:20 INFO - psutil == 3.1.1 09:17:20 INFO - requests == 1.2.3 09:17:20 INFO - wsgiref == 0.1.2 09:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:20 INFO - 'HOME': '/Users/cltbld', 09:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:20 INFO - 'LOGNAME': 'cltbld', 09:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:20 INFO - 'MOZ_NO_REMOTE': '1', 09:17:20 INFO - 'NO_EM_RESTART': '1', 09:17:20 INFO - 'PAGER': '/bin/cat', 09:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:20 INFO - 'PWD': '/builds/slave/test', 09:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:20 INFO - 'SHELL': '/bin/bash', 09:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:20 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:20 INFO - 'USER': 'cltbld', 09:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:20 INFO - 'XPC_FLAGS': '0x0', 09:17:20 INFO - 'XPC_SERVICE_NAME': '0', 09:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:17:20 INFO - Cleaning up... 09:17:20 INFO - Return code: 0 09:17:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 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 0x10e6b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e62d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa152564450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, '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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:20 INFO - 'HOME': '/Users/cltbld', 09:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:20 INFO - 'LOGNAME': 'cltbld', 09:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:20 INFO - 'MOZ_NO_REMOTE': '1', 09:17:20 INFO - 'NO_EM_RESTART': '1', 09:17:20 INFO - 'PAGER': '/bin/cat', 09:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:20 INFO - 'PWD': '/builds/slave/test', 09:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:20 INFO - 'SHELL': '/bin/bash', 09:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:20 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:20 INFO - 'USER': 'cltbld', 09:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:20 INFO - 'XPC_FLAGS': '0x0', 09:17:20 INFO - 'XPC_SERVICE_NAME': '0', 09:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:17:20 INFO - Cleaning up... 09:17:20 INFO - Return code: 0 09:17:20 INFO - Running post-action listener: _resource_record_post_action 09:17:20 INFO - Running post-action listener: _start_resource_monitoring 09:17:20 INFO - Starting resource monitoring. 09:17:20 INFO - [mozharness: 2016-12-22 17:17:20.920627Z] Finished create-virtualenv step (success) 09:17:20 INFO - [mozharness: 2016-12-22 17:17:20.921568Z] Running install step. 09:17:20 INFO - Running pre-action listener: _resource_record_pre_action 09:17:20 INFO - Running main action method: install 09:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:21 INFO - Reading from file tmpfile_stdout 09:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:21 INFO - Reading from file tmpfile_stdout 09:17:21 INFO - Output received: 09:17:21 INFO - Usage: mozinstall [options] installer 09:17:21 INFO - Options: 09:17:21 INFO - -h, --help show this help message and exit 09:17:21 INFO - -d DEST, --destination=DEST 09:17:21 INFO - Directory to install application into. [default: 09:17:21 INFO - "/builds/slave/test"] 09:17:21 INFO - --app=APP Application being installed. [default: firefox] 09:17:21 INFO - mkdir: /builds/slave/test/build/application 09:17:21 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'] 09:17:21 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 09:17:43 INFO - Reading from file tmpfile_stdout 09:17:43 INFO - Output received: 09:17:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:17:43 INFO - Running post-action listener: _resource_record_post_action 09:17:43 INFO - [mozharness: 2016-12-22 17:17:43.340709Z] Finished install step (success) 09:17:43 INFO - [mozharness: 2016-12-22 17:17:43.340841Z] Running run-tests step. 09:17:43 INFO - Running pre-action listener: _resource_record_pre_action 09:17:43 INFO - Running main action method: run_tests 09:17:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:43 INFO - 2016-12-22 09:17:43.355 screenresolution[1623:7397] starting screenresolution argv=screenresolution get 09:17:43 INFO - 2016-12-22 09:17:43.357 screenresolution[1623:7397] Display 0: 1600x1200x32@60 09:17:43 INFO - 2016-12-22 09:17:43.363 screenresolution[1624:7399] starting screenresolution argv=screenresolution list 09:17:43 INFO - Available Modes on Display 0 09:17:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:43 INFO - Intel Iris: 09:17:43 INFO - Chipset Model: Intel Iris 09:17:43 INFO - Type: GPU 09:17:43 INFO - Bus: Built-In 09:17:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:43 INFO - Vendor: Intel (0x8086) 09:17:43 INFO - Device ID: 0x0a2e 09:17:43 INFO - Revision ID: 0x0009 09:17:43 INFO - Displays: 09:17:43 INFO - Display: 09:17:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:43 INFO - Display Serial Number: 1600x1200 60 09:17:43 INFO - Main Display: Yes 09:17:43 INFO - Mirror: Off 09:17:43 INFO - Online: Yes 09:17:43 INFO - Rotation: Supported 09:17:43 INFO - Return code: 0 09:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:43 INFO - Python 2.7.3 09:17:43 INFO - Return code: 0 09:17:43 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:43 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 0x10e4cbd30>, '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 0x10e331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4c3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:17:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:17:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:17:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:43 INFO - Return code: 0 09:17:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:43 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/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:17:43 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/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6MtzVvtVsL/Render', 09:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:43 INFO - 'HOME': '/Users/cltbld', 09:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:43 INFO - 'LOGNAME': 'cltbld', 09:17:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:43 INFO - 'MOZ_NO_REMOTE': '1', 09:17:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:43 INFO - 'NO_EM_RESTART': '1', 09:17:43 INFO - 'PAGER': '/bin/cat', 09:17:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:43 INFO - 'PWD': '/builds/slave/test', 09:17:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:43 INFO - 'SHELL': '/bin/bash', 09:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w1i8BQNPw/Listeners', 09:17:43 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 09:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:43 INFO - 'USER': 'cltbld', 09:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:43 INFO - 'XPC_FLAGS': '0x0', 09:17:43 INFO - 'XPC_SERVICE_NAME': '0', 09:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:43 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/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:17:43 INFO - mozversion application_buildid: 20161222071052 09:17:43 INFO - mozversion application_changeset: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a 09:17:43 INFO - mozversion application_display_name: Firefox 09:17:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:43 INFO - mozversion application_name: Firefox 09:17:43 INFO - mozversion application_remotingname: firefox 09:17:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:43 INFO - mozversion application_vendor: Mozilla 09:17:43 INFO - mozversion application_version: 51.0 09:17:43 INFO - mozversion platform_buildid: 20161222071052 09:17:43 INFO - mozversion platform_changeset: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a 09:17:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:43 INFO - mozversion platform_version: 51.0 09:17:43 INFO - using testdate: 1482427063 09:17:43 INFO - actual date: 1482427063 09:17:43 INFO - starting webserver on 'localhost:49242' 09:17:43 INFO - SUITE-START | Running 2 tests 09:17:43 INFO - TEST-START | dromaeo_css 09:17:43 INFO - operating with platform_type : mac_ 09:17:43 INFO - Initialising browser for dromaeo_css test... 09:17:44 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpF0MScY/profile http://localhost:49242/getInfo.html) 09:17:46 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:17:46 INFO - PROCESS | 1634 | colorDepth:24 09:17:46 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:17:46 INFO - PROCESS | 1634 | __metrics 09:17:46 INFO - PROCESS | 1634 | 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" 09:17:46 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:47 INFO - TEST-INFO | 1634: exit 0 09:17:47 INFO - Browser initialized. 09:17:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:47 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpF0MScY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:58 INFO - PROCESS | 1637 | RSS: Main: 169078784 09:17:58 INFO - PROCESS | 1637 | 09:18:50 INFO - PROCESS | 1637 | 1482427130797 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] 09:21:01 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 09:21:02 INFO - PROCESS | 1637 | RSS: Main: 313196544 09:21:02 INFO - PROCESS | 1637 | 09:24:05 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 09:24:06 INFO - PROCESS | 1637 | RSS: Main: 308711424 09:24:06 INFO - PROCESS | 1637 | 09:27:08 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 09:27:09 INFO - PROCESS | 1637 | RSS: Main: 277504000 09:27:09 INFO - PROCESS | 1637 | 09:30:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 09:30:11 INFO - PROCESS | 1637 | RSS: Main: 287731712 09:30:11 INFO - PROCESS | 1637 | 09:33:15 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 09:33:15 INFO - PROCESS | 1637 | RSS: Main: 260935680 09:33:15 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 09:36:18 INFO - PROCESS | 1637 | RSS: Main: 396079104 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | __start_tp_report 09:36:18 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:36:18 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:36:18 INFO - PROCESS | 1637 | |i|pagename|runs| 09:36:18 INFO - PROCESS | 1637 | |0;dojo.html;3188.9681103188964;3412.6587341265877;3443.690067893889;3459.602145753236;3516.1385460562165;5657.462541058598;5772.653640781546;5783.884322313551;5802.825915222545;5810.883782324357;5669.404712505179;5717.199592057115;5729.427057294269;5810.941890581093;5855.619384739989;5185.325907632003;5222.582193424517;5227.921581176285;5245.947540524584;5279.604029697769;5146.176611742122;5204.765785539641;5296.232046353296;5320.361556613212;5323.840284791462;5190.039842629107;5202.141646628302;5205.687658740469;5235.188545775411;5254.500822421864;5203.60972927032;5212.8957420851375;5279.41926388097;5302.2046692996355;5333.626646134772;4623.144718227105;5138.537531622134;5186.974065129688;5218.112920803473;5222.764975576109;5551.444855514456;5637.8590535236535;5659.122835960433;5662.830115096513;5687.630304030266;6154;6161.691915404257;6227.782027629011;6263.749450021994;6278.748850046039;6223.518926965777;6259.843503912393;6278.277998030194;6292.779752708679;6295.622262664255;5679.233303504016;5740.024195886667;5778.27771528559;5833.854153646108;5848.970755146197;6270.2475702915945;6290;6293.056041593798;6313.55805093639;6326.177596912464;6199.721012554446;6209.410106039919;6223.408776166257;6224.221972253468;6237.282712488122;6128.930927367261;6191.628502289877;6211.596246243979;6254.718537665725;6270.31026587075;6242.687865606701;6251.374862513712;6256.436920677161;6265.091561723524;6277.372262773686;6194.34959329273;6218.81343559694;6275.152854364694;6294.339094395114;6297.4962003039645;4921.237208232729;4972.627052970969;4981.277714731416;5037.949620503748;5076.187809950464;4535.047639995638;4547.8635640930825;4571.337156112345;4575.7483338416705;4591.357209990604;4724.456687480915;5673.262475878109;5680.829575112753;5823.330317013513;5831.533477321804;6234.2830574483605;6253.343398943137;6271.372862713783;6289.0252010938375;6292.748290068437;5825.592208545361;5825.941740582624;5826.475617194388;5838.737256823453;5854.765809367577;4480.507144214133;5397.7571009304675;5420.620556561082;5451.591130665216;5463.754131064112;6375.904361434582;6396.104545363746;6401.8719625608155;6420.390062944013;6438.549301548846;6236.688165591611;6285.748570057147;6290.087937248982;6299.118123462627;6307.400796924285;6209.0996805462055;6234.127222188988;6276;6368.9044664330995;6382.840428989312;6198.845028874314;6255.061740738925;6267.341929097379;6290.49676025926;6300.558960872695;6279.30927597973;6291.087792270004;6300.71646775887;6300.873982520232;6326.335734747785;6042.184305118929;6062.090686397076;6171.783987560414;6214.9689251553455;6217.160683307696;4908.63185261114;5311.654742441729;5860.739940912724;6201.348858369806;6203.937960620336;6059.939400605937;6080.574066619961;6091.274296978388;6122;6129.908051379144;5997.490213331916;6185.381461853779;6189.102580125947;6192.783252586138;6199.5660303780105;5929.377415371497;6066.272047354346;6095.725692343944;6102.917792971912;6138.324784273816 09:36:18 INFO - PROCESS | 1637 | |1;ext.html;507.6928458282739;531.2482836785946;542.0919959068564;542.3600151820852;554.6616563896023;27268;42453.78773106134;43818.12363752727;43959.78020109903;46203.84490387742;44917.32624010643;45340.0931981361;45428.77285613567;45431.31853022207;45550.31674524885;9883.90116098837;10074.194064474825;10088.243381746363;10089.293749437542;10100.141487973531;9208.263338932902;9479;9480.81038379232;9610.615575376976;12063;12127.878721212808;12480.438380272864;12490.625281241577;12503.499860005635;12509.437075331587;12303.938480307586;12371.690707732289;12374.195677280948;12380.81428778569;12390.75218495634;12061.517539298418;12122.757544849143;12131.636050918487;12144.453499592451;12146.271223726604;41911;42200.57799421997;42202;42227.57772422298;42251.36622950658;3320.912207482491;3343.632200457948;3550.3076900004507;3559.626239244868;3835.884923452301;31280.061598152093;31848.6815131848;31927.52108718371;32090.839545802122;32312.272709107678;3315.336932613487;3327.434336162858;3328.7170590499836;3401.132711158639;3438.415469370188;515516;515697;516125;516217;518475.40762296325;53784;61988.69005655033;62025.37974620196;62025.37974620286;62121;37460.250794984495;37856.43215351772;38078.80960595179;38186.42720359197;38192;17857.553561160814;18000.639987200444;18021.819781802013;18037.729434058238;18055.916645001344;13675;13721.656958576115;13776.311184440738;13793.724125517634;13797.862021379859;17366.56583585395;17661.38185163513;19349.962207105043;20126.094325755377;20341.49146271355;7040.9647951760935;7502.549847009088;7936.127026027132;8016.919830801734;8019.398545109024;884.920357167858;897.9236764874928;975.1759763000396;990.5195979949718;1097.2209731090854;31404.371912561623;31446.213844654067;31448.52827207594;31874.84062579672;32088.197795054843;938.3290946972947;1068.385678235018;1083.5503266144462;1095.1622009162998;1126.1385040444068;16037.518874433787;16323;16341.836581634268;16463.68407203106;16500.917495412446;728302;735516.3224183952;738355;739230;741547;60562.69718651378;61161.69419152965;61210.38789612047;61223.38776612177;61302;1079.875814281352;1324.9735005300033;1329.4349901292105;1363.584106847421;1424.665203677135;29726.851365743034;32854;32859;33143.094734861865;33227.335453291285;50654.74672626613;51245;51320.230196546334;51321.486785133166;51388.48611513837;584190;587938;588130;589897;590208;24227.909744061206;24851.87574062118;27049.1885243443;27677.892884284403;27796.722032779413;48122.518774811804;48247.75876120738;48529;48626.51373486361;49029.50970490392;39164.02089947774;40205;40440.3933940997;40774.1845163101;42029.57970420379;41085.38371924364;41142.38286425646;41204.58795412008;41463;41643.37534936918;39056.41415378828;39361.606383935796;40135.99660008523;40282.597174029055;40352.596474034886;29023.7097629021;31751;35397.29205415929;35675.46486802752;35687.64312356843;26415.867920660272;26613.20160395191;26673.733262667123;26735.041369358183;26973.86513067422 09:36:18 INFO - PROCESS | 1637 | |2;jquery.html;333.92486690494644;387.78477944740655;393.51401019740626;402.8630265709658;412.60802237874026;16896.493105206864;19856.20575176993;21166.470838229052;21398.465038374048;21442.356729298106;11881;12321.075919306066;12509.562165324216;12541.49834006641;12560.623181304576;5490.368607610126;5796.913046304308;5797.188393624896;5797.478226959573;5810.709464526778;4139.130782535671;4197.307444271692;4568.474625418086;4603.792829322689;5672.9432705672825;7024.121984751906;7037.929620703804;7137.785866424016;7139.428845692358;7153.856922861566;6255.186825712673;6270.09083682868;6324.3359447257835;6324.968375158095;7131.928680713204;5387.595930305243;6173.290071641729;6188.350223226586;6190.133381326618;6191.938080619227;13223.404946777418;13924.37340319688;13931.721365572734;13941.86058139426;17735.822641773677;1922.7019811929174;2246.382244882654;2270.761570035139;2353.446939969106;2569.678790151231;10113.190944724405;10248.436336001518;10453.21600879937;10466.79066418675;10480.842787358195;1877.0614692653674;1906.1041310584003;1934.7001214811726;1948.3473036532778;1971.7732460766908;97089;113967.86032139655;119137.80862191354;120766.79233207644;125549;11082.335059896432;11453.942730286462;11509.827352589551;11785.469653865597;11809.40952952349;15245.695086098216;15269.389224430899;15284.082955022734;15290;15300.699440547456;8869.512176830207;9027.593758280893;9028.909710902806;9040.502772347583;9122.635094596142;9034.051424600453;9077.68228112013;9090.636374545076;9186.40288381253;9195.770105747277;4665.836695715634;4671.7430541320555;4684.8360307389075;4689.7655117244;4768.094062128184;1603.847634474723;1929.8166674165932;1978.0999645161417;1981.2471260920759;1990.1840245499275;717.1394326807851;739.0747103794645;752.6048824367142;840.0171798995191;938.2789909263191;11870.940645296718;12342.568010119603;21205.738781376156;21838.955062531753;21958.45103872416;368.87458264190303;382.6116491760865;395.47599430754366;430.9267424537836;442.73214705103595;5234.241035049972;6218.751249950042;6252.656103914328;6360.0777887206095;6362.427381535684;537500;540987;543297;606482;611002;123000;134729;146264;157691;158011.20994394954;439.16558538775945;448.64332855380053;462.24653814282505;464.06027793717993;465.36245343878426;10189.860129372915;11637.418129093681;11676.532938682358;11697.473613687234;11895.881041189477;56714.43285567257;56736.716316418155;58089.709551451975;59846;60547.091793624015;82784.58607706922;85226.29547408893;86894.13105869113;87686.56156719176;88368.5581572088;8420.10547626779;8422.873656895274;8509;8717.869231961398;8794.91205087941;11107.333559986104;12759.170653907466;13552.390142443417;13572.389242484309;13595.456181753014;11674.066074714172;11674.416279185836;11728.648140555797;11964.521419143484;11993.160478766402;9637.37357071788;11476.655700329004;11572.24780389272;11614.88385116138;11831;11643.184977051525;11723.941380293043;11801.468933898166;12009.699757506132;12045.156839021185;8304.70933517324;8353.0811610724;8558.101399353227;8628.979857049982;8639.308855291687;9034.548272586213;11536.538538458368;11757.412129393668;11833.46749396262;12038.879611203776 09:36:18 INFO - PROCESS | 1637 | |3;mootools.html;1316.2760481735043;1530.8163020437548;1564.8669863061639;1701.6001239708673;1766.2140347545349;8681;9253.213476854458;9255.768605784859;9273.907260927388;9287.024862389453;7496.775096747093;8222.424430289882;8463.661453541867;8882.911170888288;9006.86489702655;2406.651035599837;2439.353571303606;2441.218809980807;2444.181199298237;2445.877706114696;2086.332373640428;2417.746136655652;2418.6492958521003;2454.7054353477606;2455.2756936703627;2416.7704068113503;2430.1373012580543;2440.1825388494876;2441.0357908626083;2443.7189723181796;2050.6103840270302;2409.4096946248105;2417.552752740731;2417.9844465324604;2422.188566830114;2390.8804559771943;2410.5058463015216;2410.963835542468;2415;2416.9395765105837;8943;9140.90859091414;9148.176664100196;9152.176304132594;9179.036201198911;5427.592930530226;5603.187537807036;5604.215409842625;5605.691686957216;5608.943910560883;3575.302815950891;3680.5215322008235;3685.1524149445777;3685.7419980601367;3755.43668449732;1128.7686024364984;1140.0936255676756;1145.3929417408788;1154.6824623228595;1829.935952241665;11996.58011969577;12311.076669249842;12353.69115772104;12355.814662780065;12412.627621171288;4487.865364039084;4708.929366059512;4785.210440277316;4805.519448055166;4823.493533179036;9548.713538593853;9550.904490955001;9558.474283914451;9562;9572.76068098303;5455.918161227585;5458.8908221835345;5466.726663666801;5466.945330546644;5469.07025805614;4576.633869290449;4697.6241900647865;4973.452920178777;5083.085044691991;5124.333836601218;3877.6703980161437;3918.3534716771983;3972.2651309507255;4026.939595906064;4028.073543085107;1173.5481839491856;1188.7622475504934;1191.3209470601673;1201.819727040951;1209.056935590241;770.5299767142039;858.8582883824099;885.7785553611598;905.248643625789;919.2737737187547;4594.333821595917;5642.548596112301;5681.971590142023;5900.881982360329;5907.232059832194;906.6917248135666;934.191923985761;954.7558964373061;959.2901253072815;995.3381001633977;3691.57546882112;3800.239952009609;3930.9582960515486;3966.345552983783;3970.305196590585;9328.300377471716;10841.620543280947;11275.267107637977;11298.152638551977;11340;10645.574177032831;11083.057940075183;11201.66395008151;11202.495887685074;11223.933726295989;8316.708915188061;8547.444416112932;8556.74329770108;8564.3148548116;8567.400281980326;5966.433188847052;5978.850528736816;5985.431384018511;6076.817695469143;6322.36776322364;9941.950290248502;10301.536430860779;10466.842997354894;10487.370757754254;10515;10664.253502254767;10672.413017284123;10677.51951162184;10677.626283080055;10689.198310126616;6995.3004699531675;7373.225811289737;7907.406944479072;7976.9202307976175;8069.3544516439715;8722.520261385685;8931.642734290815;8938;8955.238804701412;8985.865212021694;7818.765437036898;7885.329746971572;7917.327027202522;7942.364610831235;8085.191480851868;7728.574928378993;7784.338331241682;7820.608969551614;7845;7889.526628402315;7202.567845929261;7238.348548630648;7323.816904577428;7330.706771729285;7339.633018349168;4889.706617602955;4901.975490122527;5027.4218464877;5094.2103973884105;5192.065428222956;4969.82605608802;5039.906734822007;5073.213651883964;5129.948700513097;5163.483651634807 09:36:18 INFO - PROCESS | 1637 | |4;prototype.html;304.3836231630947;308.2248145913028;311.2747298793811;318.88201365494757;319.9904002879912;4342.782860856956;4684;5328.893422131555;5356.4911333423315;5432.592555558329;4425.468943726749;5008.474110218429;5044.470330615288;5176.430592634807;5227.79088836446;3523.8414271357724;4040.222302187028;4079.4900637420324;4110.424540564323;4153.833846646131;3368.6968172864435;3731.738778285521;3911.924220839278;4050.574689657588;4075.205334959684;3394.4724873806886;3596.5254245759243;3959.317290151674;4022.962663189288;4052.635262826345;3158.6051743532057;3774.622537746231;4023.8010781428543;4049.250888585621;4079.1841631673637;3511.841967111486;3525;3544.8936531904083;3562.2163124112653;3570.036090255642;4751.3585665935;4825.479973808239;5156.74216289184;5210.426853046162;5269.947300527022;3782.659560639528;3820.3314419976673;4534.342520334566;4574.428196475407;4627.953720462786;5459.863503412406;5460.198134615567;5467.480589344006;5574.327701689477;5594.552435805126;3060.265536271279;3879.553851307079;3896.7467114637743;3933.449317095609;3947.230290093404;5348.786048558053;5477.7541208104485;5702;5717.856428714233;5737.655740655574;3819.732618716663;3892.416137579329;3909.7849618270698;3954.6638535724787;3958.2281455116554;3998.2203470323007;4009.69927255457;4012.8394864205106;4019.5980401960155;4036.495438070241;4080.613091134351;4315.438992930962;4433.202023635777;4608.88477788058;4619.838305659286;4739.980904105634;4913.150372783777;5566.025945459609;5678.4605462480995;5717.113847353667;1183.721825371037;1269.6508460173527;1369.1511263016994;1370.8758817769333;1372.6911444925013;846.2257034813077;873.7592618481771;899.6851102114208;902.3007169443733;914.9222316103072;4960.453275907743;5128.025675121715;5155.700351774867;5173.611979101583;5256.605754568346;5554.555995362028;5671.744771485293;5676.460736230051;5697.601167918288;5709.771609135588;4695.859124226278;4880.975595122072;5156.1329003247565;5168.870778230575;5183.067047931333;2606.5699159638825;2890.7569745009846;2945.6465224173235;3021.0332693537857;3022.2142243016533;4634.397528321364;5640.351359593617;5653.830385088454;5824.417558244142;5889.528837692974;4853.563179313879;5270.8140668349315;5308.416074231832;5330.866728331823;5477.917831232535;5127.461616530285;5271.469694546562;5784.681842498703;5903.527717782567;5908.852278692981;5030.597552195889;5231.515030360549;5573;5626.127950167731;5626.63426877268;5513.8145298759355;5515.751791169327;5542.919130769461;5543.528800051879;5545.641317877146;5722.914156287576;5758.337791153904;5800.694843660312;5824.359320474659;5844.3571207168025;3166.5408515765544;3776.9244615108096;3846.74996125251;3846.788426636562;3849.9037524061;4273.739246922228;4583.656225783013;5746.339170995222;5753.165790960204;5756.856078597901;4467.5927082968765;5574.581906357121;5587.636803607753;5591.608587398843;5630.774769009194;4428.977855110704;4635.49009608936;5139.948600513947;5176.447065880297;5489.682476205761;4141.101229139675;4304.504981926993;5052.924206136984;5389.434109418611;5468.890622187454;3943.7633741975574;5317.654352467077;5582.246396736551;5594.195946756082;5615.775368985195;5004.799808007639;5045.789010637347;5464.453554644504;5468.2931948685655;5482.862928426821 09:36:18 INFO - PROCESS | 1637 | |5;yui.html;710.8578284343133;764.3197554176784;776.4991580430623;809.3929552835374;851.4167795060388;15806.209689515521;16825.747613785774;16867.409640662565;16884.746728799077;16901.57746056349;14978.62553436162;15054.774178387306;15071.472498462555;15083.698326033473;15096.622584435394;712.4620911212054;734.1667207719224;735.980666776513;872.4765140915448;874.6938571499987;899.1368286445021;902.5893218585528;912.3157631776168;913.4975763330175;917.1791246834113;966.9274804389664;970.5729479029239;971.4705485510414;972.8783902012249;972.9805403891953;962.6149540183983;962.961481540741;964.3779762053472;964.8552717092457;967.970960871175;715.9534630249017;716.7527203114917;718.5078221418345;719.2555704845512;722.3823630795647;16072.678546429122;16077.035377877248;16244.75632865508;16249.83750162495;16313.755293670605;13602.591922242349;14544.70910581793;14877;14940.775888361683;15073.020253683475;13175.604731857964;13411.798823017663;13416.5304214353;13480.595582132551;13524.053316267866;4555.589996900295;4564.5435456454425;4633.25867861144;4738.360321356642;4819.4939531349055;121486.57026859502;122408;127098.3645081778;130306.60906223413;132048.33975830156;11043.613473528549;11254.268472549258;11394.031507321804;11411.144164187719;11462.48418821155;21457;21806.127754889945;21949.341519754114;22070.448238794157;22162.44593885166;7942.920570794334;8030.638621262057;8064.274215320532;8174.632141553644;8228.21831925966;4463.2635615123145;4538.568835960578;4586.312053191981;4789.688670236424;4803.519648035169;3498.510208570802;3595.280943811196;3601.4957905893198;3605.152789094561;3609.620989796086;655.6426747422666;660.4155322539491;660.9900851487232;671.0437626382386;675.9966200169066;524.6176325382568;531.6677076826983;637.6556659403963;640.0507284787908;671.1610486891386;8695.869561956575;9118.316126290554;9218.953905230432;9219.07809219086;9254.814903701888;627.5983370642792;646.6411141816337;654.0940796996194;662.7879078694772;669.4209508774971;3741.4761933329355;4178.477690288714;4416.646668266531;4446.911061778811;4463.910721785546;151683;155036;155820.66269005975;156505;159051.79251269044;115313.42343288398;120210;135783;149672;149829;76441;112288.43855780669;114389;118340;120844;8436.70471533518;9929.3545919515;10268.58925642966;10370.066693997576;10434.895651043393;64372.678136609014;66345.33654663392;66875;67385.66307168432;70151.29848701652;99765;102218.48890755499;103989;106263;107024;13017.934910325388;13501.312335958006;13510.392032358372;13574.117682350616;13706.52027179044;14725.116493010453;15063.54809355721;15081.698366032837;15443.536693899201;16081.919590402442;14400.927995360375;14734.705305894036;15336.15651139198;15396.07623542591;15487.070775753491;13795.931020344835;14232.35954382076;14654.56036318912;14664.486742963945;14860.554183374516;14437.78343324872;14577.344019518934;14798.77801832995;15051.096934183985;15263.771043434579;9525.428474291564;11509.539618415505;11956.997810073592;12195.51217951272;12330.013598911886;11395.658130256106;11832.76334473323;11937.4031298433;11966.820497692368;12191.878081219074 09:36:18 INFO - PROCESS | 1637 | __end_tp_report 09:36:18 INFO - PROCESS | 1637 | __start_cc_report 09:36:18 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1364 09:36:18 INFO - PROCESS | 1637 | __end_cc_report 09:36:18 INFO - PROCESS | 1637 | __startTimestamp1482428178834__endTimestamp 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:36:18 INFO - PROCESS | 1637 | Number of tests: 6 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5766.09 Median:6062.09 stddev:655.45 (10.8%) stddev-sans-first:625.51 09:36:18 INFO - PROCESS | 1637 | Values: 3189.0 3412.7 3443.7 3459.6 3516.1 5657.5 5772.7 5783.9 5802.8 5810.9 5669.4 5717.2 5729.4 5810.9 5855.6 5185.3 5222.6 5227.9 5245.9 5279.6 5146.2 5204.8 5296.2 5320.4 5323.8 5190.0 5202.1 5205.7 5235.2 5254.5 5203.6 5212.9 5279.4 5302.2 5333.6 4623.1 5138.5 5187.0 5218.1 5222.8 5551.4 5637.9 5659.1 5662.8 5687.6 6154.0 6161.7 6227.8 6263.7 6278.7 6223.5 6259.8 6278.3 6292.8 6295.6 5679.2 5740.0 5778.3 5833.9 5849.0 6270.2 6290.0 6293.1 6313.6 6326.2 6199.7 6209.4 6223.4 6224.2 6237.3 6128.9 6191.6 6211.6 6254.7 6270.3 6242.7 6251.4 6256.4 6265.1 6277.4 6194.3 6218.8 6275.2 6294.3 6297.5 4921.2 4972.6 4981.3 5037.9 5076.2 4535.0 4547.9 4571.3 4575.7 4591.4 4724.5 5673.3 5680.8 5823.3 5831.5 6234.3 6253.3 6271.4 6289.0 6292.7 5825.6 5825.9 5826.5 5838.7 5854.8 4480.5 5397.8 5420.6 5451.6 5463.8 6375.9 6396.1 6401.9 6420.4 6438.5 6236.7 6285.7 6290.1 6299.1 6307.4 6209.1 6234.1 6276.0 6368.9 6382.8 6198.8 6255.1 6267.3 6290.5 6300.6 6279.3 6291.1 6300.7 6300.9 6326.3 6042.2 6062.1 6171.8 6215.0 6217.2 4908.6 5311.7 5860.7 6201.3 6203.9 6059.9 6080.6 6091.3 6122.0 6129.9 5997.5 6185.4 6189.1 6192.8 6199.6 5929.4 6066.3 6095.7 6102.9 6138.3 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:74304.21 Median:37658.34 stddev:166134.59 (441.2%) stddev-sans-first:166508.25 09:36:18 INFO - PROCESS | 1637 | Values: 507.7 531.2 542.1 542.4 554.7 27268.0 42453.8 43818.1 43959.8 46203.8 44917.3 45340.1 45428.8 45431.3 45550.3 9883.9 10074.2 10088.2 10089.3 10100.1 9208.3 9479.0 9480.8 9610.6 12063.0 12127.9 12480.4 12490.6 12503.5 12509.4 12303.9 12371.7 12374.2 12380.8 12390.8 12061.5 12122.8 12131.6 12144.5 12146.3 41911.0 42200.6 42202.0 42227.6 42251.4 3320.9 3343.6 3550.3 3559.6 3835.9 31280.1 31848.7 31927.5 32090.8 32312.3 3315.3 3327.4 3328.7 3401.1 3438.4 515516.0 515697.0 516125.0 516217.0 518475.4 53784.0 61988.7 62025.4 62025.4 62121.0 37460.3 37856.4 38078.8 38186.4 38192.0 17857.6 18000.6 18021.8 18037.7 18055.9 13675.0 13721.7 13776.3 13793.7 13797.9 17366.6 17661.4 19350.0 20126.1 20341.5 7041.0 7502.5 7936.1 8016.9 8019.4 884.9 897.9 975.2 990.5 1097.2 31404.4 31446.2 31448.5 31874.8 32088.2 938.3 1068.4 1083.6 1095.2 1126.1 16037.5 16323.0 16341.8 16463.7 16500.9 728302.0 735516.3 738355.0 739230.0 741547.0 60562.7 61161.7 61210.4 61223.4 61302.0 1079.9 1325.0 1329.4 1363.6 1424.7 29726.9 32854.0 32859.0 33143.1 33227.3 50654.7 51245.0 51320.2 51321.5 51388.5 584190.0 587938.0 588130.0 589897.0 590208.0 24227.9 24851.9 27049.2 27677.9 27796.7 48122.5 48247.8 48529.0 48626.5 49029.5 39164.0 40205.0 40440.4 40774.2 42029.6 41085.4 41142.4 41204.6 41463.0 41643.4 39056.4 39361.6 40136.0 40282.6 40352.6 29023.7 31751.0 35397.3 35675.5 35687.6 26415.9 26613.2 26673.7 26735.0 26973.9 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:34119.01 Median:390.65 stddev:95980.20 (24569.4%) stddev-sans-first:96215.93 09:36:18 INFO - PROCESS | 1637 | Values: 333.9 387.8 393.5 402.9 412.6 16896.5 19856.2 21166.5 21398.5 21442.4 11881.0 12321.1 12509.6 12541.5 12560.6 5490.4 5796.9 5797.2 5797.5 5810.7 4139.1 4197.3 4568.5 4603.8 5672.9 7024.1 7037.9 7137.8 7139.4 7153.9 6255.2 6270.1 6324.3 6325.0 7131.9 5387.6 6173.3 6188.4 6190.1 6191.9 13223.4 13924.4 13931.7 13941.9 17735.8 1922.7 2246.4 2270.8 2353.4 2569.7 10113.2 10248.4 10453.2 10466.8 10480.8 1877.1 1906.1 1934.7 1948.3 1971.8 97089.0 113967.9 119137.8 120766.8 125549.0 11082.3 11453.9 11509.8 11785.5 11809.4 15245.7 15269.4 15284.1 15290.0 15300.7 8869.5 9027.6 9028.9 9040.5 9122.6 9034.1 9077.7 9090.6 9186.4 9195.8 4665.8 4671.7 4684.8 4689.8 4768.1 1603.8 1929.8 1978.1 1981.2 1990.2 717.1 739.1 752.6 840.0 938.3 11870.9 12342.6 21205.7 21839.0 21958.5 368.9 382.6 395.5 430.9 442.7 5234.2 6218.8 6252.7 6360.1 6362.4 537500.0 540987.0 543297.0 606482.0 611002.0 123000.0 134729.0 146264.0 157691.0 158011.2 439.2 448.6 462.2 464.1 465.4 10189.9 11637.4 11676.5 11697.5 11895.9 56714.4 56736.7 58089.7 59846.0 60547.1 82784.6 85226.3 86894.1 87686.6 88368.6 8420.1 8422.9 8509.0 8717.9 8794.9 11107.3 12759.2 13552.4 13572.4 13595.5 11674.1 11674.4 11728.6 11964.5 11993.2 9637.4 11476.7 11572.2 11614.9 11831.0 11643.2 11723.9 11801.5 12009.7 12045.2 8304.7 8353.1 8558.1 8629.0 8639.3 9034.5 11536.5 11757.4 11833.5 12038.9 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5868.43 Median:5033.66 stddev:3324.67 (66.0%) stddev-sans-first:3316.39 09:36:18 INFO - PROCESS | 1637 | Values: 1316.3 1530.8 1564.9 1701.6 1766.2 8681.0 9253.2 9255.8 9273.9 9287.0 7496.8 8222.4 8463.7 8882.9 9006.9 2406.7 2439.4 2441.2 2444.2 2445.9 2086.3 2417.7 2418.6 2454.7 2455.3 2416.8 2430.1 2440.2 2441.0 2443.7 2050.6 2409.4 2417.6 2418.0 2422.2 2390.9 2410.5 2411.0 2415.0 2416.9 8943.0 9140.9 9148.2 9152.2 9179.0 5427.6 5603.2 5604.2 5605.7 5608.9 3575.3 3680.5 3685.2 3685.7 3755.4 1128.8 1140.1 1145.4 1154.7 1829.9 11996.6 12311.1 12353.7 12355.8 12412.6 4487.9 4708.9 4785.2 4805.5 4823.5 9548.7 9550.9 9558.5 9562.0 9572.8 5455.9 5458.9 5466.7 5466.9 5469.1 4576.6 4697.6 4973.5 5083.1 5124.3 3877.7 3918.4 3972.3 4026.9 4028.1 1173.5 1188.8 1191.3 1201.8 1209.1 770.5 858.9 885.8 905.2 919.3 4594.3 5642.5 5682.0 5900.9 5907.2 906.7 934.2 954.8 959.3 995.3 3691.6 3800.2 3931.0 3966.3 3970.3 9328.3 10841.6 11275.3 11298.2 11340.0 10645.6 11083.1 11201.7 11202.5 11223.9 8316.7 8547.4 8556.7 8564.3 8567.4 5966.4 5978.9 5985.4 6076.8 6322.4 9942.0 10301.5 10466.8 10487.4 10515.0 10664.3 10672.4 10677.5 10677.6 10689.2 6995.3 7373.2 7907.4 7976.9 8069.4 8722.5 8931.6 8938.0 8955.2 8985.9 7818.8 7885.3 7917.3 7942.4 8085.2 7728.6 7784.3 7820.6 7845.0 7889.5 7202.6 7238.3 7323.8 7330.7 7339.6 4889.7 4902.0 5027.4 5094.2 5192.1 4969.8 5039.9 5073.2 5129.9 5163.5 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4438.31 Median:5006.64 stddev:1355.53 (27.1%) stddev-sans-first:1323.34 09:36:18 INFO - PROCESS | 1637 | Values: 304.4 308.2 311.3 318.9 320.0 4342.8 4684.0 5328.9 5356.5 5432.6 4425.5 5008.5 5044.5 5176.4 5227.8 3523.8 4040.2 4079.5 4110.4 4153.8 3368.7 3731.7 3911.9 4050.6 4075.2 3394.5 3596.5 3959.3 4023.0 4052.6 3158.6 3774.6 4023.8 4049.3 4079.2 3511.8 3525.0 3544.9 3562.2 3570.0 4751.4 4825.5 5156.7 5210.4 5269.9 3782.7 3820.3 4534.3 4574.4 4628.0 5459.9 5460.2 5467.5 5574.3 5594.6 3060.3 3879.6 3896.7 3933.4 3947.2 5348.8 5477.8 5702.0 5717.9 5737.7 3819.7 3892.4 3909.8 3954.7 3958.2 3998.2 4009.7 4012.8 4019.6 4036.5 4080.6 4315.4 4433.2 4608.9 4619.8 4740.0 4913.2 5566.0 5678.5 5717.1 1183.7 1269.7 1369.2 1370.9 1372.7 846.2 873.8 899.7 902.3 914.9 4960.5 5128.0 5155.7 5173.6 5256.6 5554.6 5671.7 5676.5 5697.6 5709.8 4695.9 4881.0 5156.1 5168.9 5183.1 2606.6 2890.8 2945.6 3021.0 3022.2 4634.4 5640.4 5653.8 5824.4 5889.5 4853.6 5270.8 5308.4 5330.9 5477.9 5127.5 5271.5 5784.7 5903.5 5908.9 5030.6 5231.5 5573.0 5626.1 5626.6 5513.8 5515.8 5542.9 5543.5 5545.6 5722.9 5758.3 5800.7 5824.4 5844.4 3166.5 3776.9 3846.7 3846.8 3849.9 4273.7 4583.7 5746.3 5753.2 5756.9 4467.6 5574.6 5587.6 5591.6 5630.8 4429.0 4635.5 5139.9 5176.4 5489.7 4141.1 4304.5 5052.9 5389.4 5468.9 3943.8 5317.7 5582.2 5594.2 5615.8 5004.8 5045.8 5464.5 5468.3 5482.9 09:36:18 INFO - PROCESS | 1637 | 09:36:18 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:26461.41 Median:21631.56 stddev:42294.88 (195.5%) stddev-sans-first:42369.34 09:36:18 INFO - PROCESS | 1637 | Values: 710.9 764.3 776.5 809.4 851.4 15806.2 16825.7 16867.4 16884.7 16901.6 14978.6 15054.8 15071.5 15083.7 15096.6 712.5 734.2 736.0 872.5 874.7 899.1 902.6 912.3 913.5 917.2 966.9 970.6 971.5 972.9 973.0 962.6 963.0 964.4 964.9 968.0 716.0 716.8 718.5 719.3 722.4 16072.7 16077.0 16244.8 16249.8 16313.8 13602.6 14544.7 14877.0 14940.8 15073.0 13175.6 13411.8 13416.5 13480.6 13524.1 4555.6 4564.5 4633.3 4738.4 4819.5 121486.6 122408.0 127098.4 130306.6 132048.3 11043.6 11254.3 11394.0 11411.1 11462.5 21457.0 21806.1 21949.3 22070.4 22162.4 7942.9 8030.6 8064.3 8174.6 8228.2 4463.3 4538.6 4586.3 4789.7 4803.5 3498.5 3595.3 3601.5 3605.2 3609.6 655.6 660.4 661.0 671.0 676.0 524.6 531.7 637.7 640.1 671.2 8695.9 9118.3 9219.0 9219.1 9254.8 627.6 646.6 654.1 662.8 669.4 3741.5 4178.5 4416.6 4446.9 4463.9 151683.0 155036.0 155820.7 156505.0 159051.8 115313.4 120210.0 135783.0 149672.0 149829.0 76441.0 112288.4 114389.0 118340.0 120844.0 8436.7 9929.4 10268.6 10370.1 10434.9 64372.7 66345.3 66875.0 67385.7 70151.3 99765.0 102218.5 103989.0 106263.0 107024.0 13017.9 13501.3 13510.4 13574.1 13706.5 14725.1 15063.5 15081.7 15443.5 16081.9 14400.9 14734.7 15336.2 15396.1 15487.1 13795.9 14232.4 14654.6 14664.5 14860.6 14437.8 14577.3 14798.8 15051.1 15263.8 9525.4 11509.5 11957.0 12195.5 12330.0 11395.7 11832.8 11937.4 11966.8 12191.9 09:36:18 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:36:18 INFO - PROCESS | 1637 | 09:36:19 INFO - TEST-INFO | 1637: exit 0 09:36:19 INFO - TEST-OK | dromaeo_css | took 1115461ms 09:36:19 INFO - TEST-START | kraken 09:36:19 INFO - operating with platform_type : mac_ 09:36:19 INFO - Initialising browser for kraken test... 09:36:19 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpvvdZRq/profile http://localhost:49242/getInfo.html) 09:36:21 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:36:21 INFO - PROCESS | 1648 | colorDepth:24 09:36:21 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:36:21 INFO - PROCESS | 1648 | __metrics 09:36:21 INFO - PROCESS | 1648 | 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" 09:36:21 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:22 INFO - TEST-INFO | 1648: exit 0 09:36:22 INFO - Browser initialized. 09:36:22 INFO - Running cycle 1/1 for kraken test... 09:36:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpvvdZRq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:34 INFO - PROCESS | 1650 | RSS: Main: 168411136 09:36:34 INFO - PROCESS | 1650 | 09:36:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:37 INFO - PROCESS | 1650 | RSS: Main: 218931200 09:36:37 INFO - PROCESS | 1650 | 09:36:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 09:36:41 INFO - PROCESS | 1650 | RSS: Main: 232878080 09:36:41 INFO - PROCESS | 1650 | 09:36:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 09:36:44 INFO - PROCESS | 1650 | RSS: Main: 328802304 09:36:44 INFO - PROCESS | 1650 | 09:36:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 09:36:47 INFO - PROCESS | 1650 | RSS: Main: 229474304 09:36:47 INFO - PROCESS | 1650 | 09:36:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:50 INFO - PROCESS | 1650 | RSS: Main: 229752832 09:36:50 INFO - PROCESS | 1650 | 09:36:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:53 INFO - PROCESS | 1650 | RSS: Main: 267206656 09:36:53 INFO - PROCESS | 1650 | 09:36:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:56 INFO - PROCESS | 1650 | RSS: Main: 269602816 09:36:56 INFO - PROCESS | 1650 | 09:36:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 09:37:00 INFO - PROCESS | 1650 | RSS: Main: 266240000 09:37:00 INFO - PROCESS | 1650 | 09:37:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:02 INFO - PROCESS | 1650 | RSS: Main: 239304704 09:37:02 INFO - PROCESS | 1650 | 09:37:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:05 INFO - PROCESS | 1650 | RSS: Main: 247111680 09:37:05 INFO - PROCESS | 1650 | 09:37:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:07 INFO - PROCESS | 1650 | RSS: Main: 252874752 09:37:07 INFO - PROCESS | 1650 | 09:37:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:11 INFO - PROCESS | 1650 | RSS: Main: 258224128 09:37:11 INFO - PROCESS | 1650 | 09:37:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:14 INFO - PROCESS | 1650 | RSS: Main: 259145728 09:37:14 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 09:37:16 INFO - PROCESS | 1650 | RSS: Main: 303079424 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | __start_tp_report 09:37:16 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:37:16 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:37:16 INFO - PROCESS | 1650 | |i|pagename|runs| 09:37:16 INFO - PROCESS | 1650 | |0;ai-astar;113;113;112;114;113;113;113;113;112;113 09:37:16 INFO - PROCESS | 1650 | |1;audio-beat-detection;145;131;140;151;108;107;107;107;138;107 09:37:16 INFO - PROCESS | 1650 | |2;audio-dft;181;183;183;187;180;183;182;181;181;183 09:37:16 INFO - PROCESS | 1650 | |3;audio-fft;79;60;49;100;87;83;83;65;81;57 09:37:16 INFO - PROCESS | 1650 | |4;audio-oscillator;87;69;93;69;68;69;91;67;68;89 09:37:16 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;86;89;108;116;87;85;90;129;129;85 09:37:16 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;92;93;93;93;92;93;93;92;91 09:37:16 INFO - PROCESS | 1650 | |7;imaging-desaturate;128;133;91;94;130;140;83;84;84;89 09:37:16 INFO - PROCESS | 1650 | |8;json-parse-financial;55;51;51;52;55;55;57;55;55;55 09:37:16 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;74;75;69;70;68;68;67;68;68 09:37:16 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;80;85;83;83;83;81;86;81;87;113 09:37:16 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;138;138;141;144;154;133;133;134;147;133 09:37:16 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;160;153;162;158;160;159;162;160;160;159 09:37:16 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;66;66;66;65;68;66;71;81;84 09:37:16 INFO - PROCESS | 1650 | __end_tp_report 09:37:16 INFO - PROCESS | 1650 | __start_cc_report 09:37:16 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1801 09:37:16 INFO - PROCESS | 1650 | __end_cc_report 09:37:16 INFO - PROCESS | 1650 | __startTimestamp1482428236654__endTimestamp 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:37:16 INFO - PROCESS | 1650 | Number of tests: 14 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:37:16 INFO - PROCESS | 1650 | Values: 113.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 112.0 113.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:134.50 stddev:18.51 (13.8%) stddev-sans-first:18.02 09:37:16 INFO - PROCESS | 1650 | Values: 145.0 131.0 140.0 151.0 108.0 107.0 107.0 107.0 138.0 107.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.96 (1.1%) stddev-sans-first:2.01 09:37:16 INFO - PROCESS | 1650 | Values: 181.0 183.0 183.0 187.0 180.0 183.0 182.0 181.0 181.0 183.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:74.40 Median:80.00 stddev:15.88 (19.9%) stddev-sans-first:16.76 09:37:16 INFO - PROCESS | 1650 | Values: 79.0 60.0 49.0 100.0 87.0 83.0 83.0 65.0 81.0 57.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.00 stddev:11.30 (14.5%) stddev-sans-first:11.40 09:37:16 INFO - PROCESS | 1650 | Values: 87.0 69.0 93.0 69.0 68.0 69.0 91.0 67.0 68.0 89.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:85.50 stddev:18.37 (21.5%) stddev-sans-first:18.73 09:37:16 INFO - PROCESS | 1650 | Values: 86.0 89.0 108.0 116.0 87.0 85.0 90.0 129.0 129.0 85.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:37:16 INFO - PROCESS | 1650 | Values: 93.0 92.0 93.0 93.0 93.0 92.0 93.0 93.0 92.0 91.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:84.00 stddev:23.80 (28.3%) stddev-sans-first:23.82 09:37:16 INFO - PROCESS | 1650 | Values: 128.0 133.0 91.0 94.0 130.0 140.0 83.0 84.0 84.0 89.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:2.02 (3.7%) stddev-sans-first:2.12 09:37:16 INFO - PROCESS | 1650 | Values: 55.0 51.0 51.0 52.0 55.0 55.0 57.0 55.0 55.0 55.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:68.50 stddev:2.95 (4.3%) stddev-sans-first:2.87 09:37:16 INFO - PROCESS | 1650 | Values: 66.0 74.0 75.0 69.0 70.0 68.0 68.0 67.0 68.0 68.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.00 stddev:9.68 (11.7%) stddev-sans-first:10.01 09:37:16 INFO - PROCESS | 1650 | Values: 80.0 85.0 83.0 83.0 83.0 81.0 86.0 81.0 87.0 113.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:139.50 stddev:7.07 (5.1%) stddev-sans-first:7.48 09:37:16 INFO - PROCESS | 1650 | Values: 138.0 138.0 141.0 144.0 154.0 133.0 133.0 134.0 147.0 133.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.00 stddev:2.54 (1.6%) stddev-sans-first:2.68 09:37:16 INFO - PROCESS | 1650 | Values: 160.0 153.0 162.0 158.0 160.0 159.0 162.0 160.0 160.0 159.0 09:37:16 INFO - PROCESS | 1650 | 09:37:16 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:67.00 stddev:6.96 (10.4%) stddev-sans-first:7.16 09:37:16 INFO - PROCESS | 1650 | Values: 65.0 66.0 66.0 66.0 65.0 68.0 66.0 71.0 81.0 84.0 09:37:16 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:37:16 INFO - PROCESS | 1650 | 09:37:17 INFO - TEST-INFO | 1650: exit 0 09:37:17 INFO - TEST-OK | kraken | took 58099ms 09:37:17 INFO - SUITE-END | took 1173s 09:37:17 INFO - Completed test suite (00:19:33) 09:37:17 INFO - javascript benchmark 09:37:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.9681103188964, 3412.6587341265877, 3443.690067893889, 3459.602145753236, 3516.1385460562165, 5657.462541058598, 5772.653640781546, 5783.884322313551, 5802.825915222545, 5810.883782324357, 5669.404712505179, 5717.199592057115, 5729.427057294269, 5810.941890581093, 5855.619384739989, 5185.325907632003, 5222.582193424517, 5227.921581176285, 5245.947540524584, 5279.604029697769, 5146.176611742122, 5204.765785539641, 5296.232046353296, 5320.361556613212, 5323.840284791462, 5190.039842629107, 5202.141646628302, 5205.687658740469, 5235.188545775411, 5254.500822421864, 5203.60972927032, 5212.8957420851375, 5279.41926388097, 5302.2046692996355, 5333.626646134772, 4623.144718227105, 5138.537531622134, 5186.974065129688, 5218.112920803473, 5222.764975576109, 5551.444855514456, 5637.8590535236535, 5659.122835960433, 5662.830115096513, 5687.630304030266, 6154.0, 6161.691915404257, 6227.782027629011, 6263.749450021994, 6278.748850046039, 6223.518926965777, 6259.843503912393, 6278.277998030194, 6292.779752708679, 6295.622262664255, 5679.233303504016, 5740.024195886667, 5778.27771528559, 5833.854153646108, 5848.970755146197, 6270.2475702915945, 6290.0, 6293.056041593798, 6313.55805093639, 6326.177596912464, 6199.721012554446, 6209.410106039919, 6223.408776166257, 6224.221972253468, 6237.282712488122, 6128.930927367261, 6191.628502289877, 6211.596246243979, 6254.718537665725, 6270.31026587075, 6242.687865606701, 6251.374862513712, 6256.436920677161, 6265.091561723524, 6277.372262773686, 6194.34959329273, 6218.81343559694, 6275.152854364694, 6294.339094395114, 6297.4962003039645, 4921.237208232729, 4972.627052970969, 4981.277714731416, 5037.949620503748, 5076.187809950464, 4535.047639995638, 4547.8635640930825, 4571.337156112345, 4575.7483338416705, 4591.357209990604, 4724.456687480915, 5673.262475878109, 5680.829575112753, 5823.330317013513, 5831.533477321804, 6234.2830574483605, 6253.343398943137, 6271.372862713783, 6289.0252010938375, 6292.748290068437, 5825.592208545361, 5825.941740582624, 5826.475617194388, 5838.737256823453, 5854.765809367577, 4480.507144214133, 5397.7571009304675, 5420.620556561082, 5451.591130665216, 5463.754131064112, 6375.904361434582, 6396.104545363746, 6401.8719625608155, 6420.390062944013, 6438.549301548846, 6236.688165591611, 6285.748570057147, 6290.087937248982, 6299.118123462627, 6307.400796924285, 6209.0996805462055, 6234.127222188988, 6276.0, 6368.9044664330995, 6382.840428989312, 6198.845028874314, 6255.061740738925, 6267.341929097379, 6290.49676025926, 6300.558960872695, 6279.30927597973, 6291.087792270004, 6300.71646775887, 6300.873982520232, 6326.335734747785, 6042.184305118929, 6062.090686397076, 6171.783987560414, 6214.9689251553455, 6217.160683307696, 4908.63185261114, 5311.654742441729, 5860.739940912724, 6201.348858369806, 6203.937960620336, 6059.939400605937, 6080.574066619961, 6091.274296978388, 6122.0, 6129.908051379144, 5997.490213331916, 6185.381461853779, 6189.102580125947, 6192.783252586138, 6199.5660303780105, 5929.377415371497, 6066.272047354346, 6095.725692343944, 6102.917792971912, 6138.324784273816], "value": 5724.64689537266, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.6928458282739, 531.2482836785946, 542.0919959068564, 542.3600151820852, 554.6616563896023, 27268.0, 42453.78773106134, 43818.12363752727, 43959.78020109903, 46203.84490387742, 44917.32624010643, 45340.0931981361, 45428.77285613567, 45431.31853022207, 45550.31674524885, 9883.90116098837, 10074.194064474825, 10088.243381746363, 10089.293749437542, 10100.141487973531, 9208.263338932902, 9479.0, 9480.81038379232, 9610.615575376976, 12063.0, 12127.878721212808, 12480.438380272864, 12490.625281241577, 12503.499860005635, 12509.437075331587, 12303.938480307586, 12371.690707732289, 12374.195677280948, 12380.81428778569, 12390.75218495634, 12061.517539298418, 12122.757544849143, 12131.636050918487, 12144.453499592451, 12146.271223726604, 41911.0, 42200.57799421997, 42202.0, 42227.57772422298, 42251.36622950658, 3320.912207482491, 3343.632200457948, 3550.3076900004507, 3559.626239244868, 3835.884923452301, 31280.061598152093, 31848.6815131848, 31927.52108718371, 32090.839545802122, 32312.272709107678, 3315.336932613487, 3327.434336162858, 3328.7170590499836, 3401.132711158639, 3438.415469370188, 515516.0, 515697.0, 516125.0, 516217.0, 518475.40762296325, 53784.0, 61988.69005655033, 62025.37974620196, 62025.37974620286, 62121.0, 37460.250794984495, 37856.43215351772, 38078.80960595179, 38186.42720359197, 38192.0, 17857.553561160814, 18000.639987200444, 18021.819781802013, 18037.729434058238, 18055.916645001344, 13675.0, 13721.656958576115, 13776.311184440738, 13793.724125517634, 13797.862021379859, 17366.56583585395, 17661.38185163513, 19349.962207105043, 20126.094325755377, 20341.49146271355, 7040.9647951760935, 7502.549847009088, 7936.127026027132, 8016.919830801734, 8019.398545109024, 884.920357167858, 897.9236764874928, 975.1759763000396, 990.5195979949718, 1097.2209731090854, 31404.371912561623, 31446.213844654067, 31448.52827207594, 31874.84062579672, 32088.197795054843, 938.3290946972947, 1068.385678235018, 1083.5503266144462, 1095.1622009162998, 1126.1385040444068, 16037.518874433787, 16323.0, 16341.836581634268, 16463.68407203106, 16500.917495412446, 728302.0, 735516.3224183952, 738355.0, 739230.0, 741547.0, 60562.69718651378, 61161.69419152965, 61210.38789612047, 61223.38776612177, 61302.0, 1079.875814281352, 1324.9735005300033, 1329.4349901292105, 1363.584106847421, 1424.665203677135, 29726.851365743034, 32854.0, 32859.0, 33143.094734861865, 33227.335453291285, 50654.74672626613, 51245.0, 51320.230196546334, 51321.486785133166, 51388.48611513837, 584190.0, 587938.0, 588130.0, 589897.0, 590208.0, 24227.909744061206, 24851.87574062118, 27049.1885243443, 27677.892884284403, 27796.722032779413, 48122.518774811804, 48247.75876120738, 48529.0, 48626.51373486361, 49029.50970490392, 39164.02089947774, 40205.0, 40440.3933940997, 40774.1845163101, 42029.57970420379, 41085.38371924364, 41142.38286425646, 41204.58795412008, 41463.0, 41643.37534936918, 39056.41415378828, 39361.606383935796, 40135.99660008523, 40282.597174029055, 40352.596474034886, 29023.7097629021, 31751.0, 35397.29205415929, 35675.46486802752, 35687.64312356843, 26415.867920660272, 26613.20160395191, 26673.733262667123, 26735.041369358183, 26973.86513067422], "value": 20821.35502002914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.92486690494644, 387.78477944740655, 393.51401019740626, 402.8630265709658, 412.60802237874026, 16896.493105206864, 19856.20575176993, 21166.470838229052, 21398.465038374048, 21442.356729298106, 11881.0, 12321.075919306066, 12509.562165324216, 12541.49834006641, 12560.623181304576, 5490.368607610126, 5796.913046304308, 5797.188393624896, 5797.478226959573, 5810.709464526778, 4139.130782535671, 4197.307444271692, 4568.474625418086, 4603.792829322689, 5672.9432705672825, 7024.121984751906, 7037.929620703804, 7137.785866424016, 7139.428845692358, 7153.856922861566, 6255.186825712673, 6270.09083682868, 6324.3359447257835, 6324.968375158095, 7131.928680713204, 5387.595930305243, 6173.290071641729, 6188.350223226586, 6190.133381326618, 6191.938080619227, 13223.404946777418, 13924.37340319688, 13931.721365572734, 13941.86058139426, 17735.822641773677, 1922.7019811929174, 2246.382244882654, 2270.761570035139, 2353.446939969106, 2569.678790151231, 10113.190944724405, 10248.436336001518, 10453.21600879937, 10466.79066418675, 10480.842787358195, 1877.0614692653674, 1906.1041310584003, 1934.7001214811726, 1948.3473036532778, 1971.7732460766908, 97089.0, 113967.86032139655, 119137.80862191354, 120766.79233207644, 125549.0, 11082.335059896432, 11453.942730286462, 11509.827352589551, 11785.469653865597, 11809.40952952349, 15245.695086098216, 15269.389224430899, 15284.082955022734, 15290.0, 15300.699440547456, 8869.512176830207, 9027.593758280893, 9028.909710902806, 9040.502772347583, 9122.635094596142, 9034.051424600453, 9077.68228112013, 9090.636374545076, 9186.40288381253, 9195.770105747277, 4665.836695715634, 4671.7430541320555, 4684.8360307389075, 4689.7655117244, 4768.094062128184, 1603.847634474723, 1929.8166674165932, 1978.0999645161417, 1981.2471260920759, 1990.1840245499275, 717.1394326807851, 739.0747103794645, 752.6048824367142, 840.0171798995191, 938.2789909263191, 11870.940645296718, 12342.568010119603, 21205.738781376156, 21838.955062531753, 21958.45103872416, 368.87458264190303, 382.6116491760865, 395.47599430754366, 430.9267424537836, 442.73214705103595, 5234.241035049972, 6218.751249950042, 6252.656103914328, 6360.0777887206095, 6362.427381535684, 537500.0, 540987.0, 543297.0, 606482.0, 611002.0, 123000.0, 134729.0, 146264.0, 157691.0, 158011.20994394954, 439.16558538775945, 448.64332855380053, 462.24653814282505, 464.06027793717993, 465.36245343878426, 10189.860129372915, 11637.418129093681, 11676.532938682358, 11697.473613687234, 11895.881041189477, 56714.43285567257, 56736.716316418155, 58089.709551451975, 59846.0, 60547.091793624015, 82784.58607706922, 85226.29547408893, 86894.13105869113, 87686.56156719176, 88368.5581572088, 8420.10547626779, 8422.873656895274, 8509.0, 8717.869231961398, 8794.91205087941, 11107.333559986104, 12759.170653907466, 13552.390142443417, 13572.389242484309, 13595.456181753014, 11674.066074714172, 11674.416279185836, 11728.648140555797, 11964.521419143484, 11993.160478766402, 9637.37357071788, 11476.655700329004, 11572.24780389272, 11614.88385116138, 11831.0, 11643.184977051525, 11723.941380293043, 11801.468933898166, 12009.699757506132, 12045.156839021185, 8304.70933517324, 8353.0811610724, 8558.101399353227, 8628.979857049982, 8639.308855291687, 9034.548272586213, 11536.538538458368, 11757.412129393668, 11833.46749396262, 12038.879611203776], "value": 8765.629075126822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.2760481735043, 1530.8163020437548, 1564.8669863061639, 1701.6001239708673, 1766.2140347545349, 8681.0, 9253.213476854458, 9255.768605784859, 9273.907260927388, 9287.024862389453, 7496.775096747093, 8222.424430289882, 8463.661453541867, 8882.911170888288, 9006.86489702655, 2406.651035599837, 2439.353571303606, 2441.218809980807, 2444.181199298237, 2445.877706114696, 2086.332373640428, 2417.746136655652, 2418.6492958521003, 2454.7054353477606, 2455.2756936703627, 2416.7704068113503, 2430.1373012580543, 2440.1825388494876, 2441.0357908626083, 2443.7189723181796, 2050.6103840270302, 2409.4096946248105, 2417.552752740731, 2417.9844465324604, 2422.188566830114, 2390.8804559771943, 2410.5058463015216, 2410.963835542468, 2415.0, 2416.9395765105837, 8943.0, 9140.90859091414, 9148.176664100196, 9152.176304132594, 9179.036201198911, 5427.592930530226, 5603.187537807036, 5604.215409842625, 5605.691686957216, 5608.943910560883, 3575.302815950891, 3680.5215322008235, 3685.1524149445777, 3685.7419980601367, 3755.43668449732, 1128.7686024364984, 1140.0936255676756, 1145.3929417408788, 1154.6824623228595, 1829.935952241665, 11996.58011969577, 12311.076669249842, 12353.69115772104, 12355.814662780065, 12412.627621171288, 4487.865364039084, 4708.929366059512, 4785.210440277316, 4805.519448055166, 4823.493533179036, 9548.713538593853, 9550.904490955001, 9558.474283914451, 9562.0, 9572.76068098303, 5455.918161227585, 5458.8908221835345, 5466.726663666801, 5466.945330546644, 5469.07025805614, 4576.633869290449, 4697.6241900647865, 4973.452920178777, 5083.085044691991, 5124.333836601218, 3877.6703980161437, 3918.3534716771983, 3972.2651309507255, 4026.939595906064, 4028.073543085107, 1173.5481839491856, 1188.7622475504934, 1191.3209470601673, 1201.819727040951, 1209.056935590241, 770.5299767142039, 858.8582883824099, 885.7785553611598, 905.248643625789, 919.2737737187547, 4594.333821595917, 5642.548596112301, 5681.971590142023, 5900.881982360329, 5907.232059832194, 906.6917248135666, 934.191923985761, 954.7558964373061, 959.2901253072815, 995.3381001633977, 3691.57546882112, 3800.239952009609, 3930.9582960515486, 3966.345552983783, 3970.305196590585, 9328.300377471716, 10841.620543280947, 11275.267107637977, 11298.152638551977, 11340.0, 10645.574177032831, 11083.057940075183, 11201.66395008151, 11202.495887685074, 11223.933726295989, 8316.708915188061, 8547.444416112932, 8556.74329770108, 8564.3148548116, 8567.400281980326, 5966.433188847052, 5978.850528736816, 5985.431384018511, 6076.817695469143, 6322.36776322364, 9941.950290248502, 10301.536430860779, 10466.842997354894, 10487.370757754254, 10515.0, 10664.253502254767, 10672.413017284123, 10677.51951162184, 10677.626283080055, 10689.198310126616, 6995.3004699531675, 7373.225811289737, 7907.406944479072, 7976.9202307976175, 8069.3544516439715, 8722.520261385685, 8931.642734290815, 8938.0, 8955.238804701412, 8985.865212021694, 7818.765437036898, 7885.329746971572, 7917.327027202522, 7942.364610831235, 8085.191480851868, 7728.574928378993, 7784.338331241682, 7820.608969551614, 7845.0, 7889.526628402315, 7202.567845929261, 7238.348548630648, 7323.816904577428, 7330.706771729285, 7339.633018349168, 4889.706617602955, 4901.975490122527, 5027.4218464877, 5094.2103973884105, 5192.065428222956, 4969.82605608802, 5039.906734822007, 5073.213651883964, 5129.948700513097, 5163.483651634807], "value": 4696.862733409546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3836231630947, 308.2248145913028, 311.2747298793811, 318.88201365494757, 319.9904002879912, 4342.782860856956, 4684.0, 5328.893422131555, 5356.4911333423315, 5432.592555558329, 4425.468943726749, 5008.474110218429, 5044.470330615288, 5176.430592634807, 5227.79088836446, 3523.8414271357724, 4040.222302187028, 4079.4900637420324, 4110.424540564323, 4153.833846646131, 3368.6968172864435, 3731.738778285521, 3911.924220839278, 4050.574689657588, 4075.205334959684, 3394.4724873806886, 3596.5254245759243, 3959.317290151674, 4022.962663189288, 4052.635262826345, 3158.6051743532057, 3774.622537746231, 4023.8010781428543, 4049.250888585621, 4079.1841631673637, 3511.841967111486, 3525.0, 3544.8936531904083, 3562.2163124112653, 3570.036090255642, 4751.3585665935, 4825.479973808239, 5156.74216289184, 5210.426853046162, 5269.947300527022, 3782.659560639528, 3820.3314419976673, 4534.342520334566, 4574.428196475407, 4627.953720462786, 5459.863503412406, 5460.198134615567, 5467.480589344006, 5574.327701689477, 5594.552435805126, 3060.265536271279, 3879.553851307079, 3896.7467114637743, 3933.449317095609, 3947.230290093404, 5348.786048558053, 5477.7541208104485, 5702.0, 5717.856428714233, 5737.655740655574, 3819.732618716663, 3892.416137579329, 3909.7849618270698, 3954.6638535724787, 3958.2281455116554, 3998.2203470323007, 4009.69927255457, 4012.8394864205106, 4019.5980401960155, 4036.495438070241, 4080.613091134351, 4315.438992930962, 4433.202023635777, 4608.88477788058, 4619.838305659286, 4739.980904105634, 4913.150372783777, 5566.025945459609, 5678.4605462480995, 5717.113847353667, 1183.721825371037, 1269.6508460173527, 1369.1511263016994, 1370.8758817769333, 1372.6911444925013, 846.2257034813077, 873.7592618481771, 899.6851102114208, 902.3007169443733, 914.9222316103072, 4960.453275907743, 5128.025675121715, 5155.700351774867, 5173.611979101583, 5256.605754568346, 5554.555995362028, 5671.744771485293, 5676.460736230051, 5697.601167918288, 5709.771609135588, 4695.859124226278, 4880.975595122072, 5156.1329003247565, 5168.870778230575, 5183.067047931333, 2606.5699159638825, 2890.7569745009846, 2945.6465224173235, 3021.0332693537857, 3022.2142243016533, 4634.397528321364, 5640.351359593617, 5653.830385088454, 5824.417558244142, 5889.528837692974, 4853.563179313879, 5270.8140668349315, 5308.416074231832, 5330.866728331823, 5477.917831232535, 5127.461616530285, 5271.469694546562, 5784.681842498703, 5903.527717782567, 5908.852278692981, 5030.597552195889, 5231.515030360549, 5573.0, 5626.127950167731, 5626.63426877268, 5513.8145298759355, 5515.751791169327, 5542.919130769461, 5543.528800051879, 5545.641317877146, 5722.914156287576, 5758.337791153904, 5800.694843660312, 5824.359320474659, 5844.3571207168025, 3166.5408515765544, 3776.9244615108096, 3846.74996125251, 3846.788426636562, 3849.9037524061, 4273.739246922228, 4583.656225783013, 5746.339170995222, 5753.165790960204, 5756.856078597901, 4467.5927082968765, 5574.581906357121, 5587.636803607753, 5591.608587398843, 5630.774769009194, 4428.977855110704, 4635.49009608936, 5139.948600513947, 5176.447065880297, 5489.682476205761, 4141.101229139675, 4304.504981926993, 5052.924206136984, 5389.434109418611, 5468.890622187454, 3943.7633741975574, 5317.654352467077, 5582.246396736551, 5594.195946756082, 5615.775368985195, 5004.799808007639, 5045.789010637347, 5464.453554644504, 5468.2931948685655, 5482.862928426821], "value": 4015.3813012965293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8578284343133, 764.3197554176784, 776.4991580430623, 809.3929552835374, 851.4167795060388, 15806.209689515521, 16825.747613785774, 16867.409640662565, 16884.746728799077, 16901.57746056349, 14978.62553436162, 15054.774178387306, 15071.472498462555, 15083.698326033473, 15096.622584435394, 712.4620911212054, 734.1667207719224, 735.980666776513, 872.4765140915448, 874.6938571499987, 899.1368286445021, 902.5893218585528, 912.3157631776168, 913.4975763330175, 917.1791246834113, 966.9274804389664, 970.5729479029239, 971.4705485510414, 972.8783902012249, 972.9805403891953, 962.6149540183983, 962.961481540741, 964.3779762053472, 964.8552717092457, 967.970960871175, 715.9534630249017, 716.7527203114917, 718.5078221418345, 719.2555704845512, 722.3823630795647, 16072.678546429122, 16077.035377877248, 16244.75632865508, 16249.83750162495, 16313.755293670605, 13602.591922242349, 14544.70910581793, 14877.0, 14940.775888361683, 15073.020253683475, 13175.604731857964, 13411.798823017663, 13416.5304214353, 13480.595582132551, 13524.053316267866, 4555.589996900295, 4564.5435456454425, 4633.25867861144, 4738.360321356642, 4819.4939531349055, 121486.57026859502, 122408.0, 127098.3645081778, 130306.60906223413, 132048.33975830156, 11043.613473528549, 11254.268472549258, 11394.031507321804, 11411.144164187719, 11462.48418821155, 21457.0, 21806.127754889945, 21949.341519754114, 22070.448238794157, 22162.44593885166, 7942.920570794334, 8030.638621262057, 8064.274215320532, 8174.632141553644, 8228.21831925966, 4463.2635615123145, 4538.568835960578, 4586.312053191981, 4789.688670236424, 4803.519648035169, 3498.510208570802, 3595.280943811196, 3601.4957905893198, 3605.152789094561, 3609.620989796086, 655.6426747422666, 660.4155322539491, 660.9900851487232, 671.0437626382386, 675.9966200169066, 524.6176325382568, 531.6677076826983, 637.6556659403963, 640.0507284787908, 671.1610486891386, 8695.869561956575, 9118.316126290554, 9218.953905230432, 9219.07809219086, 9254.814903701888, 627.5983370642792, 646.6411141816337, 654.0940796996194, 662.7879078694772, 669.4209508774971, 3741.4761933329355, 4178.477690288714, 4416.646668266531, 4446.911061778811, 4463.910721785546, 151683.0, 155036.0, 155820.66269005975, 156505.0, 159051.79251269044, 115313.42343288398, 120210.0, 135783.0, 149672.0, 149829.0, 76441.0, 112288.43855780669, 114389.0, 118340.0, 120844.0, 8436.70471533518, 9929.3545919515, 10268.58925642966, 10370.066693997576, 10434.895651043393, 64372.678136609014, 66345.33654663392, 66875.0, 67385.66307168432, 70151.29848701652, 99765.0, 102218.48890755499, 103989.0, 106263.0, 107024.0, 13017.934910325388, 13501.312335958006, 13510.392032358372, 13574.117682350616, 13706.52027179044, 14725.116493010453, 15063.54809355721, 15081.698366032837, 15443.536693899201, 16081.919590402442, 14400.927995360375, 14734.705305894036, 15336.15651139198, 15396.07623542591, 15487.070775753491, 13795.931020344835, 14232.35954382076, 14654.56036318912, 14664.486742963945, 14860.554183374516, 14437.78343324872, 14577.344019518934, 14798.77801832995, 15051.096934183985, 15263.771043434579, 9525.428474291564, 11509.539618415505, 11956.997810073592, 12195.51217951272, 12330.013598911886, 11395.658130256106, 11832.76334473323, 11937.4031298433, 11966.820497692368, 12191.878081219074], "value": 8215.28013719355, "unit": "score"}], "name": "dromaeo_css", "value": 7382.567614298115, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 131.0, 140.0, 151.0, 108.0, 107.0, 107.0, 107.0, 138.0, 107.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 187.0, 180.0, 183.0, 182.0, 181.0, 181.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 49.0, 100.0, 87.0, 83.0, 83.0, 65.0, 81.0, 57.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 93.0, 69.0, 68.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 108.0, 116.0, 87.0, 85.0, 90.0, 129.0, 129.0, 85.0], "value": 100.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 92.0, 91.0], "value": 92.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 91.0, 94.0, 130.0, 140.0, 83.0, 84.0, 84.0, 89.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 52.0, 55.0, 55.0, 57.0, 55.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 75.0, 69.0, 70.0, 68.0, 68.0, 67.0, 68.0, 68.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 83.0, 83.0, 83.0, 81.0, 86.0, 81.0, 87.0, 113.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 141.0, 144.0, 154.0, 133.0, 133.0, 134.0, 147.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 153.0, 162.0, 158.0, 160.0, 159.0, 162.0, 160.0, 160.0, 159.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 68.0, 66.0, 71.0, 81.0, 84.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1447.4999999999998, "alertThreshold": 2.0}]} 09:37:17 INFO - Return code: 0 09:37:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:37:17 INFO - # TBPL SUCCESS # 09:37:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:17 INFO - 2016-12-22 09:37:17.955 screenresolution[1654:9788] starting screenresolution argv=screenresolution get 09:37:17 INFO - 2016-12-22 09:37:17.957 screenresolution[1654:9788] Display 0: 1600x1200x32@60 09:37:17 INFO - 2016-12-22 09:37:17.963 screenresolution[1655:9791] starting screenresolution argv=screenresolution list 09:37:17 INFO - Available Modes on Display 0 09:37:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:18 INFO - Intel Iris: 09:37:18 INFO - Chipset Model: Intel Iris 09:37:18 INFO - Type: GPU 09:37:18 INFO - Bus: Built-In 09:37:18 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:18 INFO - Vendor: Intel (0x8086) 09:37:18 INFO - Device ID: 0x0a2e 09:37:18 INFO - Revision ID: 0x0009 09:37:18 INFO - Displays: 09:37:18 INFO - Display: 09:37:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:18 INFO - Display Serial Number: 1600x1200 60 09:37:18 INFO - Main Display: Yes 09:37:18 INFO - Mirror: Off 09:37:18 INFO - Online: Yes 09:37:18 INFO - Rotation: Supported 09:37:18 INFO - Return code: 0 09:37:18 INFO - Running post-action listener: _resource_record_post_action 09:37:18 INFO - [mozharness: 2016-12-22 17:37:18.199100Z] Finished run-tests step (success) 09:37:18 INFO - Running post-run listener: _resource_record_post_run 09:37:18 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 39023616; Write bytes: 493278720; Read time: 384; Write time: 1588 09:37:18 INFO - TinderboxPrint: CPU usage
53.3% 09:37:18 INFO - TinderboxPrint: I/O read bytes / time
39,023,616 / 384 09:37:18 INFO - TinderboxPrint: I/O write bytes / time
493,278,720 / 1,588 09:37:18 INFO - TinderboxPrint: CPU idle
2,236.0 (46.7%) 09:37:18 INFO - TinderboxPrint: CPU system
953.3 (19.9%) 09:37:18 INFO - TinderboxPrint: CPU user
1,596.4 (33.4%) 09:37:18 INFO - TinderboxPrint: Swap in / out
233,947,136 / 0 09:37:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192487936; Write bytes: 185761792; Read time: 18013; Write time: 332 09:37:18 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 36897792; Write bytes: 296404480; Read time: 357; Write time: 1226 09:37:18 INFO - Running post-run listener: _upload_blobber_files 09:37:18 INFO - Blob upload gear active. 09:37:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:37:18 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 09:37:18 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'] 09:37:18 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 09:37:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:37:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:20 INFO - (blobuploader) - INFO - Done attempting. 09:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:21 INFO - (blobuploader) - INFO - Done attempting. 09:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:23 INFO - (blobuploader) - INFO - Done attempting. 09:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:23 INFO - Return code: 0 09:37:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19479a4dc781cf9f851462edc9226d81a236a54cc91101e6f45a317129bc4cd53fce38895104adc80a5b5686f09f08757f11024cc5a2eb6ece1958e377dfd2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd6ad1cb06f1ce7bb223f3381b226b2eb0a78f7de6ce32f7756799e375fb5f81ccfa6b9ca0ced59889222a5c22d0b3ecc7b76c213d0f0627138666d693c182f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b4d4f133a041b24afe2b64499a67d94254e1126526c7ed04e3d61ea78b172d508a5c844ed21adb7b9e3842e53973df5c3ebaae46363fa7ada53d02a4d9ce3f"} 09:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:23 INFO - Contents: 09:37:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19479a4dc781cf9f851462edc9226d81a236a54cc91101e6f45a317129bc4cd53fce38895104adc80a5b5686f09f08757f11024cc5a2eb6ece1958e377dfd2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd6ad1cb06f1ce7bb223f3381b226b2eb0a78f7de6ce32f7756799e375fb5f81ccfa6b9ca0ced59889222a5c22d0b3ecc7b76c213d0f0627138666d693c182f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b4d4f133a041b24afe2b64499a67d94254e1126526c7ed04e3d61ea78b172d508a5c844ed21adb7b9e3842e53973df5c3ebaae46363fa7ada53d02a4d9ce3f"} 09:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:23 INFO - Copying logs to upload dir... 09:37:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.533643 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-12-22 09:37:23.783213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:23.786470) ========= 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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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/19479a4dc781cf9f851462edc9226d81a236a54cc91101e6f45a317129bc4cd53fce38895104adc80a5b5686f09f08757f11024cc5a2eb6ece1958e377dfd2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd6ad1cb06f1ce7bb223f3381b226b2eb0a78f7de6ce32f7756799e375fb5f81ccfa6b9ca0ced59889222a5c22d0b3ecc7b76c213d0f0627138666d693c182f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b4d4f133a041b24afe2b64499a67d94254e1126526c7ed04e3d61ea78b172d508a5c844ed21adb7b9e3842e53973df5c3ebaae46363fa7ada53d02a4d9ce3f"} build_url:https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010768 build_url: 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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/19479a4dc781cf9f851462edc9226d81a236a54cc91101e6f45a317129bc4cd53fce38895104adc80a5b5686f09f08757f11024cc5a2eb6ece1958e377dfd2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd6ad1cb06f1ce7bb223f3381b226b2eb0a78f7de6ce32f7756799e375fb5f81ccfa6b9ca0ced59889222a5c22d0b3ecc7b76c213d0f0627138666d693c182f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b4d4f133a041b24afe2b64499a67d94254e1126526c7ed04e3d61ea78b172d508a5c844ed21adb7b9e3842e53973df5c3ebaae46363fa7ada53d02a4d9ce3f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:23.819804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:23.820160) ========= 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.6MtzVvtVsL/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.5w1i8BQNPw/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:23.868840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:37:23.869175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:37:23.869492) ========= ========= Total master_lag: 0.17 =========