builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1476179279.01 results: success (0) buildid: 20161011004015 builduid: 493ec98de2734c049c659a825a86cd7f revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.007762) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.008141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.008416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.037355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.037615) ========= 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.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-10-11 02:47:59-- 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% 14.1M=0.001s 2016-10-11 02:47:59 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.195499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.195777) ========= 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.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.028775 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.246100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.246430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-10-11 02:47:59,321 truncating revision to first 12 chars 2016-10-11 02:47:59,321 Setting DEBUG logging. 2016-10-11 02:47:59,321 attempt 1/10 2016-10-11 02:47:59,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a452e8fde0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 02:47:59,852 unpacking tar archive at: mozilla-aurora-9a452e8fde0f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.861773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.129357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.129627) ========= script_repo_revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.129992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.130251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.148873) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-11 02:48:00.149253) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:00 INFO - MultiFileLogger online at 20161011 02:48:00 in /builds/slave/test 02:48:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:48:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:00 INFO - {'append_to_log': False, 02:48:00 INFO - 'base_work_dir': '/builds/slave/test', 02:48:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:00 INFO - 'branch': 'Mozilla-Aurora', 02:48:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:00 INFO - 'config_files': ('talos/mac_config.py',), 02:48:00 INFO - 'default_actions': ('clobber', 02:48:00 INFO - 'read-buildbot-config', 02:48:00 INFO - 'download-and-extract', 02:48:00 INFO - 'populate-webroot', 02:48:00 INFO - 'create-virtualenv', 02:48:00 INFO - 'install', 02:48:00 INFO - 'run-tests'), 02:48:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:00 INFO - 'download_minidump_stackwalk': True, 02:48:00 INFO - 'download_symbols': 'ondemand', 02:48:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:00 INFO - 'installer_path': 'installer.exe', 02:48:00 INFO - 'log_level': 'info', 02:48:00 INFO - 'log_name': 'talos', 02:48:00 INFO - 'log_to_console': True, 02:48:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:00 INFO - 'opt_config_files': (), 02:48:00 INFO - 'pip_index': False, 02:48:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:00 INFO - 'cmd': ('bash', 02:48:00 INFO - '-c', 02:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:00 INFO - 'enabled': True, 02:48:00 INFO - 'halt_on_failure': False, 02:48:00 INFO - 'name': 'check_screen_resolution'},), 02:48:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:00 INFO - 'cmd': ('bash', 02:48:00 INFO - '-c', 02:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:00 INFO - 'enabled': True, 02:48:00 INFO - 'halt_on_failure': False, 02:48:00 INFO - 'name': 'check_screen_resolution'},), 02:48:00 INFO - 'run_cmd_checks_enabled': True, 02:48:00 INFO - 'sps_profile': False, 02:48:00 INFO - 'sps_profile_interval': 0, 02:48:00 INFO - 'suite': 'dromaeojs', 02:48:00 INFO - 'system_bits': '32', 02:48:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:00 INFO - 'title': 't-yosemite-r7-0036', 02:48:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:00 INFO - 'use_talos_json': True, 02:48:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:00 INFO - 'work_dir': 'build'} 02:48:00 INFO - [mozharness: 2016-10-11 09:48:00.357556Z] Running clobber step. 02:48:00 INFO - Running pre-action listener: _resource_record_pre_action 02:48:00 INFO - Running main action method: clobber 02:48:00 INFO - rmtree: /builds/slave/test/build 02:48:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:02 INFO - Running post-action listener: _resource_record_post_action 02:48:02 INFO - [mozharness: 2016-10-11 09:48:02.619435Z] Finished clobber step (success) 02:48:02 INFO - [mozharness: 2016-10-11 09:48:02.619651Z] Running read-buildbot-config step. 02:48:02 INFO - Running pre-action listener: _resource_record_pre_action 02:48:02 INFO - Running main action method: read_buildbot_config 02:48:02 INFO - Using buildbot properties: 02:48:02 INFO - { 02:48:02 INFO - "project": "", 02:48:02 INFO - "product": "firefox", 02:48:02 INFO - "script_repo_revision": "production", 02:48:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:48:02 INFO - "repository": "", 02:48:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:48:02 INFO - "buildid": "20161011004015", 02:48:02 INFO - "stage_platform": "macosx64", 02:48:02 INFO - "basedir": "/builds/slave/test", 02:48:02 INFO - "nightly_build": "True", 02:48:02 INFO - "buildnumber": 42, 02:48:02 INFO - "slavename": "t-yosemite-r7-0036", 02:48:02 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:48:02 INFO - "platform": "yosemite_r7", 02:48:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:48:02 INFO - "branch": "mozilla-aurora", 02:48:02 INFO - "repo_path": "releases/mozilla-aurora", 02:48:02 INFO - "revision": "9a452e8fde0ffd76d25179f5d6165265444a2247", 02:48:02 INFO - "pgo_build": "False", 02:48:02 INFO - "builduid": "493ec98de2734c049c659a825a86cd7f", 02:48:02 INFO - "slavebuilddir": "test" 02:48:02 INFO - } 02:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:48:02 INFO - Running post-action listener: _resource_record_post_action 02:48:02 INFO - [mozharness: 2016-10-11 09:48:02.624941Z] Finished read-buildbot-config step (success) 02:48:02 INFO - [mozharness: 2016-10-11 09:48:02.625029Z] Running download-and-extract step. 02:48:02 INFO - Running pre-action listener: _resource_record_pre_action 02:48:02 INFO - Running main action method: download_and_extract 02:48:02 INFO - mkdir: /builds/slave/test/build/tests 02:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:02 INFO - trying https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:48:03 INFO - Downloaded 1199 bytes. 02:48:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:03 INFO - Using the following test package requirements: 02:48:03 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:03 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:48:03 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:48:03 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'jsshell-mac.zip'], 02:48:03 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:48:03 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:03 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:48:03 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:48:03 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:48:03 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:48:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:48:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:04 INFO - Expected file size: 16434994 02:48:11 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:11 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:12 INFO - Expected file size: 16434994 02:48:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:48:18 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:48:19 INFO - Expected file size: 14414059 02:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:19 INFO - trying https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:19 INFO - Downloading https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:48:22 INFO - Downloaded 115437539 bytes. 02:48:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:22 INFO - mkdir: /builds/slave/test/properties 02:48:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:22 INFO - Contents: 02:48:22 INFO - build_url:https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - Running post-action listener: set_extra_try_arguments 02:48:23 INFO - [mozharness: 2016-10-11 09:48:23.540498Z] Finished download-and-extract step (success) 02:48:23 INFO - [mozharness: 2016-10-11 09:48:23.540617Z] Running populate-webroot step. 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: populate_webroot 02:48:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:23 INFO - '--tppagecycles', 02:48:23 INFO - '7'], 02:48:23 INFO - 'tests': ['tsvgm']}}, 02:48:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['basic_compositor_video']}, 02:48:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:48:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s', 02:48:23 INFO - '--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}, 02:48:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}}, 02:48:23 INFO - 'talos.zip': {'path': '', 02:48:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - [mozharness: 2016-10-11 09:48:23.559023Z] Finished populate-webroot step (success) 02:48:23 INFO - [mozharness: 2016-10-11 09:48:23.559102Z] Running create-virtualenv step. 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: create_virtualenv 02:48:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:23 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 02:48:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:23 INFO - Using real prefix '/tools/python27' 02:48:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:27 INFO - Installing pip.................done. 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:27 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 02:48:27 INFO - Cleaning up... 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:27 INFO - Downloading/unpacking psutil>=3.1.1 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:31 INFO - Installing collected packages: psutil 02:48:31 INFO - Running setup.py install for psutil 02:48:31 INFO - building 'psutil._psutil_osx' extension 02:48:31 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 02:48:32 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 02:48:32 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 02:48:32 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 02:48:32 INFO - building 'psutil._psutil_posix' extension 02:48:32 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 02:48:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:32 INFO - ^ 02:48:32 INFO - 1 warning generated. 02:48:32 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 02:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:32 INFO - Successfully installed psutil 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:32 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 02:48:32 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 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:35 INFO - Installing collected packages: mozsystemmonitor 02:48:35 INFO - Running setup.py install for mozsystemmonitor 02:48:35 INFO - Successfully installed mozsystemmonitor 02:48:35 INFO - Cleaning up... 02:48:35 INFO - Return code: 0 02:48:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48:35 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')]} 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 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')]} 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:35 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 02:48:35 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 02:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:35 INFO - 'HOME': '/Users/cltbld', 02:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:35 INFO - 'LOGNAME': 'cltbld', 02:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:35 INFO - 'MOZ_NO_REMOTE': '1', 02:48:35 INFO - 'NO_EM_RESTART': '1', 02:48:35 INFO - 'PAGER': '/bin/cat', 02:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:35 INFO - 'PWD': '/builds/slave/test', 02:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:35 INFO - 'SHELL': '/bin/bash', 02:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:35 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:35 INFO - 'USER': 'cltbld', 02:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:35 INFO - 'XPC_FLAGS': '0x0', 02:48:35 INFO - 'XPC_SERVICE_NAME': '0', 02:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Installing collected packages: jsonschema, functools32 02:48:39 INFO - Running setup.py install for functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Successfully installed jsonschema functools32 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:39 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')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:39 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 02:48:39 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 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:39 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')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:39 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 02:48:39 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 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:42 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:42 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 02:48:42 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 02:48:42 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 02:48:42 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 02:48:42 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 02:48:42 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 02:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - Downloading docopt-0.6.1.tar.gz 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:43 INFO - Running setup.py install for blobuploader 02:48:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:43 INFO - Running setup.py install for requests 02:48:44 INFO - Running setup.py install for docopt 02:48:44 INFO - Successfully installed blobuploader requests docopt 02:48:44 INFO - Cleaning up... 02:48:44 INFO - Return code: 0 02:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:44 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 02:48:44 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 02:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:44 INFO - 'HOME': '/Users/cltbld', 02:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:44 INFO - 'LOGNAME': 'cltbld', 02:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:44 INFO - 'MOZ_NO_REMOTE': '1', 02:48:44 INFO - 'NO_EM_RESTART': '1', 02:48:44 INFO - 'PAGER': '/bin/cat', 02:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:44 INFO - 'PWD': '/builds/slave/test', 02:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:44 INFO - 'SHELL': '/bin/bash', 02:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:44 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:44 INFO - 'USER': 'cltbld', 02:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:44 INFO - 'XPC_FLAGS': '0x0', 02:48:44 INFO - 'XPC_SERVICE_NAME': '0', 02:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YIlp9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-bhWEfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-AeWLmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vSys3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-sBXgqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dYpW3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-F22eib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ZVR0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nW_VJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-X_6IAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-TQb3x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:45 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IhpBw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-uBJJTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-WtxnaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-32hP9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-LHEwua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-iHlSqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:46 INFO - Running setup.py install for manifestparser 02:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for mozcrash 02:48:46 INFO - Running setup.py install for mozdebug 02:48:46 INFO - Running setup.py install for mozdevice 02:48:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozfile 02:48:47 INFO - Running setup.py install for mozhttpd 02:48:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozinfo 02:48:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozInstall 02:48:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozleak 02:48:47 INFO - Running setup.py install for mozlog 02:48:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for moznetwork 02:48:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozprocess 02:48:48 INFO - Running setup.py install for mozprofile 02:48:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozrunner 02:48:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozscreenshot 02:48:48 INFO - Running setup.py install for moztest 02:48:48 INFO - Running setup.py install for mozversion 02:48:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:49 INFO - Cleaning up... 02:48:49 INFO - Return code: 0 02:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:49 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 02:48:49 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 02:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-diqNk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Ja12dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-d3e_R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-BezalL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-78kFLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:49 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RP3W8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-bICPo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-jwST_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-lb43a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-UcQxyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Bs2VPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-92hM1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oJm6KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rJ0DBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:50 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oolnor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-l_4qnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-UcS8q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - Downloading blessings-1.6.tar.gz 02:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:53 INFO - Installing collected packages: blessings 02:48:53 INFO - Running setup.py install for blessings 02:48:53 INFO - Successfully installed blessings 02:48:53 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:54 INFO - Reading from file tmpfile_stdout 02:48:54 INFO - Current package versions: 02:48:54 INFO - blessings == 1.6 02:48:54 INFO - blobuploader == 1.2.4 02:48:54 INFO - docopt == 0.6.1 02:48:54 INFO - functools32 == 3.2.3-2 02:48:54 INFO - jsonschema == 2.5.1 02:48:54 INFO - manifestparser == 1.1 02:48:54 INFO - mozInstall == 1.12 02:48:54 INFO - mozcrash == 0.17 02:48:54 INFO - mozdebug == 0.1 02:48:54 INFO - mozdevice == 0.48 02:48:54 INFO - mozfile == 1.2 02:48:54 INFO - mozhttpd == 0.7 02:48:54 INFO - mozinfo == 0.9 02:48:54 INFO - mozleak == 0.1 02:48:54 INFO - mozlog == 3.4 02:48:54 INFO - moznetwork == 0.27 02:48:54 INFO - mozprocess == 0.23 02:48:54 INFO - mozprofile == 0.28 02:48:54 INFO - mozrunner == 6.12 02:48:54 INFO - mozscreenshot == 0.1 02:48:54 INFO - mozsystemmonitor == 0.3 02:48:54 INFO - moztest == 0.7 02:48:54 INFO - mozversion == 1.4 02:48:54 INFO - psutil == 3.1.1 02:48:54 INFO - requests == 1.2.3 02:48:54 INFO - wsgiref == 0.1.2 02:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:54 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 02:48:54 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 02:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:54 INFO - 'HOME': '/Users/cltbld', 02:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:54 INFO - 'LOGNAME': 'cltbld', 02:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:54 INFO - 'MOZ_NO_REMOTE': '1', 02:48:54 INFO - 'NO_EM_RESTART': '1', 02:48:54 INFO - 'PAGER': '/bin/cat', 02:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:54 INFO - 'PWD': '/builds/slave/test', 02:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:54 INFO - 'SHELL': '/bin/bash', 02:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:54 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:54 INFO - 'USER': 'cltbld', 02:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:54 INFO - 'XPC_FLAGS': '0x0', 02:48:54 INFO - 'XPC_SERVICE_NAME': '0', 02:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 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)) 02:48:54 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 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 0x103aea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd042daebb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, '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.qqQUQw4b67/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.kKwAuVktZc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:48:54 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 02:48:54 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 02:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:54 INFO - 'HOME': '/Users/cltbld', 02:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:54 INFO - 'LOGNAME': 'cltbld', 02:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:54 INFO - 'MOZ_NO_REMOTE': '1', 02:48:54 INFO - 'NO_EM_RESTART': '1', 02:48:54 INFO - 'PAGER': '/bin/cat', 02:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:54 INFO - 'PWD': '/builds/slave/test', 02:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:54 INFO - 'SHELL': '/bin/bash', 02:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:48:54 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:54 INFO - 'USER': 'cltbld', 02:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:54 INFO - 'XPC_FLAGS': '0x0', 02:48:54 INFO - 'XPC_SERVICE_NAME': '0', 02:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:54 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Running post-action listener: _resource_record_post_action 02:48:54 INFO - Running post-action listener: _start_resource_monitoring 02:48:54 INFO - Starting resource monitoring. 02:48:54 INFO - [mozharness: 2016-10-11 09:48:54.908838Z] Finished create-virtualenv step (success) 02:48:54 INFO - [mozharness: 2016-10-11 09:48:54.909797Z] Running install step. 02:48:54 INFO - Running pre-action listener: _resource_record_pre_action 02:48:54 INFO - Running main action method: install 02:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:55 INFO - Reading from file tmpfile_stdout 02:48:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:55 INFO - Reading from file tmpfile_stdout 02:48:55 INFO - Output received: 02:48:55 INFO - Usage: mozinstall [options] installer 02:48:55 INFO - Options: 02:48:55 INFO - -h, --help show this help message and exit 02:48:55 INFO - -d DEST, --destination=DEST 02:48:55 INFO - Directory to install application into. [default: 02:48:55 INFO - "/builds/slave/test"] 02:48:55 INFO - --app=APP Application being installed. [default: firefox] 02:48:55 INFO - mkdir: /builds/slave/test/build/application 02:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Output received: 02:49:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:27 INFO - Running post-action listener: _resource_record_post_action 02:49:27 INFO - [mozharness: 2016-10-11 09:49:27.309350Z] Finished install step (success) 02:49:27 INFO - [mozharness: 2016-10-11 09:49:27.309532Z] Running run-tests step. 02:49:27 INFO - Running pre-action listener: _resource_record_pre_action 02:49:27 INFO - Running main action method: run_tests 02:49:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:27 INFO - 2016-10-11 02:49:27.324 screenresolution[1643:8293] starting screenresolution argv=screenresolution get 02:49:27 INFO - 2016-10-11 02:49:27.326 screenresolution[1643:8293] Display 0: 1600x1200x32@60 02:49:27 INFO - 2016-10-11 02:49:27.332 screenresolution[1644:8295] starting screenresolution argv=screenresolution list 02:49:27 INFO - Available Modes on Display 0 02:49:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:27 INFO - Intel Iris: 02:49:27 INFO - Chipset Model: Intel Iris 02:49:27 INFO - Type: GPU 02:49:27 INFO - Bus: Built-In 02:49:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:27 INFO - Vendor: Intel (0x8086) 02:49:27 INFO - Device ID: 0x0a2e 02:49:27 INFO - Revision ID: 0x0009 02:49:27 INFO - Displays: 02:49:27 INFO - Display: 02:49:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:27 INFO - Display Serial Number: 1600x1200 60 02:49:27 INFO - Main Display: Yes 02:49:27 INFO - Mirror: Off 02:49:27 INFO - Online: Yes 02:49:27 INFO - Rotation: Supported 02:49:27 INFO - Return code: 0 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:27 INFO - Python 2.7.3 02:49:27 INFO - Return code: 0 02:49:27 INFO - grabbing minidump binary from tooltool 02:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:27 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 0x1038fed30>, '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 0x103764db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:27 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 02:49:27 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 02:49:27 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 02:49:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:27 INFO - Return code: 0 02:49:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 02:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqQUQw4b67/Render', 02:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:27 INFO - 'HOME': '/Users/cltbld', 02:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PAGER': '/bin/cat', 02:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKwAuVktZc/Listeners', 02:49:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - 'XPC_FLAGS': '0x0', 02:49:27 INFO - 'XPC_SERVICE_NAME': '0', 02:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 02:49:27 INFO - mozversion application_buildid: 20161011004015 02:49:27 INFO - mozversion application_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 02:49:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:49:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:27 INFO - mozversion application_name: Firefox 02:49:27 INFO - mozversion application_remotingname: firefox-dev 02:49:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:27 INFO - mozversion application_vendor: Mozilla 02:49:27 INFO - mozversion application_version: 51.0a2 02:49:27 INFO - mozversion platform_buildid: 20161011004015 02:49:27 INFO - mozversion platform_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 02:49:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:27 INFO - mozversion platform_version: 51.0a2 02:49:27 INFO - using testdate: 1476179367 02:49:27 INFO - actual date: 1476179367 02:49:27 INFO - starting webserver on 'localhost:49267' 02:49:27 INFO - SUITE-START | Running 2 tests 02:49:27 INFO - TEST-START | dromaeo_css 02:49:27 INFO - operating with platform_type : mac_ 02:49:27 INFO - Initialising browser for dromaeo_css test... 02:49:27 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpYIwHgw/profile http://localhost:49267/getInfo.html) 02:49:30 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 02:49:30 INFO - PROCESS | 1654 | colorDepth:24 02:49:30 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 02:49:30 INFO - PROCESS | 1654 | __metrics 02:49:30 INFO - PROCESS | 1654 | 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" 02:49:30 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:31 INFO - TEST-INFO | 1654: exit 0 02:49:31 INFO - Browser initialized. 02:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:31 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpYIwHgw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:43 INFO - PROCESS | 1659 | RSS: Main: 232890368 02:49:43 INFO - PROCESS | 1659 | 02:50:34 INFO - PROCESS | 1659 | 1476179434522 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] 02:52:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 02:52:47 INFO - PROCESS | 1659 | RSS: Main: 390107136 02:52:47 INFO - PROCESS | 1659 | 02:55:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 02:55:51 INFO - PROCESS | 1659 | RSS: Main: 361807872 02:55:51 INFO - PROCESS | 1659 | 02:58:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 02:58:54 INFO - PROCESS | 1659 | RSS: Main: 335290368 02:58:54 INFO - PROCESS | 1659 | 03:01:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 03:01:57 INFO - PROCESS | 1659 | RSS: Main: 349171712 03:01:57 INFO - PROCESS | 1659 | 03:05:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 03:05:01 INFO - PROCESS | 1659 | RSS: Main: 321122304 03:05:01 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 03:08:04 INFO - PROCESS | 1659 | RSS: Main: 440659968 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | __start_tp_report 03:08:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 03:08:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 03:08:04 INFO - PROCESS | 1659 | |i|pagename|runs| 03:08:04 INFO - PROCESS | 1659 | |0;dojo.html;3330.167458135466;3336.9332613347733;3337.332533493302;3338.933221335572;3377.1894745261143;5634.154876768482;5653.095504719246;5722.685252311121;5729.226554415158;5740.081586946089;5603.467670571299;5659;5661.2923384576925;5669.979403707331;5681.943180568193;5154.32993710817;5154.381474223099;5178.55982241509;5190.195519694435;5199.766010529535;5191.195364718475;5206.947930520684;5208.0885844977165;5256.894862102756;5303.443138470463;5241.2400201970695;5250.579953603703;5258.13240815265;5285.075111855429;5285.762140703659;5263.184206448007;5296.179092240709;5315.946840531584;5326.067938110815;5338.332708411449;5110.156824124015;5176.327077479904;5259.815906443295;5271.209318602202;5290.761915713763;5620.775168993236;5637.351704553947;5649.180868774005;5683.715814209273;5702.144678298288;6175.845603859894;6202.5658203925295;6230.532710046765;6274.466670333027;6287.654179020152;6224.221972253468;6271.341509141565;6299.779507717254;6316.9368306317265;6333.588316759396;5362.731863406853;5748.02283611787;5748.827535173951;5822.010258256107;5833.649981001068;6235.127082208494;6240.095186198067;6249.406306400884;6269.341719119518;6272.749090036439;6175.59858609189;6186.628802271878;6186.659733714599;6189.81430557084;6210.378962103753;6103.974138059492;6166;6191.349908259658;6268;6276.184096067482;6248;6249.9062514062325;6269.216347956505;6269.310375858652;6278.372162783685;6164.784232551929;6192.225971753531;6241.251049873953;6251.531135164881;6276.6547839869245;4845.224764037737;4898;4903.705777653352;4904.994476132384;4986.750662466862;4463.62059224963;4470.664700147502;4474.993126546501;4518.277075667877;4528.932066019012;5822.7670893163795;5844.503217226584;5852.678102704393;5861.648301101863;5904.350521442638;6106.005662907935;6116.4879456621975;6258.593191442542;6297.874042519124;6298.937010629835;5679.886402271932;5748.9425105748405;5765.942340576625;5816.621919575214;5832.62087964281;5335.813246536352;5386.084365657847;5400.945990540123;5404.405515393303;5405.837824865261;6266.592671476339;6271.122042913996;6272.40412160844;6284.780032698925;6287.056941458818;6132.478739307209;6132.509399248139;6159.4456498915315;6210.472109870531;6222.439980401786;6226.283977342664;6301.117843502005;6304.810855674337;6310.905336420049;6325.557210995186;6185.690715464299;6223;6256.280527739368;6263.498920086473;6265.561410701207;4788.569028787426;6148.9692551536955;6167.444929956326;6205.596636218631;6324.936750632435;6089.878202435838;6106.855059071331;6112.449879510866;6173.753049877954;6199.008158694767;5082.567981721595;6142.815715528542;6145.692715364304;6150.1082343059115;6174.753009879554;5797.8550536236935;5974.551908606785;5978.312494063239;5994.520438364833;6007.068904319837;5991.64050156992;6076.1493390924425;6102.267727872683;6106.399996025681;6187.102870083722;5626.409227031103;5994.28068631767;5996.1005849122985;6009.399060094131;6038.486728628116 03:08:04 INFO - PROCESS | 1659 | |1;ext.html;454.37069658522944;499.71016810250046;508.98965553376564;517.9274901513786;526.3131613244717;29296.41407171858;39128;40024.19951600966;40233.59766402331;42558.36162457558;42075;42400.787996060055;42508.14983700324;42576.14847703044;42620.93447663802;8374.665013399457;9674.419534827897;9851;9852.408855468695;9873.456959867204;8698.56507174642;8932.910670893272;11820.93611574958;12121.818172727417;12125.575604853831;12086.879131208707;12207.755844883097;12213.694657633585;12230.571929982452;12256;8749.737507874774;12103.27380357177;12200.023998080176;12212.877871221262;12213.816792748115;8647.740567782977;11613.245139065933;11959.103067269989;11964.102692298113;12232.204906681038;39900.80297591077;40025.59974400248;40109.398359024635;40201.99495012619;40221.59778402208;3409.7613167078066;3557.3774589446743;3655.6161603031833;3942.4086387041884;3953.4267531207815;30065.098047058622;30297.545536816964;31276.53085203724;31976;32103.612625552272;3074.308280636861;3085.7222849943614;3161.1306890605038;3194.834390520458;3307.570015897942;531759;531804.7278108872;532199;532276;535708;60169.398306017254;60532.48668783228;60557.39442605606;60563.39436605666;60592.36445813265;33708.66291337055;34330.656693433244;63583.364166357744;63670.0449493258;63952.040719389246;16444;16887.577810554587;16890.915545422195;16891.915540422466;16956.23696933641;11624.88375116255;11889.940550297366;12611;12720.618381448572;12743.745125097446;16406.09766462832;18448.723269150974;18940.337088201846;18971.24115035383;19095.04524773756;7060.752873649398;7280;7848.725294614661;7980.840383192303;8002.439829212016;832.675256649907;955.4553904274636;1001.9048190421898;1014.7209517382631;1015.0509273828993;28483.572746408405;29522.852385737933;29608.55587166194;30047.948321809068;30483.69516304853;906.909309069101;956.5934477846887;989.2975987049132;1001.1090129784498;1014.9188064954934;14543.490977815725;14972.326245318987;14998.775018374734;15282.235888205545;15323;695917;698227.5088624525;700000.0000000036;701548;701610;55657;55987.720061399436;56057.878842423735;56060;56116.71941640347;1247.2329517346766;1259.8362212912264;1383.4189640350876;1389.6178550898583;1412.11037046662;29224.707752922197;29875.55186672245;31174.532382013833;31178.532322015642;31906.840465797522;47566.76216618895;48272;48304;48418.5158148414;48462.75768621134;643179;659187;659678;659755;660166;39814.21300508937;42918.78540607277;43434;43443.131137377706;43579.782101089295;44943.77528112339;46048.76975615101;46114.538854612365;46946.295805563626;47072.529274706816;31284.99977560258;38013.80993095017;38861;39992.60081391103;40148.598514014484;32793.67206327906;37032.62967370292;37331.813340934204;37901.43147852839;40378.79810600928;36815.63184368229;37054.44418333673;37891;37909.241815164096;38358.424623631225;25781.222895716553;33795.66204337925;34217.65782342145;34415;34617.480737789454;23413.882930585238;23969.76030239745;25214.873925630254;25505;25874.48251034931 03:08:04 INFO - PROCESS | 1659 | |2;jquery.html;349.8932825488225;372.3428149316456;374.04991322042014;386.8645973909131;402.84490471168607;15189.620259493518;15528.767068493968;17024;20575.38273851783;20879.74680409514;20293.594128117427;20783;21183.682244766303;21430.14279428821;21454.927253637296;5652.858678533049;5820.679862607555;5984.670843103628;6085.574009819315;6087.995480745672;5775.942240577582;5954.910676339859;5957.2851257849115;5963;5969.4925931295675;4138.420621113031;4413.58070983256;6334.714937827809;6562.80311590653;6640.369164929324;6484.319146489598;6622.444054082302;6625.271220165778;6688.966555167217;6714.731410743589;5703.62926409782;5811.941880581182;5832.970835145839;5837.066069428871;5841.415858414167;19379.515512112168;26028;26490.470190596272;26519.867400663064;26841.73158268412;2061.9278325258542;2246.382244882654;2297.885105744706;2475.789557887582;2778.3470884342164;15310.540683779505;15896.364145434169;15932.442364517303;16465.91767041157;16585.751213731804;1876.277633111262;1900.4108726294892;1921.8174273444001;1938.903054847266;1981.6433042052424;100584;103788;122820.77179228271;127812;129172;10807.297525660806;11097.33415995043;11284.830727539094;11502.769944601061;11648.94175529117;14403.711925761427;14408.42366305336;14425.639359016108;14427.206503642401;14455;7527.661255243527;8635.525046122399;8764.123587641185;8821.2060914518;8901.599428025755;7675.884861727079;8816.426932249384;8950.86573701395;8976.685815996409;9136.908630913606;5814.680192589363;6830.487713421513;6858.794236172923;6951.096357473597;6988.93011069893;1531.931063102163;1832.496063582499;1834.2479583370755;1834.3304693786672;1838;681.7511608262948;931.3247895276006;952.2762700347647;954.9045095490395;1007.6120693532896;21880.562388752136;22468.775312246995;22943.655845162335;22987.195448159568;23040.847957602055;932.883389576303;933.3054734684548;933.607884688419;949.0319873728758;1077.7305673581604;11476.598319058792;12094.516219351128;12138.028957683364;12177.452014659184;12235.632931012084;527901;530081;530616;632615;645894;143053.8541921872;144178.27910860378;144878;146982;153100.2344988268;957.2437774158337;983.179045497018;1002.5839276700087;1005.7988402319419;1009.3943633819649;18767.71848422302;19779.307724229584;20111.296104636855;20266.493337666678;20324;53685.926281473374;53904;54891.45108548863;55842.441575583725;56810.14784778314;78725.60637196778;84409.15590844012;87298;89158;89167;6481;7860.5676687782725;8067.3142782864115;8325.25072743456;8346.499210047417;9205.447673139633;12692.17500862441;12754.48982040708;12831.935840320739;13153.802692959805;11166.879540193144;11277.943610281896;11377.943110284396;11516.94241528787;11641.41792910368;9519.476428796483;10853.240273180802;11047.613333533287;11053.944730276296;11211.88788112141;9344.532773361168;11152.832707509557;11437.02785263262;11508.827367589325;11739.11956603241;7979.5611241382285;7991.520508769492;8224.013118425828;8362.163783621589;8445.788855278668;8633.30933525304;10880.238383313092;11154.944225278821;11163.553457861595;11568.190226684052 03:08:04 INFO - PROCESS | 1659 | |3;mootools.html;1524.268351191428;1547.7523596224603;1699.3032856528819;1820.1900154431266;1851.7314989326555;8527.275181609562;9134.725958221255;9137.086291370859;9138.725838224847;9147.679831205909;7886.250806173404;8090.150534193898;8101.392395570327;8634.136586341363;8866.246369058637;2367.7040369953756;2430.1980346485707;2433;2438.9146379876706;2439.4145405102736;2400.23192578375;2417.129833260025;2437.7684120008657;2439.1950656283384;2445.339758265276;2404.278716385086;2422.600270955299;2425.5027719317586;2426.1872272788637;2437.463757973243;2385.403649087728;2390.5935990881503;2398.5083057973075;2404.89177986991;2421.2615152378517;2305.8155347572156;2338.625819868813;2345.57779599672;2349.295211436562;2355.5759963206615;7606.657700403495;9035.232005279559;9039.502827344493;9060.139286767746;9236.953815230949;5270.077736396115;5427.185922111676;5427.945720542783;5429.56563474921;5433.347998240197;3479.9826000869834;3602.3875941089814;3671.2657468506404;3678.301122786662;3680.834362453696;1042.1818872185374;1071.3786004117594;1081.1891081688734;1088.1186239146239;1096.4243772019674;11844.46699898498;11895.226810257305;11931.403429828473;11951.342676152808;11953.40232988347;4563.612092972135;4692.507286734844;4864.124457597595;4870.488598697157;4879.853604391803;10070.899291006996;10073;10080.596776128872;10086.49567521621;10090.49547522621;5373.140297552372;5384.3000409947235;5389.865253368697;5395.811146609928;5401.783928642811;4407.537208593116;4523.5250298718165;4543.909121817545;4893.853184404474;4900.191468407673;3276.6231883333244;3866.2654095721723;3978.602139785998;4011.398290256485;4014.5985401460202;1104.7238190452388;1271.8918891894293;1273.3696820074122;1289.9161554498928;1307.1176955554963;740.2560426771169;850.9276711479594;907.668700924158;909.663424532927;923.8521836506127;5651.46311100453;5672.4894759471845;5736.942630573724;5745.4694195170605;5975.910361344583;866.8786369908091;918.1507105927125;921.709661456639;927.3879239701764;948.1087777489138;3933.272344616255;3936.075022369741;3942.2903877301787;3950.170464202492;4016.59834016596;10771;11181.496832642551;11182.32906025641;11193.552257909756;11232.606858759904;11071.391073491035;11078.944605276922;11124.888751112385;11140.610078647209;11149.777004459866;7901.802454938557;8301.46040507365;8460.280876125475;8461.111583283666;8473.110323415953;5459.808906688247;5551.9722401387735;5835.766569337179;5995.670238136944;6083.756649733961;8695.173958473935;9993.050660187271;10147.746306342106;10284;10301.690949271533;9933.403995760278;10173.643922462677;10279.229057820543;10535.209859260432;10548.208884333859;6521.6087034776165;7038.225795162631;7238.022866912899;7250.383717384081;7779.105402878741;8162.591870406574;8401.789955251168;8412.116727743498;8545.658173673231;8545.700900468453;7351.3751331137455;7370.815729606803;7486.4759466836795;7609.429292802951;7691.115521714851;7256.383207427428;7392.889106663297;7410.333070023724;7486.326230639269;7553.848923021619;6984.4063254623925;7052.400545953446;7116.323949224816;7137.10786151731;7162.498625096193;4917.616984876185;4951.529604687549;4953.23224900141;5015.673981191211;5056.595472362129;4877.707337559757;4954.405471343462;4967.577755890789;5026.195808670595;5039.496050394931 03:08:04 INFO - PROCESS | 1659 | |4;prototype.html;294.9572312014757;300.5221697500973;310.1981378137514;313.91053549738314;315.6795852210006;4854.538818812216;5303.602229832759;5369.5704343652515;5430.131179011359;5510.338759348879;5318.9202161967605;5327.362955337114;5360.91958620621;5375.381831089426;5386.353637563498;3578;4119.938200926996;4129.6283334499885;4144.336906095025;4163.376283249535;3264.608247010362;3502.807345595991;4087.7736678996184;4142.627163555279;4168.24971505129;3841.9615803842025;3901.4784234148565;3946.703997200207;4068.776217308047;4101.364288535282;3406.3698215829904;3978.940315895235;4011.63895249426;4043.6158564936286;4084.6732261419015;3331.650681474007;3490.2495963367996;3510.2970712551446;3512.701420379271;3523.5067090607336;5072.474511606297;5262.500062494057;5299.682019078868;5329.561018524976;5344.225087362311;3823.47061175532;4621.052684199731;4628.629709623222;4653.581177694024;4665.6967297125575;4442.62237709795;5672.829815105553;5688.402717714622;5690.800821971253;5708.689939095997;3387.254803943153;3718.9442158367647;3859.0931131184147;3892.708046896494;3895.4935858338235;5155.871103222412;5563.471470210324;5665.790341766714;5774.855628609318;5933.61431506955;3771.41543060826;3778.848846046127;3900.2199560088097;3913.964738336106;3937.5078115235597;3958.762474251554;3965.6827453803626;3972.880813575597;3975.1652153048185;4003.619656132663;3598.514200582888;4485.708428952173;4652.952700811632;4665.883352916204;4682.484926658065;5226.085435048927;5653.9151912721345;5689.886202276014;5709.8287051388525;5716.542676585863;1153.948072336747;1289.7291568770477;1327.5220920468817;1342.5032737887045;1358.4905660377358;768.4937522455937;807.9717209897743;812.3014207781304;825.8224481736455;838.1827717975048;3748.756330838487;3813.523309586302;4415.757133357696;4443.067265739413;4525.275955847049;4683.454460028182;4842.249451335048;4866.2967961214;4883.829065982744;4897.4857639948;3862.633049860259;3966.8859944943083;4035.5964403559997;4268.466441694788;4361.168309310097;2349.76637265437;2669.6529451171223;3076.5541394591355;3085.5217441296636;3101.8914337998513;6057.42454466825;6061.090836374491;6080.2399700037495;6084;6122.693865306717;4819.2530157825595;5149.665271757323;5628.549716022791;5825.79609713658;6019.367966363557;5005.746264927826;5317.946820531823;6046.395360464006;6048.576599637983;6057.030875059969;5094.617903657315;5819.388964158872;5830.6298019966125;5846.216903844368;5889.94110058894;5384.326959130109;5696.006397760916;5716.256541754805;5769.1634712967225;5771.701367192348;5043.839916819079;5500.669959802264;5792.4497172768515;5995.1906492624685;6049.576529642883;3145.7797954143907;3918.2555314490155;3927.312720273998;3928.64642182205;3928.6660633846445;5898.941010590011;5908;5909.261342332208;5915.674637894957;5919;5308.654937429054;5481.3422389311945;5749.8275051748515;5759.782483743705;5834.38738932406;5740.101248869294;5757.251557297692;5757.568182386254;5781.82654520365;5790.10253410722;5470.72646367688;5658.292713410824;5677.410325108976;5730.885382292247;5731.942680573141;5369.999350483915;5641.858953526031;5670.603057785916;5674.347450043298;5685.545156387562;4877.609791216765;4944.604431645388;5397.163439666858;5515.393306736176;5552.250446189712 03:08:04 INFO - PROCESS | 1659 | |5;yui.html;688.4733179117976;771.3096778383347;788.3811208201562;801.6312496251724;818.4230117766975;14821.925890370547;15724.528264152064;15806.209689515536;15843.207839608016;15875.52373428796;14542.418303267883;14621.92689036556;14622.780658290134;14646.487372941949;14658.900582456305;663.8307231655921;681.9215790184143;685.1880521581917;809.295912556077;824.1675907333577;831.7546323834483;839.8320335932807;843.2158092973532;848.0035957749619;850.1668365002301;896.0725648953335;900.0324651000168;901.134910485931;902.4134312696734;902.463034494478;691.2154704410531;714.9954314188574;888.7156110044788;895.9820803583924;897.2776914583758;638.3361304243581;656.7734131724548;657.3656421553225;658.4896705053574;659.8185498987768;14945.17801520916;14972.550823475312;15005.24973751308;15014.624634384229;15023.849761502355;13538.932305338509;13743;13763.38064787077;13841.653958651013;14116.15303081808;11962.58130965412;12446.3154526501;12514.499420023189;12764.6624493624;12853.293068881208;4531.841385551523;4574.121491695632;4590.288505281686;4632.907341853178;4768.642351823627;117953;118675.81324186733;118776;121191;123795;10666.36001839892;10680.412577308323;10855.728606784893;10924.781504369868;11000.889991099986;21283.46791330229;21323.36029919105;21324.89337553302;21353.14587416486;21369;7866.174051724486;7918.762437126896;7952.085510166289;7965.084015338194;8011.399145064143;4372.868813935587;4442.4669039715445;4459.3979812724865;4477.619402350771;4598.609118224921;3135.6550779414247;3223.16197788572;3224.5485632011537;3228.338190670907;3233.401820663185;649.8700259947934;668.535906365059;677.0656494038195;685.7976896815352;690.7616872179091;572.3046498504337;602.9216201893813;627.7018416252243;631.66837410359;640.8558074433215;8450.648214427649;9137.77155571116;9220.308476864262;9274;9392.483413412328;537.9300690910235;607.9755611794053;623.6258245053023;640.826976716284;653.0889409274037;4305.5048669402795;4545.9537716539235;4551.749653769009;4582.2668373060815;4646.3495110684535;141817.58182418044;163543;170328;170559;171171;103828.44257336146;119025;134991;143377;150395;108069;110527;111190;111609.88390115995;112080;8377.413581049268;8565.61454734526;8573.142685731376;8641;8843.07147749477;62674.05988910079;64344.67827660832;66055;66462.66768666125;66493.67012659623;102193.97806021845;103223;104016.47991759992;106108;106455;10542.789144216918;10855.620053298097;10929.234953553176;11174.66476005721;11228.382438965935;11963.64109076729;12001.459934302802;12307.569235077088;12646.620601381605;12770.106092573431;11405.714857128638;11514.30914145154;11869.050475961729;11921;12036.338001410006;11478.426078696199;11539.480723367637;11543.88456115428;11546.826797597874;11612.361320127475;11158.49786759614;11208.439578021229;11469.31184128955;11472.369019703663;11702.127659574238;9356.532173391439;9813.705588832347;10128.502543946503;10271.537780799732;10628.309159904582;8436;10097.376480757275;10132.527597451186;10145.391276523433;10149.492525373555 03:08:04 INFO - PROCESS | 1659 | __end_tp_report 03:08:04 INFO - PROCESS | 1659 | __start_cc_report 03:08:04 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1551 03:08:04 INFO - PROCESS | 1659 | __end_cc_report 03:08:04 INFO - PROCESS | 1659 | __startTimestamp1476180484527__endTimestamp 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | ------- Summary: start ------- 03:08:04 INFO - PROCESS | 1659 | Number of tests: 6 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5742.47 Median:5994.28 stddev:640.33 (10.7%) stddev-sans-first:613.69 03:08:04 INFO - PROCESS | 1659 | Values: 3330.2 3336.9 3337.3 3338.9 3377.2 5634.2 5653.1 5722.7 5729.2 5740.1 5603.5 5659.0 5661.3 5670.0 5681.9 5154.3 5154.4 5178.6 5190.2 5199.8 5191.2 5206.9 5208.1 5256.9 5303.4 5241.2 5250.6 5258.1 5285.1 5285.8 5263.2 5296.2 5315.9 5326.1 5338.3 5110.2 5176.3 5259.8 5271.2 5290.8 5620.8 5637.4 5649.2 5683.7 5702.1 6175.8 6202.6 6230.5 6274.5 6287.7 6224.2 6271.3 6299.8 6316.9 6333.6 5362.7 5748.0 5748.8 5822.0 5833.6 6235.1 6240.1 6249.4 6269.3 6272.7 6175.6 6186.6 6186.7 6189.8 6210.4 6104.0 6166.0 6191.3 6268.0 6276.2 6248.0 6249.9 6269.2 6269.3 6278.4 6164.8 6192.2 6241.3 6251.5 6276.7 4845.2 4898.0 4903.7 4905.0 4986.8 4463.6 4470.7 4475.0 4518.3 4528.9 5822.8 5844.5 5852.7 5861.6 5904.4 6106.0 6116.5 6258.6 6297.9 6298.9 5679.9 5748.9 5765.9 5816.6 5832.6 5335.8 5386.1 5400.9 5404.4 5405.8 6266.6 6271.1 6272.4 6284.8 6287.1 6132.5 6132.5 6159.4 6210.5 6222.4 6226.3 6301.1 6304.8 6310.9 6325.6 6185.7 6223.0 6256.3 6263.5 6265.6 4788.6 6149.0 6167.4 6205.6 6324.9 6089.9 6106.9 6112.4 6173.8 6199.0 5082.6 6142.8 6145.7 6150.1 6174.8 5797.9 5974.6 5978.3 5994.5 6007.1 5991.6 6076.1 6102.3 6106.4 6187.1 5626.4 5994.3 5996.1 6009.4 6038.5 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:75332.42 Median:37961.53 stddev:169697.84 (447.0%) stddev-sans-first:170080.76 03:08:04 INFO - PROCESS | 1659 | Values: 454.4 499.7 509.0 517.9 526.3 29296.4 39128.0 40024.2 40233.6 42558.4 42075.0 42400.8 42508.1 42576.1 42620.9 8374.7 9674.4 9851.0 9852.4 9873.5 8698.6 8932.9 11820.9 12121.8 12125.6 12086.9 12207.8 12213.7 12230.6 12256.0 8749.7 12103.3 12200.0 12212.9 12213.8 8647.7 11613.2 11959.1 11964.1 12232.2 39900.8 40025.6 40109.4 40202.0 40221.6 3409.8 3557.4 3655.6 3942.4 3953.4 30065.1 30297.5 31276.5 31976.0 32103.6 3074.3 3085.7 3161.1 3194.8 3307.6 531759.0 531804.7 532199.0 532276.0 535708.0 60169.4 60532.5 60557.4 60563.4 60592.4 33708.7 34330.7 63583.4 63670.0 63952.0 16444.0 16887.6 16890.9 16891.9 16956.2 11624.9 11889.9 12611.0 12720.6 12743.7 16406.1 18448.7 18940.3 18971.2 19095.0 7060.8 7280.0 7848.7 7980.8 8002.4 832.7 955.5 1001.9 1014.7 1015.1 28483.6 29522.9 29608.6 30047.9 30483.7 906.9 956.6 989.3 1001.1 1014.9 14543.5 14972.3 14998.8 15282.2 15323.0 695917.0 698227.5 700000.0 701548.0 701610.0 55657.0 55987.7 56057.9 56060.0 56116.7 1247.2 1259.8 1383.4 1389.6 1412.1 29224.7 29875.6 31174.5 31178.5 31906.8 47566.8 48272.0 48304.0 48418.5 48462.8 643179.0 659187.0 659678.0 659755.0 660166.0 39814.2 42918.8 43434.0 43443.1 43579.8 44943.8 46048.8 46114.5 46946.3 47072.5 31285.0 38013.8 38861.0 39992.6 40148.6 32793.7 37032.6 37331.8 37901.4 40378.8 36815.6 37054.4 37891.0 37909.2 38358.4 25781.2 33795.7 34217.7 34415.0 34617.5 23413.9 23969.8 25214.9 25505.0 25874.5 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35355.51 Median:14251.89 stddev:96961.21 (680.3%) stddev-sans-first:97197.59 03:08:04 INFO - PROCESS | 1659 | Values: 349.9 372.3 374.0 386.9 402.8 15189.6 15528.8 17024.0 20575.4 20879.7 20293.6 20783.0 21183.7 21430.1 21454.9 5652.9 5820.7 5984.7 6085.6 6088.0 5775.9 5954.9 5957.3 5963.0 5969.5 4138.4 4413.6 6334.7 6562.8 6640.4 6484.3 6622.4 6625.3 6689.0 6714.7 5703.6 5811.9 5833.0 5837.1 5841.4 19379.5 26028.0 26490.5 26519.9 26841.7 2061.9 2246.4 2297.9 2475.8 2778.3 15310.5 15896.4 15932.4 16465.9 16585.8 1876.3 1900.4 1921.8 1938.9 1981.6 100584.0 103788.0 122820.8 127812.0 129172.0 10807.3 11097.3 11284.8 11502.8 11648.9 14403.7 14408.4 14425.6 14427.2 14455.0 7527.7 8635.5 8764.1 8821.2 8901.6 7675.9 8816.4 8950.9 8976.7 9136.9 5814.7 6830.5 6858.8 6951.1 6988.9 1531.9 1832.5 1834.2 1834.3 1838.0 681.8 931.3 952.3 954.9 1007.6 21880.6 22468.8 22943.7 22987.2 23040.8 932.9 933.3 933.6 949.0 1077.7 11476.6 12094.5 12138.0 12177.5 12235.6 527901.0 530081.0 530616.0 632615.0 645894.0 143053.9 144178.3 144878.0 146982.0 153100.2 957.2 983.2 1002.6 1005.8 1009.4 18767.7 19779.3 20111.3 20266.5 20324.0 53685.9 53904.0 54891.5 55842.4 56810.1 78725.6 84409.2 87298.0 89158.0 89167.0 6481.0 7860.6 8067.3 8325.3 8346.5 9205.4 12692.2 12754.5 12831.9 13153.8 11166.9 11277.9 11377.9 11516.9 11641.4 9519.5 10853.2 11047.6 11053.9 11211.9 9344.5 11152.8 11437.0 11508.8 11739.1 7979.6 7991.5 8224.0 8362.2 8445.8 8633.3 10880.2 11154.9 11163.6 11568.2 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5760.10 Median:4886.85 stddev:3259.36 (66.7%) stddev-sans-first:3252.96 03:08:04 INFO - PROCESS | 1659 | Values: 1524.3 1547.8 1699.3 1820.2 1851.7 8527.3 9134.7 9137.1 9138.7 9147.7 7886.3 8090.2 8101.4 8634.1 8866.2 2367.7 2430.2 2433.0 2438.9 2439.4 2400.2 2417.1 2437.8 2439.2 2445.3 2404.3 2422.6 2425.5 2426.2 2437.5 2385.4 2390.6 2398.5 2404.9 2421.3 2305.8 2338.6 2345.6 2349.3 2355.6 7606.7 9035.2 9039.5 9060.1 9237.0 5270.1 5427.2 5427.9 5429.6 5433.3 3480.0 3602.4 3671.3 3678.3 3680.8 1042.2 1071.4 1081.2 1088.1 1096.4 11844.5 11895.2 11931.4 11951.3 11953.4 4563.6 4692.5 4864.1 4870.5 4879.9 10070.9 10073.0 10080.6 10086.5 10090.5 5373.1 5384.3 5389.9 5395.8 5401.8 4407.5 4523.5 4543.9 4893.9 4900.2 3276.6 3866.3 3978.6 4011.4 4014.6 1104.7 1271.9 1273.4 1289.9 1307.1 740.3 850.9 907.7 909.7 923.9 5651.5 5672.5 5736.9 5745.5 5975.9 866.9 918.2 921.7 927.4 948.1 3933.3 3936.1 3942.3 3950.2 4016.6 10771.0 11181.5 11182.3 11193.6 11232.6 11071.4 11078.9 11124.9 11140.6 11149.8 7901.8 8301.5 8460.3 8461.1 8473.1 5459.8 5552.0 5835.8 5995.7 6083.8 8695.2 9993.1 10147.7 10284.0 10301.7 9933.4 10173.6 10279.2 10535.2 10548.2 6521.6 7038.2 7238.0 7250.4 7779.1 8162.6 8401.8 8412.1 8545.7 8545.7 7351.4 7370.8 7486.5 7609.4 7691.1 7256.4 7392.9 7410.3 7486.3 7553.8 6984.4 7052.4 7116.3 7137.1 7162.5 4917.6 4951.5 4953.2 5015.7 5056.6 4877.7 4954.4 4967.6 5026.2 5039.5 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4515.25 Median:5024.79 stddev:1429.72 (28.5%) stddev-sans-first:1398.20 03:08:04 INFO - PROCESS | 1659 | Values: 295.0 300.5 310.2 313.9 315.7 4854.5 5303.6 5369.6 5430.1 5510.3 5318.9 5327.4 5360.9 5375.4 5386.4 3578.0 4119.9 4129.6 4144.3 4163.4 3264.6 3502.8 4087.8 4142.6 4168.2 3842.0 3901.5 3946.7 4068.8 4101.4 3406.4 3978.9 4011.6 4043.6 4084.7 3331.7 3490.2 3510.3 3512.7 3523.5 5072.5 5262.5 5299.7 5329.6 5344.2 3823.5 4621.1 4628.6 4653.6 4665.7 4442.6 5672.8 5688.4 5690.8 5708.7 3387.3 3718.9 3859.1 3892.7 3895.5 5155.9 5563.5 5665.8 5774.9 5933.6 3771.4 3778.8 3900.2 3914.0 3937.5 3958.8 3965.7 3972.9 3975.2 4003.6 3598.5 4485.7 4653.0 4665.9 4682.5 5226.1 5653.9 5689.9 5709.8 5716.5 1153.9 1289.7 1327.5 1342.5 1358.5 768.5 808.0 812.3 825.8 838.2 3748.8 3813.5 4415.8 4443.1 4525.3 4683.5 4842.2 4866.3 4883.8 4897.5 3862.6 3966.9 4035.6 4268.5 4361.2 2349.8 2669.7 3076.6 3085.5 3101.9 6057.4 6061.1 6080.2 6084.0 6122.7 4819.3 5149.7 5628.5 5825.8 6019.4 5005.7 5317.9 6046.4 6048.6 6057.0 5094.6 5819.4 5830.6 5846.2 5889.9 5384.3 5696.0 5716.3 5769.2 5771.7 5043.8 5500.7 5792.4 5995.2 6049.6 3145.8 3918.3 3927.3 3928.6 3928.7 5898.9 5908.0 5909.3 5915.7 5919.0 5308.7 5481.3 5749.8 5759.8 5834.4 5740.1 5757.3 5757.6 5781.8 5790.1 5470.7 5658.3 5677.4 5730.9 5731.9 5370.0 5641.9 5670.6 5674.3 5685.5 4877.6 4944.6 5397.2 5515.4 5552.3 03:08:04 INFO - PROCESS | 1659 | 03:08:04 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25688.17 Median:21361.07 stddev:42600.46 (199.4%) stddev-sans-first:42678.62 03:08:04 INFO - PROCESS | 1659 | Values: 688.5 771.3 788.4 801.6 818.4 14821.9 15724.5 15806.2 15843.2 15875.5 14542.4 14621.9 14622.8 14646.5 14658.9 663.8 681.9 685.2 809.3 824.2 831.8 839.8 843.2 848.0 850.2 896.1 900.0 901.1 902.4 902.5 691.2 715.0 888.7 896.0 897.3 638.3 656.8 657.4 658.5 659.8 14945.2 14972.6 15005.2 15014.6 15023.8 13538.9 13743.0 13763.4 13841.7 14116.2 11962.6 12446.3 12514.5 12764.7 12853.3 4531.8 4574.1 4590.3 4632.9 4768.6 117953.0 118675.8 118776.0 121191.0 123795.0 10666.4 10680.4 10855.7 10924.8 11000.9 21283.5 21323.4 21324.9 21353.1 21369.0 7866.2 7918.8 7952.1 7965.1 8011.4 4372.9 4442.5 4459.4 4477.6 4598.6 3135.7 3223.2 3224.5 3228.3 3233.4 649.9 668.5 677.1 685.8 690.8 572.3 602.9 627.7 631.7 640.9 8450.6 9137.8 9220.3 9274.0 9392.5 537.9 608.0 623.6 640.8 653.1 4305.5 4546.0 4551.7 4582.3 4646.3 141817.6 163543.0 170328.0 170559.0 171171.0 103828.4 119025.0 134991.0 143377.0 150395.0 108069.0 110527.0 111190.0 111609.9 112080.0 8377.4 8565.6 8573.1 8641.0 8843.1 62674.1 64344.7 66055.0 66462.7 66493.7 102194.0 103223.0 104016.5 106108.0 106455.0 10542.8 10855.6 10929.2 11174.7 11228.4 11963.6 12001.5 12307.6 12646.6 12770.1 11405.7 11514.3 11869.1 11921.0 12036.3 11478.4 11539.5 11543.9 11546.8 11612.4 11158.5 11208.4 11469.3 11472.4 11702.1 9356.5 9813.7 10128.5 10271.5 10628.3 8436.0 10097.4 10132.5 10145.4 10149.5 03:08:04 INFO - PROCESS | 1659 | -------- Summary: end -------- 03:08:04 INFO - PROCESS | 1659 | 03:08:05 INFO - TEST-INFO | 1659: exit 0 03:08:05 INFO - TEST-OK | dromaeo_css | took 1117242ms 03:08:05 INFO - TEST-START | kraken 03:08:05 INFO - operating with platform_type : mac_ 03:08:05 INFO - Initialising browser for kraken test... 03:08:05 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp7rw1aO/profile http://localhost:49267/getInfo.html) 03:08:07 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 03:08:07 INFO - PROCESS | 1664 | colorDepth:24 03:08:07 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 03:08:07 INFO - PROCESS | 1664 | __metrics 03:08:07 INFO - PROCESS | 1664 | 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" 03:08:07 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:08 INFO - TEST-INFO | 1664: exit 0 03:08:08 INFO - Browser initialized. 03:08:08 INFO - Running cycle 1/1 for kraken test... 03:08:08 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp7rw1aO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:20 INFO - PROCESS | 1667 | RSS: Main: 239370240 03:08:20 INFO - PROCESS | 1667 | 03:08:22 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:23 INFO - PROCESS | 1667 | RSS: Main: 286855168 03:08:23 INFO - PROCESS | 1667 | 03:08:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 03:08:26 INFO - PROCESS | 1667 | RSS: Main: 298471424 03:08:26 INFO - PROCESS | 1667 | 03:08:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 03:08:30 INFO - PROCESS | 1667 | RSS: Main: 392654848 03:08:30 INFO - PROCESS | 1667 | 03:08:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 03:08:33 INFO - PROCESS | 1667 | RSS: Main: 294531072 03:08:33 INFO - PROCESS | 1667 | 03:08:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:35 INFO - PROCESS | 1667 | RSS: Main: 295096320 03:08:35 INFO - PROCESS | 1667 | 03:08:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:39 INFO - PROCESS | 1667 | RSS: Main: 333217792 03:08:39 INFO - PROCESS | 1667 | 03:08:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:42 INFO - PROCESS | 1667 | RSS: Main: 332746752 03:08:42 INFO - PROCESS | 1667 | 03:08:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 03:08:46 INFO - PROCESS | 1667 | RSS: Main: 332808192 03:08:46 INFO - PROCESS | 1667 | 03:08:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:48 INFO - PROCESS | 1667 | RSS: Main: 308224000 03:08:48 INFO - PROCESS | 1667 | 03:08:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:50 INFO - PROCESS | 1667 | RSS: Main: 309874688 03:08:50 INFO - PROCESS | 1667 | 03:08:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:53 INFO - PROCESS | 1667 | RSS: Main: 317460480 03:08:53 INFO - PROCESS | 1667 | 03:08:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:57 INFO - PROCESS | 1667 | RSS: Main: 322850816 03:08:57 INFO - PROCESS | 1667 | 03:09:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:00 INFO - PROCESS | 1667 | RSS: Main: 322543616 03:09:00 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 03:09:02 INFO - PROCESS | 1667 | RSS: Main: 366612480 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | __start_tp_report 03:09:02 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 03:09:02 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 03:09:02 INFO - PROCESS | 1667 | |i|pagename|runs| 03:09:02 INFO - PROCESS | 1667 | |0;ai-astar;116;113;115;114;114;113;113;114;114;113 03:09:02 INFO - PROCESS | 1667 | |1;audio-beat-detection;142;110;112;142;108;107;108;107;141;106 03:09:02 INFO - PROCESS | 1667 | |2;audio-dft;182;184;183;183;185;184;182;186;185;183 03:09:02 INFO - PROCESS | 1667 | |3;audio-fft;79;59;59;88;63;59;66;63;111;78 03:09:02 INFO - PROCESS | 1667 | |4;audio-oscillator;92;70;94;70;67;70;92;69;69;91 03:09:02 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;86;83;86;83;86;82;87;83;89;83 03:09:02 INFO - PROCESS | 1667 | |6;imaging-darkroom;102;97;98;137;94;114;135;96;95;102 03:09:02 INFO - PROCESS | 1667 | |7;imaging-desaturate;84;86;86;83;87;83;83;85;86;84 03:09:02 INFO - PROCESS | 1667 | |8;json-parse-financial;57;56;54;55;57;58;56;56;57;58 03:09:02 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;64;67;78;75;71;68;68;70;70;71 03:09:02 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;85;82;85;100;78;84;82;83;87;89 03:09:02 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;142;147;153;138;135;133;130;177;191;138 03:09:02 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;164;167;163;165;215;163;163;169;161;165 03:09:02 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;62;84;84;86;66;66;67;66;66;67 03:09:02 INFO - PROCESS | 1667 | __end_tp_report 03:09:02 INFO - PROCESS | 1667 | __start_cc_report 03:09:02 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1957 03:09:02 INFO - PROCESS | 1667 | __end_cc_report 03:09:02 INFO - PROCESS | 1667 | __startTimestamp1476180542804__endTimestamp 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | ------- Summary: start ------- 03:09:02 INFO - PROCESS | 1667 | Number of tests: 14 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.71 03:09:02 INFO - PROCESS | 1667 | Values: 116.0 113.0 115.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:111.00 stddev:16.21 (14.6%) stddev-sans-first:14.76 03:09:02 INFO - PROCESS | 1667 | Values: 142.0 110.0 112.0 142.0 108.0 107.0 108.0 107.0 141.0 106.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.34 (0.7%) stddev-sans-first:1.27 03:09:02 INFO - PROCESS | 1667 | Values: 182.0 184.0 183.0 183.0 185.0 184.0 182.0 186.0 185.0 183.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:72.50 Median:64.50 stddev:16.88 (26.2%) stddev-sans-first:17.74 03:09:02 INFO - PROCESS | 1667 | Values: 79.0 59.0 59.0 88.0 63.0 59.0 66.0 63.0 111.0 78.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:80.50 stddev:11.97 (14.9%) stddev-sans-first:11.65 03:09:02 INFO - PROCESS | 1667 | Values: 92.0 70.0 94.0 70.0 67.0 70.0 92.0 69.0 69.0 91.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:2.30 (2.7%) stddev-sans-first:2.40 03:09:02 INFO - PROCESS | 1667 | Values: 86.0 83.0 86.0 83.0 86.0 82.0 87.0 83.0 89.0 83.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:107.00 Median:94.50 stddev:16.32 (17.3%) stddev-sans-first:17.21 03:09:02 INFO - PROCESS | 1667 | Values: 102.0 97.0 98.0 137.0 94.0 114.0 135.0 96.0 95.0 102.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.56 03:09:02 INFO - PROCESS | 1667 | Values: 84.0 86.0 86.0 83.0 87.0 83.0 83.0 85.0 86.0 84.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.32 03:09:02 INFO - PROCESS | 1667 | Values: 57.0 56.0 54.0 55.0 57.0 58.0 56.0 56.0 57.0 58.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:3.99 (5.7%) stddev-sans-first:3.55 03:09:02 INFO - PROCESS | 1667 | Values: 64.0 67.0 78.0 75.0 71.0 68.0 68.0 70.0 70.0 71.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:5.91 (7.0%) stddev-sans-first:6.27 03:09:02 INFO - PROCESS | 1667 | Values: 85.0 82.0 85.0 100.0 78.0 84.0 82.0 83.0 87.0 89.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:144.50 stddev:20.19 (14.0%) stddev-sans-first:21.28 03:09:02 INFO - PROCESS | 1667 | Values: 142.0 147.0 153.0 138.0 135.0 133.0 130.0 177.0 191.0 138.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:165.00 stddev:16.15 (9.8%) stddev-sans-first:17.00 03:09:02 INFO - PROCESS | 1667 | Values: 164.0 167.0 163.0 165.0 215.0 163.0 163.0 169.0 161.0 165.0 03:09:02 INFO - PROCESS | 1667 | 03:09:02 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:67.00 stddev:9.28 (13.8%) stddev-sans-first:9.19 03:09:02 INFO - PROCESS | 1667 | Values: 62.0 84.0 84.0 86.0 66.0 66.0 67.0 66.0 66.0 67.0 03:09:02 INFO - PROCESS | 1667 | -------- Summary: end -------- 03:09:02 INFO - PROCESS | 1667 | 03:09:03 INFO - TEST-INFO | 1667: exit 0 03:09:03 INFO - TEST-OK | kraken | took 58470ms 03:09:03 INFO - SUITE-END | took 1175s 03:09:03 INFO - Completed test suite (00:19:36) 03:09:03 INFO - javascript benchmark 03:09:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.167458135466, 3336.9332613347733, 3337.332533493302, 3338.933221335572, 3377.1894745261143, 5634.154876768482, 5653.095504719246, 5722.685252311121, 5729.226554415158, 5740.081586946089, 5603.467670571299, 5659.0, 5661.2923384576925, 5669.979403707331, 5681.943180568193, 5154.32993710817, 5154.381474223099, 5178.55982241509, 5190.195519694435, 5199.766010529535, 5191.195364718475, 5206.947930520684, 5208.0885844977165, 5256.894862102756, 5303.443138470463, 5241.2400201970695, 5250.579953603703, 5258.13240815265, 5285.075111855429, 5285.762140703659, 5263.184206448007, 5296.179092240709, 5315.946840531584, 5326.067938110815, 5338.332708411449, 5110.156824124015, 5176.327077479904, 5259.815906443295, 5271.209318602202, 5290.761915713763, 5620.775168993236, 5637.351704553947, 5649.180868774005, 5683.715814209273, 5702.144678298288, 6175.845603859894, 6202.5658203925295, 6230.532710046765, 6274.466670333027, 6287.654179020152, 6224.221972253468, 6271.341509141565, 6299.779507717254, 6316.9368306317265, 6333.588316759396, 5362.731863406853, 5748.02283611787, 5748.827535173951, 5822.010258256107, 5833.649981001068, 6235.127082208494, 6240.095186198067, 6249.406306400884, 6269.341719119518, 6272.749090036439, 6175.59858609189, 6186.628802271878, 6186.659733714599, 6189.81430557084, 6210.378962103753, 6103.974138059492, 6166.0, 6191.349908259658, 6268.0, 6276.184096067482, 6248.0, 6249.9062514062325, 6269.216347956505, 6269.310375858652, 6278.372162783685, 6164.784232551929, 6192.225971753531, 6241.251049873953, 6251.531135164881, 6276.6547839869245, 4845.224764037737, 4898.0, 4903.705777653352, 4904.994476132384, 4986.750662466862, 4463.62059224963, 4470.664700147502, 4474.993126546501, 4518.277075667877, 4528.932066019012, 5822.7670893163795, 5844.503217226584, 5852.678102704393, 5861.648301101863, 5904.350521442638, 6106.005662907935, 6116.4879456621975, 6258.593191442542, 6297.874042519124, 6298.937010629835, 5679.886402271932, 5748.9425105748405, 5765.942340576625, 5816.621919575214, 5832.62087964281, 5335.813246536352, 5386.084365657847, 5400.945990540123, 5404.405515393303, 5405.837824865261, 6266.592671476339, 6271.122042913996, 6272.40412160844, 6284.780032698925, 6287.056941458818, 6132.478739307209, 6132.509399248139, 6159.4456498915315, 6210.472109870531, 6222.439980401786, 6226.283977342664, 6301.117843502005, 6304.810855674337, 6310.905336420049, 6325.557210995186, 6185.690715464299, 6223.0, 6256.280527739368, 6263.498920086473, 6265.561410701207, 4788.569028787426, 6148.9692551536955, 6167.444929956326, 6205.596636218631, 6324.936750632435, 6089.878202435838, 6106.855059071331, 6112.449879510866, 6173.753049877954, 6199.008158694767, 5082.567981721595, 6142.815715528542, 6145.692715364304, 6150.1082343059115, 6174.753009879554, 5797.8550536236935, 5974.551908606785, 5978.312494063239, 5994.520438364833, 6007.068904319837, 5991.64050156992, 6076.1493390924425, 6102.267727872683, 6106.399996025681, 6187.102870083722, 5626.409227031103, 5994.28068631767, 5996.1005849122985, 6009.399060094131, 6038.486728628116], "value": 5701.854260544245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.37069658522944, 499.71016810250046, 508.98965553376564, 517.9274901513786, 526.3131613244717, 29296.41407171858, 39128.0, 40024.19951600966, 40233.59766402331, 42558.36162457558, 42075.0, 42400.787996060055, 42508.14983700324, 42576.14847703044, 42620.93447663802, 8374.665013399457, 9674.419534827897, 9851.0, 9852.408855468695, 9873.456959867204, 8698.56507174642, 8932.910670893272, 11820.93611574958, 12121.818172727417, 12125.575604853831, 12086.879131208707, 12207.755844883097, 12213.694657633585, 12230.571929982452, 12256.0, 8749.737507874774, 12103.27380357177, 12200.023998080176, 12212.877871221262, 12213.816792748115, 8647.740567782977, 11613.245139065933, 11959.103067269989, 11964.102692298113, 12232.204906681038, 39900.80297591077, 40025.59974400248, 40109.398359024635, 40201.99495012619, 40221.59778402208, 3409.7613167078066, 3557.3774589446743, 3655.6161603031833, 3942.4086387041884, 3953.4267531207815, 30065.098047058622, 30297.545536816964, 31276.53085203724, 31976.0, 32103.612625552272, 3074.308280636861, 3085.7222849943614, 3161.1306890605038, 3194.834390520458, 3307.570015897942, 531759.0, 531804.7278108872, 532199.0, 532276.0, 535708.0, 60169.398306017254, 60532.48668783228, 60557.39442605606, 60563.39436605666, 60592.36445813265, 33708.66291337055, 34330.656693433244, 63583.364166357744, 63670.0449493258, 63952.040719389246, 16444.0, 16887.577810554587, 16890.915545422195, 16891.915540422466, 16956.23696933641, 11624.88375116255, 11889.940550297366, 12611.0, 12720.618381448572, 12743.745125097446, 16406.09766462832, 18448.723269150974, 18940.337088201846, 18971.24115035383, 19095.04524773756, 7060.752873649398, 7280.0, 7848.725294614661, 7980.840383192303, 8002.439829212016, 832.675256649907, 955.4553904274636, 1001.9048190421898, 1014.7209517382631, 1015.0509273828993, 28483.572746408405, 29522.852385737933, 29608.55587166194, 30047.948321809068, 30483.69516304853, 906.909309069101, 956.5934477846887, 989.2975987049132, 1001.1090129784498, 1014.9188064954934, 14543.490977815725, 14972.326245318987, 14998.775018374734, 15282.235888205545, 15323.0, 695917.0, 698227.5088624525, 700000.0000000036, 701548.0, 701610.0, 55657.0, 55987.720061399436, 56057.878842423735, 56060.0, 56116.71941640347, 1247.2329517346766, 1259.8362212912264, 1383.4189640350876, 1389.6178550898583, 1412.11037046662, 29224.707752922197, 29875.55186672245, 31174.532382013833, 31178.532322015642, 31906.840465797522, 47566.76216618895, 48272.0, 48304.0, 48418.5158148414, 48462.75768621134, 643179.0, 659187.0, 659678.0, 659755.0, 660166.0, 39814.21300508937, 42918.78540607277, 43434.0, 43443.131137377706, 43579.782101089295, 44943.77528112339, 46048.76975615101, 46114.538854612365, 46946.295805563626, 47072.529274706816, 31284.99977560258, 38013.80993095017, 38861.0, 39992.60081391103, 40148.598514014484, 32793.67206327906, 37032.62967370292, 37331.813340934204, 37901.43147852839, 40378.79810600928, 36815.63184368229, 37054.44418333673, 37891.0, 37909.241815164096, 38358.424623631225, 25781.222895716553, 33795.66204337925, 34217.65782342145, 34415.0, 34617.480737789454, 23413.882930585238, 23969.76030239745, 25214.873925630254, 25505.0, 25874.48251034931], "value": 20499.71040750098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8932825488225, 372.3428149316456, 374.04991322042014, 386.8645973909131, 402.84490471168607, 15189.620259493518, 15528.767068493968, 17024.0, 20575.38273851783, 20879.74680409514, 20293.594128117427, 20783.0, 21183.682244766303, 21430.14279428821, 21454.927253637296, 5652.858678533049, 5820.679862607555, 5984.670843103628, 6085.574009819315, 6087.995480745672, 5775.942240577582, 5954.910676339859, 5957.2851257849115, 5963.0, 5969.4925931295675, 4138.420621113031, 4413.58070983256, 6334.714937827809, 6562.80311590653, 6640.369164929324, 6484.319146489598, 6622.444054082302, 6625.271220165778, 6688.966555167217, 6714.731410743589, 5703.62926409782, 5811.941880581182, 5832.970835145839, 5837.066069428871, 5841.415858414167, 19379.515512112168, 26028.0, 26490.470190596272, 26519.867400663064, 26841.73158268412, 2061.9278325258542, 2246.382244882654, 2297.885105744706, 2475.789557887582, 2778.3470884342164, 15310.540683779505, 15896.364145434169, 15932.442364517303, 16465.91767041157, 16585.751213731804, 1876.277633111262, 1900.4108726294892, 1921.8174273444001, 1938.903054847266, 1981.6433042052424, 100584.0, 103788.0, 122820.77179228271, 127812.0, 129172.0, 10807.297525660806, 11097.33415995043, 11284.830727539094, 11502.769944601061, 11648.94175529117, 14403.711925761427, 14408.42366305336, 14425.639359016108, 14427.206503642401, 14455.0, 7527.661255243527, 8635.525046122399, 8764.123587641185, 8821.2060914518, 8901.599428025755, 7675.884861727079, 8816.426932249384, 8950.86573701395, 8976.685815996409, 9136.908630913606, 5814.680192589363, 6830.487713421513, 6858.794236172923, 6951.096357473597, 6988.93011069893, 1531.931063102163, 1832.496063582499, 1834.2479583370755, 1834.3304693786672, 1838.0, 681.7511608262948, 931.3247895276006, 952.2762700347647, 954.9045095490395, 1007.6120693532896, 21880.562388752136, 22468.775312246995, 22943.655845162335, 22987.195448159568, 23040.847957602055, 932.883389576303, 933.3054734684548, 933.607884688419, 949.0319873728758, 1077.7305673581604, 11476.598319058792, 12094.516219351128, 12138.028957683364, 12177.452014659184, 12235.632931012084, 527901.0, 530081.0, 530616.0, 632615.0, 645894.0, 143053.8541921872, 144178.27910860378, 144878.0, 146982.0, 153100.2344988268, 957.2437774158337, 983.179045497018, 1002.5839276700087, 1005.7988402319419, 1009.3943633819649, 18767.71848422302, 19779.307724229584, 20111.296104636855, 20266.493337666678, 20324.0, 53685.926281473374, 53904.0, 54891.45108548863, 55842.441575583725, 56810.14784778314, 78725.60637196778, 84409.15590844012, 87298.0, 89158.0, 89167.0, 6481.0, 7860.5676687782725, 8067.3142782864115, 8325.25072743456, 8346.499210047417, 9205.447673139633, 12692.17500862441, 12754.48982040708, 12831.935840320739, 13153.802692959805, 11166.879540193144, 11277.943610281896, 11377.943110284396, 11516.94241528787, 11641.41792910368, 9519.476428796483, 10853.240273180802, 11047.613333533287, 11053.944730276296, 11211.88788112141, 9344.532773361168, 11152.832707509557, 11437.02785263262, 11508.827367589325, 11739.11956603241, 7979.5611241382285, 7991.520508769492, 8224.013118425828, 8362.163783621589, 8445.788855278668, 8633.30933525304, 10880.238383313092, 11154.944225278821, 11163.553457861595, 11568.190226684052], "value": 9897.875615181738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.268351191428, 1547.7523596224603, 1699.3032856528819, 1820.1900154431266, 1851.7314989326555, 8527.275181609562, 9134.725958221255, 9137.086291370859, 9138.725838224847, 9147.679831205909, 7886.250806173404, 8090.150534193898, 8101.392395570327, 8634.136586341363, 8866.246369058637, 2367.7040369953756, 2430.1980346485707, 2433.0, 2438.9146379876706, 2439.4145405102736, 2400.23192578375, 2417.129833260025, 2437.7684120008657, 2439.1950656283384, 2445.339758265276, 2404.278716385086, 2422.600270955299, 2425.5027719317586, 2426.1872272788637, 2437.463757973243, 2385.403649087728, 2390.5935990881503, 2398.5083057973075, 2404.89177986991, 2421.2615152378517, 2305.8155347572156, 2338.625819868813, 2345.57779599672, 2349.295211436562, 2355.5759963206615, 7606.657700403495, 9035.232005279559, 9039.502827344493, 9060.139286767746, 9236.953815230949, 5270.077736396115, 5427.185922111676, 5427.945720542783, 5429.56563474921, 5433.347998240197, 3479.9826000869834, 3602.3875941089814, 3671.2657468506404, 3678.301122786662, 3680.834362453696, 1042.1818872185374, 1071.3786004117594, 1081.1891081688734, 1088.1186239146239, 1096.4243772019674, 11844.46699898498, 11895.226810257305, 11931.403429828473, 11951.342676152808, 11953.40232988347, 4563.612092972135, 4692.507286734844, 4864.124457597595, 4870.488598697157, 4879.853604391803, 10070.899291006996, 10073.0, 10080.596776128872, 10086.49567521621, 10090.49547522621, 5373.140297552372, 5384.3000409947235, 5389.865253368697, 5395.811146609928, 5401.783928642811, 4407.537208593116, 4523.5250298718165, 4543.909121817545, 4893.853184404474, 4900.191468407673, 3276.6231883333244, 3866.2654095721723, 3978.602139785998, 4011.398290256485, 4014.5985401460202, 1104.7238190452388, 1271.8918891894293, 1273.3696820074122, 1289.9161554498928, 1307.1176955554963, 740.2560426771169, 850.9276711479594, 907.668700924158, 909.663424532927, 923.8521836506127, 5651.46311100453, 5672.4894759471845, 5736.942630573724, 5745.4694195170605, 5975.910361344583, 866.8786369908091, 918.1507105927125, 921.709661456639, 927.3879239701764, 948.1087777489138, 3933.272344616255, 3936.075022369741, 3942.2903877301787, 3950.170464202492, 4016.59834016596, 10771.0, 11181.496832642551, 11182.32906025641, 11193.552257909756, 11232.606858759904, 11071.391073491035, 11078.944605276922, 11124.888751112385, 11140.610078647209, 11149.777004459866, 7901.802454938557, 8301.46040507365, 8460.280876125475, 8461.111583283666, 8473.110323415953, 5459.808906688247, 5551.9722401387735, 5835.766569337179, 5995.670238136944, 6083.756649733961, 8695.173958473935, 9993.050660187271, 10147.746306342106, 10284.0, 10301.690949271533, 9933.403995760278, 10173.643922462677, 10279.229057820543, 10535.209859260432, 10548.208884333859, 6521.6087034776165, 7038.225795162631, 7238.022866912899, 7250.383717384081, 7779.105402878741, 8162.591870406574, 8401.789955251168, 8412.116727743498, 8545.658173673231, 8545.700900468453, 7351.3751331137455, 7370.815729606803, 7486.4759466836795, 7609.429292802951, 7691.115521714851, 7256.383207427428, 7392.889106663297, 7410.333070023724, 7486.326230639269, 7553.848923021619, 6984.4063254623925, 7052.400545953446, 7116.323949224816, 7137.10786151731, 7162.498625096193, 4917.616984876185, 4951.529604687549, 4953.23224900141, 5015.673981191211, 5056.595472362129, 4877.707337559757, 4954.405471343462, 4967.577755890789, 5026.195808670595, 5039.496050394931], "value": 4618.114230851239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.9572312014757, 300.5221697500973, 310.1981378137514, 313.91053549738314, 315.6795852210006, 4854.538818812216, 5303.602229832759, 5369.5704343652515, 5430.131179011359, 5510.338759348879, 5318.9202161967605, 5327.362955337114, 5360.91958620621, 5375.381831089426, 5386.353637563498, 3578.0, 4119.938200926996, 4129.6283334499885, 4144.336906095025, 4163.376283249535, 3264.608247010362, 3502.807345595991, 4087.7736678996184, 4142.627163555279, 4168.24971505129, 3841.9615803842025, 3901.4784234148565, 3946.703997200207, 4068.776217308047, 4101.364288535282, 3406.3698215829904, 3978.940315895235, 4011.63895249426, 4043.6158564936286, 4084.6732261419015, 3331.650681474007, 3490.2495963367996, 3510.2970712551446, 3512.701420379271, 3523.5067090607336, 5072.474511606297, 5262.500062494057, 5299.682019078868, 5329.561018524976, 5344.225087362311, 3823.47061175532, 4621.052684199731, 4628.629709623222, 4653.581177694024, 4665.6967297125575, 4442.62237709795, 5672.829815105553, 5688.402717714622, 5690.800821971253, 5708.689939095997, 3387.254803943153, 3718.9442158367647, 3859.0931131184147, 3892.708046896494, 3895.4935858338235, 5155.871103222412, 5563.471470210324, 5665.790341766714, 5774.855628609318, 5933.61431506955, 3771.41543060826, 3778.848846046127, 3900.2199560088097, 3913.964738336106, 3937.5078115235597, 3958.762474251554, 3965.6827453803626, 3972.880813575597, 3975.1652153048185, 4003.619656132663, 3598.514200582888, 4485.708428952173, 4652.952700811632, 4665.883352916204, 4682.484926658065, 5226.085435048927, 5653.9151912721345, 5689.886202276014, 5709.8287051388525, 5716.542676585863, 1153.948072336747, 1289.7291568770477, 1327.5220920468817, 1342.5032737887045, 1358.4905660377358, 768.4937522455937, 807.9717209897743, 812.3014207781304, 825.8224481736455, 838.1827717975048, 3748.756330838487, 3813.523309586302, 4415.757133357696, 4443.067265739413, 4525.275955847049, 4683.454460028182, 4842.249451335048, 4866.2967961214, 4883.829065982744, 4897.4857639948, 3862.633049860259, 3966.8859944943083, 4035.5964403559997, 4268.466441694788, 4361.168309310097, 2349.76637265437, 2669.6529451171223, 3076.5541394591355, 3085.5217441296636, 3101.8914337998513, 6057.42454466825, 6061.090836374491, 6080.2399700037495, 6084.0, 6122.693865306717, 4819.2530157825595, 5149.665271757323, 5628.549716022791, 5825.79609713658, 6019.367966363557, 5005.746264927826, 5317.946820531823, 6046.395360464006, 6048.576599637983, 6057.030875059969, 5094.617903657315, 5819.388964158872, 5830.6298019966125, 5846.216903844368, 5889.94110058894, 5384.326959130109, 5696.006397760916, 5716.256541754805, 5769.1634712967225, 5771.701367192348, 5043.839916819079, 5500.669959802264, 5792.4497172768515, 5995.1906492624685, 6049.576529642883, 3145.7797954143907, 3918.2555314490155, 3927.312720273998, 3928.64642182205, 3928.6660633846445, 5898.941010590011, 5908.0, 5909.261342332208, 5915.674637894957, 5919.0, 5308.654937429054, 5481.3422389311945, 5749.8275051748515, 5759.782483743705, 5834.38738932406, 5740.101248869294, 5757.251557297692, 5757.568182386254, 5781.82654520365, 5790.10253410722, 5470.72646367688, 5658.292713410824, 5677.410325108976, 5730.885382292247, 5731.942680573141, 5369.999350483915, 5641.858953526031, 5670.603057785916, 5674.347450043298, 5685.545156387562, 4877.609791216765, 4944.604431645388, 5397.163439666858, 5515.393306736176, 5552.250446189712], "value": 4055.829884879889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.4733179117976, 771.3096778383347, 788.3811208201562, 801.6312496251724, 818.4230117766975, 14821.925890370547, 15724.528264152064, 15806.209689515536, 15843.207839608016, 15875.52373428796, 14542.418303267883, 14621.92689036556, 14622.780658290134, 14646.487372941949, 14658.900582456305, 663.8307231655921, 681.9215790184143, 685.1880521581917, 809.295912556077, 824.1675907333577, 831.7546323834483, 839.8320335932807, 843.2158092973532, 848.0035957749619, 850.1668365002301, 896.0725648953335, 900.0324651000168, 901.134910485931, 902.4134312696734, 902.463034494478, 691.2154704410531, 714.9954314188574, 888.7156110044788, 895.9820803583924, 897.2776914583758, 638.3361304243581, 656.7734131724548, 657.3656421553225, 658.4896705053574, 659.8185498987768, 14945.17801520916, 14972.550823475312, 15005.24973751308, 15014.624634384229, 15023.849761502355, 13538.932305338509, 13743.0, 13763.38064787077, 13841.653958651013, 14116.15303081808, 11962.58130965412, 12446.3154526501, 12514.499420023189, 12764.6624493624, 12853.293068881208, 4531.841385551523, 4574.121491695632, 4590.288505281686, 4632.907341853178, 4768.642351823627, 117953.0, 118675.81324186733, 118776.0, 121191.0, 123795.0, 10666.36001839892, 10680.412577308323, 10855.728606784893, 10924.781504369868, 11000.889991099986, 21283.46791330229, 21323.36029919105, 21324.89337553302, 21353.14587416486, 21369.0, 7866.174051724486, 7918.762437126896, 7952.085510166289, 7965.084015338194, 8011.399145064143, 4372.868813935587, 4442.4669039715445, 4459.3979812724865, 4477.619402350771, 4598.609118224921, 3135.6550779414247, 3223.16197788572, 3224.5485632011537, 3228.338190670907, 3233.401820663185, 649.8700259947934, 668.535906365059, 677.0656494038195, 685.7976896815352, 690.7616872179091, 572.3046498504337, 602.9216201893813, 627.7018416252243, 631.66837410359, 640.8558074433215, 8450.648214427649, 9137.77155571116, 9220.308476864262, 9274.0, 9392.483413412328, 537.9300690910235, 607.9755611794053, 623.6258245053023, 640.826976716284, 653.0889409274037, 4305.5048669402795, 4545.9537716539235, 4551.749653769009, 4582.2668373060815, 4646.3495110684535, 141817.58182418044, 163543.0, 170328.0, 170559.0, 171171.0, 103828.44257336146, 119025.0, 134991.0, 143377.0, 150395.0, 108069.0, 110527.0, 111190.0, 111609.88390115995, 112080.0, 8377.413581049268, 8565.61454734526, 8573.142685731376, 8641.0, 8843.07147749477, 62674.05988910079, 64344.67827660832, 66055.0, 66462.66768666125, 66493.67012659623, 102193.97806021845, 103223.0, 104016.47991759992, 106108.0, 106455.0, 10542.789144216918, 10855.620053298097, 10929.234953553176, 11174.66476005721, 11228.382438965935, 11963.64109076729, 12001.459934302802, 12307.569235077088, 12646.620601381605, 12770.106092573431, 11405.714857128638, 11514.30914145154, 11869.050475961729, 11921.0, 12036.338001410006, 11478.426078696199, 11539.480723367637, 11543.88456115428, 11546.826797597874, 11612.361320127475, 11158.49786759614, 11208.439578021229, 11469.31184128955, 11472.369019703663, 11702.127659574238, 9356.532173391439, 9813.705588832347, 10128.502543946503, 10271.537780799732, 10628.309159904582, 8436.0, 10097.376480757275, 10132.527597451186, 10145.391276523433, 10149.492525373555], "value": 7631.586298765459, "unit": "score"}], "name": "dromaeo_css", "value": 7408.872108635013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 112.0, 142.0, 108.0, 107.0, 108.0, 107.0, 141.0, 106.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 183.0, 185.0, 184.0, 182.0, 186.0, 185.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 63.0, 59.0, 66.0, 63.0, 111.0, 78.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 94.0, 70.0, 67.0, 70.0, 92.0, 69.0, 69.0, 91.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 86.0, 82.0, 87.0, 83.0, 89.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 97.0, 98.0, 137.0, 94.0, 114.0, 135.0, 96.0, 95.0, 102.0], "value": 107.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 83.0, 87.0, 83.0, 83.0, 85.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 55.0, 57.0, 58.0, 56.0, 56.0, 57.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 78.0, 75.0, 71.0, 68.0, 68.0, 70.0, 70.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 100.0, 78.0, 84.0, 82.0, 83.0, 87.0, 89.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 153.0, 138.0, 135.0, 133.0, 130.0, 177.0, 191.0, 138.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 163.0, 165.0, 215.0, 163.0, 163.0, 169.0, 161.0, 165.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 84.0, 84.0, 86.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1444.7000000000003, "alertThreshold": 2.0}]} 03:09:04 INFO - Return code: 0 03:09:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:09:04 INFO - # TBPL SUCCESS # 03:09:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:04 INFO - 2016-10-11 03:09:04.151 screenresolution[1673:10653] starting screenresolution argv=screenresolution get 03:09:04 INFO - 2016-10-11 03:09:04.154 screenresolution[1673:10653] Display 0: 1600x1200x32@60 03:09:04 INFO - 2016-10-11 03:09:04.160 screenresolution[1674:10655] starting screenresolution argv=screenresolution list 03:09:04 INFO - Available Modes on Display 0 03:09:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:04 INFO - Intel Iris: 03:09:04 INFO - Chipset Model: Intel Iris 03:09:04 INFO - Type: GPU 03:09:04 INFO - Bus: Built-In 03:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:04 INFO - Vendor: Intel (0x8086) 03:09:04 INFO - Device ID: 0x0a2e 03:09:04 INFO - Revision ID: 0x0009 03:09:04 INFO - Displays: 03:09:04 INFO - Display: 03:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:04 INFO - Display Serial Number: 1600x1200 60 03:09:04 INFO - Main Display: Yes 03:09:04 INFO - Mirror: Off 03:09:04 INFO - Online: Yes 03:09:04 INFO - Rotation: Supported 03:09:04 INFO - Return code: 0 03:09:04 INFO - Running post-action listener: _resource_record_post_action 03:09:04 INFO - [mozharness: 2016-10-11 10:09:04.395066Z] Finished run-tests step (success) 03:09:04 INFO - Running post-run listener: _resource_record_post_run 03:09:04 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33270784; Write bytes: 666977792; Read time: 317; Write time: 2252 03:09:04 INFO - TinderboxPrint: CPU usage
53.4% 03:09:04 INFO - TinderboxPrint: I/O read bytes / time
33,270,784 / 317 03:09:04 INFO - TinderboxPrint: I/O write bytes / time
666,977,792 / 2,252 03:09:04 INFO - TinderboxPrint: CPU idle
2,256.6 (46.6%) 03:09:04 INFO - TinderboxPrint: CPU system
967.8 (20.0%) 03:09:04 INFO - TinderboxPrint: CPU user
1,613.3 (33.3%) 03:09:04 INFO - TinderboxPrint: Swap in / out
407,318,528 / 0 03:09:04 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360335872; Write bytes: 355149824; Read time: 27445; Write time: 674 03:09:04 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31230976; Write bytes: 300584448; Read time: 295; Write time: 1542 03:09:04 INFO - Running post-run listener: _upload_blobber_files 03:09:04 INFO - Blob upload gear active. 03:09:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:04 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 03:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:06 INFO - (blobuploader) - INFO - Done attempting. 03:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:07 INFO - (blobuploader) - INFO - Done attempting. 03:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:09 INFO - (blobuploader) - INFO - Done attempting. 03:09:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:09 INFO - Return code: 0 03:09:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027602f9b7115c2098d3e3ee4f4a197b8d4a7f94e47edbf12858e2744cfffd9fc5b895deae3d3371410c01d07e419f942fde152adc0d2a392d6cacb1f9108d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dae2fc46c3843717a27c56a28d389911a21abd8b1bfba1b4b8ba736ed41b2dc0087f5e64cc214b926d476b0db44898b7e448811b0be6271a9d693b9d9bab700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/958e3f83a47cfb0b539d281b786315bc2d6e80678871fb8b282fd2c735b84c778c2fa87f98bb6243feb02c220e3cbd248ae3d9608c75bb7cf11dfbd66f290668"} 03:09:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:09 INFO - Contents: 03:09:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027602f9b7115c2098d3e3ee4f4a197b8d4a7f94e47edbf12858e2744cfffd9fc5b895deae3d3371410c01d07e419f942fde152adc0d2a392d6cacb1f9108d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dae2fc46c3843717a27c56a28d389911a21abd8b1bfba1b4b8ba736ed41b2dc0087f5e64cc214b926d476b0db44898b7e448811b0be6271a9d693b9d9bab700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/958e3f83a47cfb0b539d281b786315bc2d6e80678871fb8b282fd2c735b84c778c2fa87f98bb6243feb02c220e3cbd248ae3d9608c75bb7cf11dfbd66f290668"} 03:09:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:09 INFO - Copying logs to upload dir... 03:09:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.453191 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-11 03:09:09.651448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:09.657225) ========= 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.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027602f9b7115c2098d3e3ee4f4a197b8d4a7f94e47edbf12858e2744cfffd9fc5b895deae3d3371410c01d07e419f942fde152adc0d2a392d6cacb1f9108d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dae2fc46c3843717a27c56a28d389911a21abd8b1bfba1b4b8ba736ed41b2dc0087f5e64cc214b926d476b0db44898b7e448811b0be6271a9d693b9d9bab700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/958e3f83a47cfb0b539d281b786315bc2d6e80678871fb8b282fd2c735b84c778c2fa87f98bb6243feb02c220e3cbd248ae3d9608c75bb7cf11dfbd66f290668"} build_url:https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027602f9b7115c2098d3e3ee4f4a197b8d4a7f94e47edbf12858e2744cfffd9fc5b895deae3d3371410c01d07e419f942fde152adc0d2a392d6cacb1f9108d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dae2fc46c3843717a27c56a28d389911a21abd8b1bfba1b4b8ba736ed41b2dc0087f5e64cc214b926d476b0db44898b7e448811b0be6271a9d693b9d9bab700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/958e3f83a47cfb0b539d281b786315bc2d6e80678871fb8b282fd2c735b84c778c2fa87f98bb6243feb02c220e3cbd248ae3d9608c75bb7cf11dfbd66f290668"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:09.934402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:09.934726) ========= 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.qqQUQw4b67/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.kKwAuVktZc/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005032 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:09.983752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 03:09:09.984075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 03:09:09.984387) ========= ========= Total master_lag: 0.42 =========