builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1470758691.35 results: success (0) buildid: 20160809064419 builduid: a6589aed923947f292a7168d3cc8a142 revision: 0813514a828bf931605bd22596d8fe876c1bb368 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:04:51.350435) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:04:51.350914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-08-09 09:04:51.351196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-08-09 09:05:06.110542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:06.110841) ========= 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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-08-09 09:05:06-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.07M=0.001s 2016-08-09 09:05:06 (9.07 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.456407 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:06.589713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:06.590029) ========= 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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.028419 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:06.638924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 09:05:06.639291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0813514a828bf931605bd22596d8fe876c1bb368 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0813514a828bf931605bd22596d8fe876c1bb368 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-08-09 09:05:06,715 truncating revision to first 12 chars 2016-08-09 09:05:06,715 Setting DEBUG logging. 2016-08-09 09:05:06,715 attempt 1/10 2016-08-09 09:05:06,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0813514a828b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 09:05:07,687 unpacking tar archive at: mozilla-central-0813514a828b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.226555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 09:05:07.889192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:07.889504) ========= script_repo_revision: 0813514a828bf931605bd22596d8fe876c1bb368 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:07.889926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:07.890202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:05:07.908729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-09 09:05:07.909133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:05:08 INFO - MultiFileLogger online at 20160809 09:05:08 in /builds/slave/test 09:05:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:05:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:08 INFO - {'append_to_log': False, 09:05:08 INFO - 'base_work_dir': '/builds/slave/test', 09:05:08 INFO - 'blob_upload_branch': 'Firefox', 09:05:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:08 INFO - 'branch': 'Firefox', 09:05:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:08 INFO - 'config_files': ('talos/mac_config.py',), 09:05:08 INFO - 'default_actions': ('clobber', 09:05:08 INFO - 'read-buildbot-config', 09:05:08 INFO - 'download-and-extract', 09:05:08 INFO - 'populate-webroot', 09:05:08 INFO - 'create-virtualenv', 09:05:08 INFO - 'install', 09:05:08 INFO - 'run-tests'), 09:05:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:08 INFO - 'download_minidump_stackwalk': True, 09:05:08 INFO - 'download_symbols': 'ondemand', 09:05:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:08 INFO - 'installer_path': 'installer.exe', 09:05:08 INFO - 'log_level': 'info', 09:05:08 INFO - 'log_name': 'talos', 09:05:08 INFO - 'log_to_console': True, 09:05:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:05:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:05:08 INFO - 'opt_config_files': (), 09:05:08 INFO - 'pip_index': False, 09:05:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:08 INFO - 'cmd': ('bash', 09:05:08 INFO - '-c', 09:05:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:08 INFO - 'enabled': True, 09:05:08 INFO - 'halt_on_failure': False, 09:05:08 INFO - 'name': 'check_screen_resolution'},), 09:05:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:08 INFO - 'cmd': ('bash', 09:05:08 INFO - '-c', 09:05:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:08 INFO - 'enabled': True, 09:05:08 INFO - 'halt_on_failure': False, 09:05:08 INFO - 'name': 'check_screen_resolution'},), 09:05:08 INFO - 'run_cmd_checks_enabled': True, 09:05:08 INFO - 'sps_profile': False, 09:05:08 INFO - 'sps_profile_interval': 0, 09:05:08 INFO - 'suite': 'dromaeojs-e10s', 09:05:08 INFO - 'system_bits': '32', 09:05:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:08 INFO - 'title': 't-yosemite-r7-0073', 09:05:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:08 INFO - 'use_talos_json': True, 09:05:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:08 INFO - 'work_dir': 'build'} 09:05:08 INFO - [mozharness: 2016-08-09 16:05:08.106234Z] Running clobber step. 09:05:08 INFO - Running pre-action listener: _resource_record_pre_action 09:05:08 INFO - Running main action method: clobber 09:05:08 INFO - rmtree: /builds/slave/test/build 09:05:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - [mozharness: 2016-08-09 16:05:10.205061Z] Finished clobber step (success) 09:05:10 INFO - [mozharness: 2016-08-09 16:05:10.205197Z] Running read-buildbot-config step. 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: read_buildbot_config 09:05:10 INFO - Using buildbot properties: 09:05:10 INFO - { 09:05:10 INFO - "project": "", 09:05:10 INFO - "product": "firefox", 09:05:10 INFO - "script_repo_revision": "production", 09:05:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:05:10 INFO - "repository": "", 09:05:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:05:10 INFO - "buildid": "20160809064419", 09:05:10 INFO - "pgo_build": "False", 09:05:10 INFO - "basedir": "/builds/slave/test", 09:05:10 INFO - "buildnumber": 36, 09:05:10 INFO - "slavename": "t-yosemite-r7-0073", 09:05:10 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:05:10 INFO - "platform": "yosemite_r7", 09:05:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:05:10 INFO - "branch": "mozilla-central", 09:05:10 INFO - "repo_path": "mozilla-central", 09:05:10 INFO - "revision": "0813514a828bf931605bd22596d8fe876c1bb368", 09:05:10 INFO - "stage_platform": "macosx64", 09:05:10 INFO - "builduid": "a6589aed923947f292a7168d3cc8a142", 09:05:10 INFO - "slavebuilddir": "test" 09:05:10 INFO - } 09:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - [mozharness: 2016-08-09 16:05:10.208500Z] Finished read-buildbot-config step (success) 09:05:10 INFO - [mozharness: 2016-08-09 16:05:10.208612Z] Running download-and-extract step. 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: download_and_extract 09:05:10 INFO - mkdir: /builds/slave/test/build/tests 09:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:10 INFO - trying https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:05:10 INFO - Downloading https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 09:05:11 INFO - Downloaded 1199 bytes. 09:05:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:05:11 INFO - Using the following test package requirements: 09:05:11 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:05:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:05:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:05:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'jsshell-mac.zip'], 09:05:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:05:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:05:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:05:11 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:05:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:05:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:05:11 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:05:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:11 INFO - trying https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:05:12 INFO - Downloaded 16324563 bytes. 09:05:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:05:15 INFO - Return code: 0 09:05:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:15 INFO - trying https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:05:15 INFO - Downloading https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:05:16 INFO - Downloaded 16324563 bytes. 09:05:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:05:19 INFO - Return code: 0 09:05: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')]} 09:05:19 INFO - trying https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:05:19 INFO - Downloading https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:05:20 INFO - Downloaded 14413723 bytes. 09:05:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:05:20 INFO - Return code: 0 09:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:20 INFO - trying https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:05:20 INFO - Downloading https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 09:05:23 INFO - Downloaded 111953263 bytes. 09:05:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:05:23 INFO - mkdir: /builds/slave/test/properties 09:05:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:23 INFO - Contents: 09:05:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:05:24 INFO - Running post-action listener: _resource_record_post_action 09:05:24 INFO - Running post-action listener: set_extra_try_arguments 09:05:24 INFO - [mozharness: 2016-08-09 16:05:24.623089Z] Finished download-and-extract step (success) 09:05:24 INFO - [mozharness: 2016-08-09 16:05:24.623242Z] Running populate-webroot step. 09:05:24 INFO - Running pre-action listener: _resource_record_pre_action 09:05:24 INFO - Running main action method: populate_webroot 09:05:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:24 INFO - '--tppagecycles', 09:05:24 INFO - '7'], 09:05:24 INFO - 'tests': ['tsvgm']}}, 09:05:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['damp', 'tps']}, 09:05:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'tests': ['damp', 'tps']}, 09:05:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['dromaeo_dom']}, 09:05:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['basic_compositor_video']}, 09:05:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['a11yr', 09:05:24 INFO - 'ts_paint', 09:05:24 INFO - 'tpaint', 09:05:24 INFO - 'sessionrestore', 09:05:24 INFO - 'sessionrestore_no_auto_restore', 09:05:24 INFO - 'tabpaint']}, 09:05:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['tsvgx', 09:05:24 INFO - 'tsvgr_opacity', 09:05:24 INFO - 'tart', 09:05:24 INFO - 'tscrollx', 09:05:24 INFO - 'cart']}, 09:05:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:24 INFO - 'tsvgr_opacity', 09:05:24 INFO - 'tart', 09:05:24 INFO - 'tscrollx', 09:05:24 INFO - 'cart']}, 09:05:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'talos_options': ['--disable-e10s'], 09:05:24 INFO - 'tests': ['tp5o']}, 09:05:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'tests': ['tp5o']}, 09:05:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'talos_options': ['--disable-e10s', 09:05:24 INFO - '--xperf_path', 09:05:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:24 INFO - 'tests': ['tp5n']}, 09:05:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:24 INFO - 'talos_options': ['--xperf_path', 09:05:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:24 INFO - 'tests': ['tp5n']}}, 09:05:24 INFO - 'talos.zip': {'path': '', 09:05:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:24 INFO - Running post-action listener: _resource_record_post_action 09:05:24 INFO - [mozharness: 2016-08-09 16:05:24.642077Z] Finished populate-webroot step (success) 09:05:24 INFO - [mozharness: 2016-08-09 16:05:24.642192Z] Running create-virtualenv step. 09:05:24 INFO - Running pre-action listener: _resource_record_pre_action 09:05:24 INFO - Running main action method: create_virtualenv 09:05:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:05:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:24 INFO - Using real prefix '/tools/python27' 09:05:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:28 INFO - Installing pip.................done. 09:05:28 INFO - Return code: 0 09:05:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:28 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:28 INFO - 'HOME': '/Users/cltbld', 09:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:28 INFO - 'LOGNAME': 'cltbld', 09:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:28 INFO - 'MOZ_NO_REMOTE': '1', 09:05:28 INFO - 'NO_EM_RESTART': '1', 09:05:28 INFO - 'PAGER': '/bin/cat', 09:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:28 INFO - 'PWD': '/builds/slave/test', 09:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:28 INFO - 'SHELL': '/bin/bash', 09:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:28 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:28 INFO - 'USER': 'cltbld', 09:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:28 INFO - 'XPC_FLAGS': '0x0', 09:05:28 INFO - 'XPC_SERVICE_NAME': '0', 09:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:05:28 INFO - Cleaning up... 09:05:28 INFO - Return code: 0 09:05:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:28 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:28 INFO - 'HOME': '/Users/cltbld', 09:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:28 INFO - 'LOGNAME': 'cltbld', 09:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:28 INFO - 'MOZ_NO_REMOTE': '1', 09:05:28 INFO - 'NO_EM_RESTART': '1', 09:05:28 INFO - 'PAGER': '/bin/cat', 09:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:28 INFO - 'PWD': '/builds/slave/test', 09:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:28 INFO - 'SHELL': '/bin/bash', 09:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:28 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:28 INFO - 'USER': 'cltbld', 09:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:28 INFO - 'XPC_FLAGS': '0x0', 09:05:28 INFO - 'XPC_SERVICE_NAME': '0', 09:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:28 INFO - Downloading/unpacking psutil>=3.1.1 09:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:32 INFO - Installing collected packages: psutil 09:05:32 INFO - Running setup.py install for psutil 09:05:32 INFO - building 'psutil._psutil_osx' extension 09:05: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:05: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 09:05:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:05:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:05:33 INFO - building 'psutil._psutil_posix' extension 09:05:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:05:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:05:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:05:33 INFO - ^ 09:05:33 INFO - 1 warning generated. 09:05:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:05:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:33 INFO - Successfully installed psutil 09:05:33 INFO - Cleaning up... 09:05:33 INFO - Return code: 0 09:05:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:33 INFO - 'HOME': '/Users/cltbld', 09:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:33 INFO - 'LOGNAME': 'cltbld', 09:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:33 INFO - 'MOZ_NO_REMOTE': '1', 09:05:33 INFO - 'NO_EM_RESTART': '1', 09:05:33 INFO - 'PAGER': '/bin/cat', 09:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:33 INFO - 'PWD': '/builds/slave/test', 09:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:33 INFO - 'SHELL': '/bin/bash', 09:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:33 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:33 INFO - 'USER': 'cltbld', 09:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:33 INFO - 'XPC_FLAGS': '0x0', 09:05:33 INFO - 'XPC_SERVICE_NAME': '0', 09:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:36 INFO - Installing collected packages: mozsystemmonitor 09:05:36 INFO - Running setup.py install for mozsystemmonitor 09:05:36 INFO - Successfully installed mozsystemmonitor 09:05:36 INFO - Cleaning up... 09:05:36 INFO - Return code: 0 09:05:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:36 INFO - 'HOME': '/Users/cltbld', 09:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:36 INFO - 'LOGNAME': 'cltbld', 09:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:36 INFO - 'MOZ_NO_REMOTE': '1', 09:05:36 INFO - 'NO_EM_RESTART': '1', 09:05:36 INFO - 'PAGER': '/bin/cat', 09:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:36 INFO - 'PWD': '/builds/slave/test', 09:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:36 INFO - 'SHELL': '/bin/bash', 09:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:36 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:36 INFO - 'USER': 'cltbld', 09:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:36 INFO - 'XPC_FLAGS': '0x0', 09:05:36 INFO - 'XPC_SERVICE_NAME': '0', 09:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:39 INFO - warning: no files found matching '*.txt' 09:05:39 INFO - no previously-included directories found matching 'build' 09:05:39 INFO - no previously-included directories found matching 'dist' 09:05:39 INFO - no previously-included directories found matching '.git*' 09:05:39 INFO - Installing collected packages: jsonschema, functools32 09:05:39 INFO - Running setup.py install for functools32 09:05:39 INFO - warning: no files found matching '*.txt' 09:05:39 INFO - no previously-included directories found matching 'build' 09:05:39 INFO - no previously-included directories found matching 'dist' 09:05:39 INFO - no previously-included directories found matching '.git*' 09:05:39 INFO - Successfully installed jsonschema functools32 09:05:39 INFO - Cleaning up... 09:05:39 INFO - Return code: 0 09:05:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05: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 09:05: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 09:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:39 INFO - 'HOME': '/Users/cltbld', 09:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:39 INFO - 'LOGNAME': 'cltbld', 09:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:39 INFO - 'MOZ_NO_REMOTE': '1', 09:05:39 INFO - 'NO_EM_RESTART': '1', 09:05:39 INFO - 'PAGER': '/bin/cat', 09:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:39 INFO - 'PWD': '/builds/slave/test', 09:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:39 INFO - 'SHELL': '/bin/bash', 09:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:39 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:39 INFO - 'USER': 'cltbld', 09:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:39 INFO - 'XPC_FLAGS': '0x0', 09:05:39 INFO - 'XPC_SERVICE_NAME': '0', 09:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:40 INFO - Cleaning up... 09:05:40 INFO - Return code: 0 09:05:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:40 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:40 INFO - 'HOME': '/Users/cltbld', 09:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:40 INFO - 'LOGNAME': 'cltbld', 09:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:40 INFO - 'MOZ_NO_REMOTE': '1', 09:05:40 INFO - 'NO_EM_RESTART': '1', 09:05:40 INFO - 'PAGER': '/bin/cat', 09:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:40 INFO - 'PWD': '/builds/slave/test', 09:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:40 INFO - 'SHELL': '/bin/bash', 09:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:40 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:40 INFO - 'USER': 'cltbld', 09:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:40 INFO - 'XPC_FLAGS': '0x0', 09:05:40 INFO - 'XPC_SERVICE_NAME': '0', 09:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:44 INFO - Downloading docopt-0.6.1.tar.gz 09:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:44 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:44 INFO - Running setup.py install for blobuploader 09:05:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:44 INFO - Running setup.py install for requests 09:05:44 INFO - Running setup.py install for docopt 09:05:44 INFO - Successfully installed blobuploader requests docopt 09:05:44 INFO - Cleaning up... 09:05:45 INFO - Return code: 0 09:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:45 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:45 INFO - 'HOME': '/Users/cltbld', 09:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:45 INFO - 'LOGNAME': 'cltbld', 09:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:45 INFO - 'MOZ_NO_REMOTE': '1', 09:05:45 INFO - 'NO_EM_RESTART': '1', 09:05:45 INFO - 'PAGER': '/bin/cat', 09:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:45 INFO - 'PWD': '/builds/slave/test', 09:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:45 INFO - 'SHELL': '/bin/bash', 09:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:45 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:45 INFO - 'USER': 'cltbld', 09:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:45 INFO - 'XPC_FLAGS': '0x0', 09:05:45 INFO - 'XPC_SERVICE_NAME': '0', 09:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-t2kSSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TzSYDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-_ZfHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-IAKZ3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pJnUCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:45 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-xfJq6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-jS2XzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fRbar9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-aSR6W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yTwuA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XI4e9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Qag2z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-nF5fcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1Eid_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6qZ2zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:46 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-oivrt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:47 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9bjiYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:47 INFO - Running setup.py install for manifestparser 09:05:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:47 INFO - Running setup.py install for mozcrash 09:05:47 INFO - Running setup.py install for mozdebug 09:05:47 INFO - Running setup.py install for mozdevice 09:05:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:47 INFO - Running setup.py install for mozfile 09:05:47 INFO - Running setup.py install for mozhttpd 09:05:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Running setup.py install for mozinfo 09:05:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Running setup.py install for mozInstall 09:05:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Running setup.py install for mozleak 09:05:48 INFO - Running setup.py install for mozlog 09:05:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Running setup.py install for moznetwork 09:05:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:48 INFO - Running setup.py install for mozprocess 09:05:48 INFO - Running setup.py install for mozprofile 09:05:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:49 INFO - Running setup.py install for mozrunner 09:05:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:49 INFO - Running setup.py install for mozscreenshot 09:05:49 INFO - Running setup.py install for moztest 09:05:49 INFO - Running setup.py install for mozversion 09:05:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:49 INFO - Cleaning up... 09:05:49 INFO - Return code: 0 09:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05: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 09:05: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 09:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:49 INFO - 'HOME': '/Users/cltbld', 09:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:49 INFO - 'LOGNAME': 'cltbld', 09:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:49 INFO - 'MOZ_NO_REMOTE': '1', 09:05:49 INFO - 'NO_EM_RESTART': '1', 09:05:49 INFO - 'PAGER': '/bin/cat', 09:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:49 INFO - 'PWD': '/builds/slave/test', 09:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:49 INFO - 'SHELL': '/bin/bash', 09:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:49 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:49 INFO - 'USER': 'cltbld', 09:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:49 INFO - 'XPC_FLAGS': '0x0', 09:05:49 INFO - 'XPC_SERVICE_NAME': '0', 09:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pWOZDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-SQNmLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-S5oKWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-V8rtS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-kRnnOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MvVuqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05: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)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lbCk6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05: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)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-skQuta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05: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)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-epx1ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05: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)) 09:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-N6Y6Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-oBjYRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Ce5n7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6VUGFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-QG4Bqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YYV2JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05: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)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-UuOeIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05: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)) 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pJ8pLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:54 INFO - Downloading blessings-1.6.tar.gz 09:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:54 INFO - Installing collected packages: blessings 09:05:54 INFO - Running setup.py install for blessings 09:05:54 INFO - Successfully installed blessings 09:05:54 INFO - Cleaning up... 09:05:54 INFO - Return code: 0 09:05:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:54 INFO - Reading from file tmpfile_stdout 09:05:54 INFO - Current package versions: 09:05:54 INFO - blessings == 1.6 09:05:54 INFO - blobuploader == 1.2.4 09:05:54 INFO - docopt == 0.6.1 09:05:54 INFO - functools32 == 3.2.3-2 09:05:54 INFO - jsonschema == 2.5.1 09:05:54 INFO - manifestparser == 1.1 09:05:54 INFO - mozInstall == 1.12 09:05:54 INFO - mozcrash == 0.17 09:05:54 INFO - mozdebug == 0.1 09:05:54 INFO - mozdevice == 0.48 09:05:54 INFO - mozfile == 1.2 09:05:54 INFO - mozhttpd == 0.7 09:05:54 INFO - mozinfo == 0.9 09:05:54 INFO - mozleak == 0.1 09:05:54 INFO - mozlog == 3.3 09:05:54 INFO - moznetwork == 0.27 09:05:54 INFO - mozprocess == 0.23 09:05:54 INFO - mozprofile == 0.28 09:05:54 INFO - mozrunner == 6.12 09:05:54 INFO - mozscreenshot == 0.1 09:05:54 INFO - mozsystemmonitor == 0.3 09:05:54 INFO - moztest == 0.7 09:05:54 INFO - mozversion == 1.4 09:05:54 INFO - psutil == 3.1.1 09:05:54 INFO - requests == 1.2.3 09:05:54 INFO - wsgiref == 0.1.2 09:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05: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 09:05: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 09:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:54 INFO - 'HOME': '/Users/cltbld', 09:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:54 INFO - 'LOGNAME': 'cltbld', 09:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:54 INFO - 'MOZ_NO_REMOTE': '1', 09:05:54 INFO - 'NO_EM_RESTART': '1', 09:05:54 INFO - 'PAGER': '/bin/cat', 09:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:54 INFO - 'PWD': '/builds/slave/test', 09:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:54 INFO - 'SHELL': '/bin/bash', 09:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:54 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:54 INFO - 'USER': 'cltbld', 09:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:54 INFO - 'XPC_FLAGS': '0x0', 09:05:54 INFO - 'XPC_SERVICE_NAME': '0', 09:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:55 INFO - Cleaning up... 09:05:55 INFO - Return code: 0 09:05:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:55 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 0x104394a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104429618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe23145d5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, '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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:55 INFO - 'HOME': '/Users/cltbld', 09:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:55 INFO - 'LOGNAME': 'cltbld', 09:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:55 INFO - 'MOZ_NO_REMOTE': '1', 09:05:55 INFO - 'NO_EM_RESTART': '1', 09:05:55 INFO - 'PAGER': '/bin/cat', 09:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:55 INFO - 'PWD': '/builds/slave/test', 09:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:55 INFO - 'SHELL': '/bin/bash', 09:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:05:55 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:55 INFO - 'USER': 'cltbld', 09:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:55 INFO - 'XPC_FLAGS': '0x0', 09:05:55 INFO - 'XPC_SERVICE_NAME': '0', 09:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:55 INFO - Cleaning up... 09:05:55 INFO - Return code: 0 09:05:55 INFO - Running post-action listener: _resource_record_post_action 09:05:55 INFO - Running post-action listener: _start_resource_monitoring 09:05:55 INFO - Starting resource monitoring. 09:05:55 INFO - [mozharness: 2016-08-09 16:05:55.510897Z] Finished create-virtualenv step (success) 09:05:55 INFO - [mozharness: 2016-08-09 16:05:55.511841Z] Running install step. 09:05:55 INFO - Running pre-action listener: _resource_record_pre_action 09:05:55 INFO - Running main action method: install 09:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:55 INFO - Reading from file tmpfile_stdout 09:05:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:55 INFO - Reading from file tmpfile_stdout 09:05:55 INFO - Output received: 09:05:55 INFO - Usage: mozinstall [options] installer 09:05:55 INFO - Options: 09:05:55 INFO - -h, --help show this help message and exit 09:05:55 INFO - -d DEST, --destination=DEST 09:05:55 INFO - Directory to install application into. [default: 09:05:55 INFO - "/builds/slave/test"] 09:05:55 INFO - --app=APP Application being installed. [default: firefox] 09:05:55 INFO - mkdir: /builds/slave/test/build/application 09:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:06:29 INFO - Reading from file tmpfile_stdout 09:06:29 INFO - Output received: 09:06:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:06:29 INFO - Running post-action listener: _resource_record_post_action 09:06:29 INFO - [mozharness: 2016-08-09 16:06:29.971502Z] Finished install step (success) 09:06:29 INFO - [mozharness: 2016-08-09 16:06:29.971673Z] Running run-tests step. 09:06:29 INFO - Running pre-action listener: _resource_record_pre_action 09:06:29 INFO - Running main action method: run_tests 09:06:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:29 INFO - 2016-08-09 09:06:29.986 screenresolution[1649:8051] starting screenresolution argv=screenresolution get 09:06:29 INFO - 2016-08-09 09:06:29.988 screenresolution[1649:8051] Display 0: 1600x1200x32@60 09:06:29 INFO - 2016-08-09 09:06:29.994 screenresolution[1650:8053] starting screenresolution argv=screenresolution list 09:06:29 INFO - Available Modes on Display 0 09:06:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:30 INFO - Intel Iris: 09:06:30 INFO - Chipset Model: Intel Iris 09:06:30 INFO - Type: GPU 09:06:30 INFO - Bus: Built-In 09:06:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:30 INFO - Vendor: Intel (0x8086) 09:06:30 INFO - Device ID: 0x0a2e 09:06:30 INFO - Revision ID: 0x0009 09:06:30 INFO - Displays: 09:06:30 INFO - Display: 09:06:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:30 INFO - Display Serial Number: 1600x1200 60 09:06:30 INFO - Main Display: Yes 09:06:30 INFO - Mirror: Off 09:06:30 INFO - Online: Yes 09:06:30 INFO - Rotation: Supported 09:06:30 INFO - Return code: 0 09:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:30 INFO - Python 2.7.3 09:06:30 INFO - Return code: 0 09:06:30 INFO - grabbing minidump binary from tooltool 09:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:30 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 0x1042f8d30>, '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 0x10405ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042f0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:06:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:06:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:06:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:30 INFO - Return code: 0 09:06:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:06:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sxc8twLeEP/Render', 09:06:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:30 INFO - 'HOME': '/Users/cltbld', 09:06:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:30 INFO - 'LOGNAME': 'cltbld', 09:06:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:30 INFO - 'MOZ_NO_REMOTE': '1', 09:06:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:30 INFO - 'NO_EM_RESTART': '1', 09:06:30 INFO - 'PAGER': '/bin/cat', 09:06:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:30 INFO - 'PWD': '/builds/slave/test', 09:06:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:30 INFO - 'SHELL': '/bin/bash', 09:06:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXg9w3uhIK/Listeners', 09:06:30 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 09:06:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:30 INFO - 'USER': 'cltbld', 09:06:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:30 INFO - 'XPC_FLAGS': '0x0', 09:06:30 INFO - 'XPC_SERVICE_NAME': '0', 09:06:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:06:30 INFO - mozversion application_buildid: 20160809064419 09:06:30 INFO - mozversion application_changeset: 0813514a828bf931605bd22596d8fe876c1bb368 09:06:30 INFO - mozversion application_display_name: Nightly 09:06:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:30 INFO - mozversion application_name: Firefox 09:06:30 INFO - mozversion application_remotingname: firefox 09:06:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:06:30 INFO - mozversion application_vendor: Mozilla 09:06:30 INFO - mozversion application_version: 51.0a1 09:06:30 INFO - mozversion platform_buildid: 20160809064419 09:06:30 INFO - mozversion platform_changeset: 0813514a828bf931605bd22596d8fe876c1bb368 09:06:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:06:30 INFO - mozversion platform_version: 51.0a1 09:06:30 INFO - using testdate: 1470758790 09:06:30 INFO - actual date: 1470758790 09:06:30 INFO - starting webserver on 'localhost:49271' 09:06:30 INFO - SUITE-START | Running 2 tests 09:06:30 INFO - TEST-START | dromaeo_css 09:06:30 INFO - operating with platform_type : mac_ 09:06:30 INFO - Initialising browser for dromaeo_css test... 09:06:30 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp3WYAG4/profile http://localhost:49271/getInfo.html) 09:06:33 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:06:33 INFO - PROCESS | 1660 | colorDepth:24 09:06:33 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:06:33 INFO - PROCESS | 1660 | __metrics 09:06:33 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:06:34 INFO - TEST-INFO | 1660: exit 0 09:06:34 INFO - Browser initialized. 09:06:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:34 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp3WYAG4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:46 INFO - PROCESS | 1664 | RSS: Main: 254672896 09:06:46 INFO - PROCESS | 1664 | 09:07:35 INFO - PROCESS | 1664 | 1470758855988 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:09:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:09:50 INFO - PROCESS | 1664 | RSS: Main: 267821056 09:09:50 INFO - PROCESS | 1664 | 09:12:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:12:53 INFO - PROCESS | 1664 | RSS: Main: 280199168 09:12:53 INFO - PROCESS | 1664 | 09:15:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:15:55 INFO - PROCESS | 1664 | RSS: Main: 287404032 09:15:55 INFO - PROCESS | 1664 | 09:18:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 09:18:57 INFO - PROCESS | 1664 | RSS: Main: 286334976 09:18:57 INFO - PROCESS | 1664 | 09:22:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:22:01 INFO - PROCESS | 1664 | RSS: Main: 292339712 09:22:01 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:25:04 INFO - PROCESS | 1664 | RSS: Main: 292048896 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | __start_tp_report 09:25:04 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 09:25:04 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 09:25:04 INFO - PROCESS | 1664 | |i|pagename|runs| 09:25:04 INFO - PROCESS | 1664 | |0;dojo.html;3463.9653603463976;3477.530533377994;3486.4073107571703;3488.511608374826;3530.5586801649793;4897.265410188474;4964.783628011133;5680.147977803332;5897.941020589798;6036.969815150924;5946.494547963428;5948.31594366648;5988.341282458937;6008.789692360769;6036;5310.973445132789;5376.731163441812;5415.160650099241;5457.945420545803;5458.727063646822;5321.4412486688925;5327.600429967749;5388.757505912244;5423.267858839065;5431.728413579325;4903.289023091632;4974.801007959677;5379.058664733695;5382.4886635769535;5385.838424847222;5397.8380648580605;5399.352077750656;5429.918551221735;5436.320459942507;5480.958617862633;5168.896622067575;5272.499112584337;5351.384590772072;5352.5182733553775;5403.297571315704;5870.26621672291;6017.217761690952;6029.065494848305;6029.969850150765;6091.177691011745;6239.188905442309;6283.931731605638;6307.779227727054;6311.93688063118;6332.1135041094285;6215.067739839015;6254.186955695731;6285.622862628257;6362.809115726535;6368.617882927039;6099.408095342438;6134.1904138279315;6143.788236234952;6153.876922461525;6167.136600875881;6434.227892652912;6506.056621789814;6517.4134327910715;6522.641254731036;6523.934760652428;6163.84590385244;6213.409726076106;6225.128482012522;6285.685715714196;6302.338254483213;6319.431251187415;6336.461400780893;6344.048392741033;6356.173697419306;6372.6495042773095;6206.751729930752;6243.594166379171;6246.3753624637175;6255.499560035186;6260.624362538262;6145.863015342176;6176.66028368444;6207.224096987877;6241.812745617639;6248.4376406123665;4741.454732705714;5097.592192624581;5123.718195499283;5127.282180494733;5159;4049.8785036448953;4331.675124365685;4603.286490593963;4615.076984603093;4665.883352916204;5755.280589926259;5918.23063001807;6039.939600604026;6041.184440100618;6045.939540604626;5853.268341457318;6345.333739957238;6362.427381535684;6404.263509696351;6430.356964303533;5949.9107513387335;6075.513958883279;6110.877782444326;6112.327643959161;6121.724522396503;5495.368032676293;5545.390007099216;5587.720613969285;5637;5695.6297840641055;6509.934900651027;6519.282878883414;6539.771108011197;6552.213734351908;6554.14796076507;6327;6327.114204011534;6336.239651241881;6343.587666801828;6352.428281454691;6356.269029061717;6401.167848179707;6427.967860160669;6492.610443373413;6535.738570457129;6227.314995350598;6248.250209974832;6259.561830671809;6273.560850740587;6302.149209856794;5603.523700485504;6325.4939604832425;6341.8731625368155;6350.68246587678;6350.968245158745;5163.922541161961;6115.879294474783;6187.443130118131;6253.499720022478;6260.092286618324;6161.815145545641;6184.196054512884;6206.007038873759;6234.438900498977;6249.187605611241;4846.079244943449;5291.3385826771655;6197.81406557804;6241.282252540835;6266.624002559679;6117.64471673804;6193.597416167935;6211.81364559064;6245.875082498415;6268.655223962726;5101.69389836611;5146.845594632167;6114.38856114385;6139.062858969336;6175.907361389673 09:25:04 INFO - PROCESS | 1664 | |1;ext.html;445.55667111224335;504.90659228042813;527.9155335146374;540.7863893761964;558.4973523828556;30542.69457305426;35448.2910341793;41857;42001.57998420015;42154.36768448468;42452.78773606128;42764.358534622006;43100.568994310044;43231.56768432315;43284.134317313714;9497.525123743802;9687.418754874694;9697.563609637547;9708.854367184498;9719.319647624669;9616.855747163798;9628.374155679858;9638.710838674851;9690.46702431366;9693.079157480028;9679.95160024199;9688.321817472779;9696.46669433181;9756.268279879003;9768.951155244215;9679.322447428684;9723.076307750753;9725.416475011521;9730.610775568968;9733.756656083584;9616.567254473566;9652.179564736936;9682.419054856731;9700.27247956399;9705.902940970642;40759.388609170885;40905.79547102275;41280;41321.96695082647;41322.38016429756;3373.7469689773366;3470.201853573667;3474.166200111955;3621;3945.6448919597374;32087.037388878136;33196.834015830005;33321.33357332864;33335.333293334;33348;3140.105070055023;3157.6684448132846;3286.457734473809;3302.6036875574846;3315.419801534722;490009;494883;498025;498386;498707;61958.69020654868;62143.37856621376;62447.375526244155;62518;62639;65438;66305.33694662992;66344.00483992744;66535.66732166309;66587;15922.920385397998;15963.122028288324;16131.112788796494;16140.75788863168;16241;12494.250344979331;12500.749985000431;12523.311217883103;12551.686207844694;12560.623181304576;17248.913755431142;18102.637947240983;18116.456506304832;18116.64125190616;18154;5530.5022547970875;6500.967495162494;6520.673966301666;6591.274959754423;6592.637404942679;867.5835598912557;878.4070752242211;958.1903291718487;1002.2683441087901;1010.5099026971913;29835;30249;30331;30426.84786576053;30505.38989220203;1029.5881647340973;1045.8065257927155;1077.6443773554709;1115.5426275227119;1120.6077872744474;14408.495702650356;15609.765853512206;15880.203368287359;15880.761788573182;15961.680766384607;654267;667407;669044;669470;669822;59625.40374596199;59763;60656;60984.780304393666;61024.084638730455;1316.8683131686946;1367.589723083071;1374.4364810427676;1381.095382524448;1399.9160050396806;28422.86308547635;29485.85257073701;29498.262543436587;31996;32243;51709.48290517197;52090.47909521008;52525.212121818964;52592.68518287074;52622.47377526176;529770;547815;551437;555392;557506;24549.38626534351;24653.38366540851;25390.873045634653;26335.34161645974;26758.866205668848;46600.83497912444;46748.7662561685;48158.5184148154;48580;48631.02737945292;40687.1862562753;40846.79576602098;41071.589284106776;41908;42360.576394235664;39670.404943925285;40026.39960400655;40770.9807254821;41089.58910410977;41263;38323.233535329695;38450;38731.22537549177;38817;39507.60492395039;35386.646133538336;35530.467042993856;35749;35944.460833087;35986.820065899505;24259.878700606383;26214.60678089792;26452.206433807016;26633.60049599219;26767.464650707265 09:25:04 INFO - PROCESS | 1664 | |2;jquery.html;342.83715235263253;372.1069433359936;376.54626175458577;377.44138674761336;398.8962869653891;20193.52626321362;21340.4664883378;21568.784312156873;22127.446813829643;22337.776622233774;21190.25834095807;21423.892880535615;21455.785442145574;21638.459038524044;21720.674189887166;5776.989026920293;5786.768529258835;5915.349311575723;5985.760569577212;6003.609765365259;4134.359174327984;5828.358880523139;5922.170896074553;6312.873742525147;6588.439982601484;6620.6358650274215;6638.4689224861895;6641;6663.200415950093;6669.566478178927;6385.968070159643;6610.173728283965;6630.9668451657435;6637.435817955456;6640;5143.3570803649545;5447.5641948644015;5646.350669672999;5759.395263497357;5764.596478246524;13261.86738132616;13389.19664820114;13408.994325425534;13494.52769153075;13509.729805403837;2121.6817477378363;2136.818370438499;2261.1746712450004;2583.5866261398273;2864.8854045838143;9823.017698230191;10051.145652619536;10142.442165680885;10195.98040195982;10346.32748871321;1769.566456218222;1779.0482092080674;1806.97289540657;1883.2655264446876;1916.9808301916942;114502;116371.41814290959;121109.39445302806;122273.99999999911;122450;10921.890781092246;11112.277387075259;11316.321020738618;11339.603113890975;11538.826917596243;13880.722385552232;13894.513692020731;13925.816305614137;13932.721345573033;13934;8092.959535202286;8246.670133194604;8346.207110324509;8440.62017209227;8474.703385381483;6756.2568117507035;8308.70919517814;8324.6670133194;8434.367422443342;8490.23587877094;4371.30059190528;4373.606375426227;4425.424694789721;4462.553744625511;4501.617362524222;1588.4440445843861;1660.6844699507296;1675.5894805772664;1914.5692219250557;1979.1786408640542;920.2637889688223;945.5036106044245;992.9602815887428;1010.757418219622;1021.4504596527157;20675.793242067688;21805.824279406534;22165;22273;23737.7626223739;827.7227128911761;923.196818767663;944.40502483435;945.7871978804851;1038.46000079958;9969.700908972742;11141.275817071864;11738.119641026957;11818.940905295418;11877.22798018126;493193;570232;578709.9580518886;588792;591490;134477;135485.64514354928;136731.31634341765;140591;143478;1044.770150566874;1057.2757661002238;1080.8216644253766;1083.588236470152;1086.1256688365784;17070.231839567;19660.90169549143;19718.507037324183;19848.305309314106;19928.202871885544;56872.146917797094;57368.426315737976;57975;58106;58998;78265.60867195627;80987.59506202431;83179.5841020791;83766;85768.14231857602;6908.516403851682;7317.15852676949;8045.477043992122;8270.545120018456;8351.20663536963;11023.61417350389;11872.347020913932;12914.09601327898;13448.529301474793;13491.86508134906;11124.700454414678;11287.927646873533;11655;11689.88310116922;11727.472263748323;10745.301555398873;11021.173411993972;11156.44217789091;11284.379359134999;11608.30350178992;11376.431178441211;11457.942710286396;11646.650600481998;11826.93557579822;11948.940255298668;8017.879731804144;8198.754037378889;8206.671733130846;8335.874656921238;8446.408751387344;8257.00915890073;11106.666799996014;11211.943940280247;11436.199466037298;11676.766464670829 09:25:04 INFO - PROCESS | 1664 | |3;mootools.html;1503.676709507456;1533.2793587014103;1715.3138744502198;1796.8141026922233;1832.8442082422994;7851.018622672166;8385.2872505837;8432.53621050842;8894.288456923447;8907.15382038707;8545.359098067638;8654.870176947335;8693.652253909851;8696.521691306976;8722.520261385622;1980.2870966452138;2071.7203177570987;2227.5433536125056;2326.1742081561056;2353.95292094158;2314.780095890888;2318.211807985285;2368.1829768729845;2369.407648087978;2374.82188835838;1978.7526559180103;2347.401412639783;2369.609014512603;2373.2880135959144;2380.547695937766;2286.142696488817;2316.224064938248;2329.010170677464;2332.7550607186254;2333.7782910623464;1936.5545924437458;2345.5074434368803;2347.5891718949288;2347.97652023481;2350.059976009593;8755.956220218923;8812.647494100229;8850.114988501162;8879.067697891758;8886.155815197546;5205.635605507616;5340.332458442695;5342.866428339323;5345.866353341159;5360.678359298455;3487.877924272638;3540.030362643223;3618.0773902654655;3658.4878117063367;3674.7978861162624;1045.900639439252;1077.6766969908997;1083.5286650307141;1090.7436752363187;1102.4510562659477;11373.090152787758;11541;11558.942205289004;11627.360495172763;11671.649850504498;4521.570450807168;4605.654575906753;4766.809327626856;4769.284607308931;4774.7135171889795;9723.319367644339;9750.463724495079;9825.606975721033;9866.125436167105;9873.555689993967;5200.453952335026;5243.344581927259;5245.895082098336;5272.393674727378;5315.3621565412395;4354.825806967686;4697;4802.327674125625;4818.301346304766;4832.95167048325;3907.1013666856784;3930.6265904739003;4015.678745700337;4044.676425885922;4074.9185016299507;1276.8020956751718;1287.8261434706194;1291.063978615515;1296.1898813241723;1304.4325718312564;811.2131232704268;921.635953798246;927.9350445468752;936.1106948398912;975.5268694683073;5717.456841600041;5946.821595352147;5978.760849566055;6030.879382412327;6073.939260607426;411.5740208883791;422.1325176761784;424.65815018909456;430.9827606895752;435.5753140687804;3904.39481880309;3964.365701487748;3977.065389633434;4081.6326530611796;4091.2840252956207;10267.71653543307;10709.78580428387;10712.089472394779;10725.83911241332;10729.517171727291;10560.366378017343;10653.680389588324;10659.253852230424;10675.985781350759;10689.786204275872;6415.615063096229;6960.408365289007;7882.448228623941;8144.592770361458;8260.132686067996;5464.754086066057;5792.681402522901;6038.728257228523;6134.4172303631085;6168.784092556739;8193.303569196685;9500.524973751422;9962;10122.544485498318;10127.594896204364;8695.565221739014;9990.000999900243;10037.397756134655;10067.345622534805;10184.134348580454;7452.292032256927;7489.962550187214;7538.698452061856;7593.1647518774;7646.235376462309;8144.5520496373265;8240.011198656199;8290.87563686533;8337.416380853281;8341.582920853813;7509.66206520697;7593.354564862048;7639.732609358646;7689.8462030757955;7759.650815713419;7343.77968660941;7456.9254307458405;7504.737334193277;7517.699292028257;7653.540787552764;5967.731452084753;7035.964820175866;7095.964520177573;7102.289771022856;7111.395531379684;4772.164871147605;4973.229149481836;4987.326710893983;5010.3737032870895;5120.974395128001;4968.875778105432;5044.722540260321;5150.819721309736;5168.922466162935;5214.97392513035 09:25:04 INFO - PROCESS | 1664 | |4;prototype.html;257.6058630295647;293.7488447377494;309.97553087047305;311.67741387663773;313.20602273237347;5537.335519737637;5665.716714164296;5713.028785106531;5752.683602401867;5782.653040817549;5611.635243709156;5667.489925906668;5715.7420270445755;5722.6280291781;5752.252207213067;3840.6543411093;4367.061081867398;4387.749491394945;4408.933865991997;4411.205982923088;4025.396190571423;4292.871213863574;4361.60745532902;4362.323839804835;4365.668471116308;3828.8659896903614;4136.91726165478;4254.765987870666;4273.764942928137;4284.785760711968;4135.813888375;4253.2131555662145;4253.766042867641;4307.892302692427;4355.172517221749;3091.30445649727;3265.7713960022807;3550.289942011608;3689.5572531296148;3706.054955986206;4320.546342634041;5098.694078355274;5484.314460692413;5493.697846618435;5536.695481748502;4093.8771836844944;4282.892927676802;4685.789139488731;4916.558409113635;4944.258361245842;5072.568831649277;5193.896122077537;5209.322788037569;5975.163477113208;5995.970020149872;4027.3153563893916;4042.4542686737504;4044.1507283470505;4080.7347522410946;4083.2650122977852;5600.299962504687;5822.505087067562;5897.997340452091;5902.170327198539;6335.081413195107;3676.485292059114;3712.1462063724953;4072.775997320176;4078.286299897565;4086.2644723949975;3285.4743241081314;3646.2889736501656;3790.8104594770152;4111.71218014742;4122.876313710593;4853.2720091985775;4876.366072410564;4894.95105048945;4916.959461823303;4922.987764971536;4800.623691272773;5626.856304144752;6053.213082299361;6091.390860913873;6111.84720381994;1142.611512085878;1291.773939560592;1299.616613099138;1368.9110207836459;1414.2080434956458;825.7646281406267;832.3008672714949;839.366278459759;857.3012994409536;863.8531449653574;3794.829232684536;3898.335564569296;4237.944596870515;4694.413198350207;4696.600788932979;4434.490033646108;4899.681520701143;5106.412762532356;5120.539151476385;5194.0910340690225;3960.821763020671;4387.407699960529;4656.3946686930485;4753.47711751707;4777.140114779304;2420.6853109095705;2426.344886880532;2652.2706255779817;2729.9489696466608;2749.6866276137207;5310.459966609717;5382.730863456812;5397;5406.945930540723;5449.719315960746;5117.746152192736;5273.419923808378;5323.201519772065;5403.729813509309;5454.372747134051;6378.394052564999;6441.774537891245;6450.7097180627925;6462.967685161544;6536.901946470807;5837.153612726216;6259.967105427736;6278.4035516625845;6309.684515774101;6360.900902702189;5761.0124507045;6052.969735151296;6059.697015149313;6077.6353418795015;6179.721912514037;5391.433899440659;6008.609440386361;6124.989376752786;6457.225132984072;6497.025446182921;3946.171304026072;4038.1721747041197;4060.7766572837595;4083.8774836754947;4107.774072426046;4906.252498600795;5093.439721630692;5517.806876759294;5904.409559044061;6026.939730602638;5135.281060651587;5847.035239185487;6073.514118870568;6145.201123853871;6173.580076582321;5558.972205138948;6082.939170608237;6124.724387402489;6126.702486567538;6174.598651087665;5204.791808327776;5448.346198456211;5941.405859414024;5946.554008449297;5994.250718660168;6097.512199024156;6122.969385153046;6128.84364552247;6152.50779937595;6152.969235153795;5247.475252474722;5682.5453963681975;5857.941420585739;6011.489023433057;6015.293118096962 09:25:04 INFO - PROCESS | 1664 | |5;yui.html;637.7225906730573;698.6787362512478;715.6278735057767;784.5724080376194;827.2430725885815;14116.658917402856;14748.705025899475;15261.389544418224;15736.527904162893;15931.840681593181;13924;14081.859181408183;14223.857761422383;14282.143071415723;14395.06432081914;776.3090849144266;877.1097336203742;885.4731434796286;885.9601317940708;887.7514295997131;706.5230969095866;855.9400841941035;881.823635272948;887.5961437545933;888.6267767537618;818.8526065308242;898.1467605774508;899.2131884600974;941.0824446165003;945.654835984864;897.5063714956813;900.5497251374313;938.9718308450791;943.7923656795494;944.6740874398322;663.9933600663979;668.7692746002622;693.4175292754111;697.504771612156;699.1330749870175;14580.854191458056;14775.261236938217;15050.172240526766;15114.546563603;15184.696306073927;14568.271586420637;14753.77869331961;14973.775393369107;14979.101253924691;15035.398584056624;12009.459574319177;12313.69215769604;12527.123101382907;12562.120651554394;12588.68528286791;3346.247094403764;3533.2403533240476;3635.4365073413665;3785.299719551892;3797.7341586088983;112268.43865780701;113455;113913;114589;116855.8314416862;8576.785580360416;10336.689899303034;10432.061114499731;10458.52936617854;10854.240203185858;21557.461063473223;21732.78267217339;21836.23573174931;21871.562568748537;22392.992315345524;8066.798330041678;8120.472169308976;8136.023677158779;8201.71294004719;8218.712345067894;4384.101259241847;4415.580519850609;4453.821847126079;4501.954980450219;4531.864044078683;3879.4180872868733;4104.343305071175;4124.360724087711;4124.835006599762;4154.979225103855;710.1123595505618;715.2525610736689;719.6114098386812;723.8081908294306;728.661172554754;638.8402899275181;643.2120652201016;684.5037347922716;689.2074114768056;692.6121372031679;9186.26509879208;9787.657431989846;9904.603815847286;10000.0999910007;10053.497325133714;577.7515668262604;654.6366766444573;663.4791688524485;681.1213534540486;699.2029086841005;4483.686141970031;4807.663463557587;4894.898647804287;4897.436794768647;4901.58336541398;91275.54362228146;114291.42854285675;176663.11668441576;177802;182490.08754956405;139381;148722.25638871736;151011;154791;155175.44824551835;88817.55591222002;99284;105221;124081.13878291832;131642;9328.440293582407;9337.53312334367;9347.439153650803;9378.577963991773;9419.340646154977;66207.34481637998;66296;66744.97326176635;67115.66442167954;67951;98635.01364986545;100324;100477;100710.99289007016;102454.97545024753;11999.700007499883;12106.273623582612;12127.090468214743;12184.756304873676;12305;10959.726006849893;13549;13570.347277387204;13717.725645487233;13763.31183440844;12549;12708.618741437771;12733.426995785398;12868.806967895302;13091.803622945854;11655.941720291345;12454.439550220442;12574.308413037004;12922;12989.740205196033;12162.331071791137;12201.145919785884;12295.44670489848;12377.167271101252;12668;10219.948900255451;10407.011333923265;10476.584832898314;10525.263231574023;10808.729781755519;10551.472426378497;10587.682369528926;10822.40476773785;10854.945725271324;10866.239363244496 09:25:04 INFO - PROCESS | 1664 | __end_tp_report 09:25:04 INFO - PROCESS | 1664 | __start_cc_report 09:25:04 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,411 09:25:04 INFO - PROCESS | 1664 | __end_cc_report 09:25:04 INFO - PROCESS | 1664 | __startTimestamp1470759904341__endTimestamp 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | ------- Summary: start ------- 09:25:04 INFO - PROCESS | 1664 | Number of tests: 6 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5850.38 Median:6139.06 stddev:664.80 (10.8%) stddev-sans-first:639.94 09:25:04 INFO - PROCESS | 1664 | Values: 3464.0 3477.5 3486.4 3488.5 3530.6 4897.3 4964.8 5680.1 5897.9 6037.0 5946.5 5948.3 5988.3 6008.8 6036.0 5311.0 5376.7 5415.2 5457.9 5458.7 5321.4 5327.6 5388.8 5423.3 5431.7 4903.3 4974.8 5379.1 5382.5 5385.8 5397.8 5399.4 5429.9 5436.3 5481.0 5168.9 5272.5 5351.4 5352.5 5403.3 5870.3 6017.2 6029.1 6030.0 6091.2 6239.2 6283.9 6307.8 6311.9 6332.1 6215.1 6254.2 6285.6 6362.8 6368.6 6099.4 6134.2 6143.8 6153.9 6167.1 6434.2 6506.1 6517.4 6522.6 6523.9 6163.8 6213.4 6225.1 6285.7 6302.3 6319.4 6336.5 6344.0 6356.2 6372.6 6206.8 6243.6 6246.4 6255.5 6260.6 6145.9 6176.7 6207.2 6241.8 6248.4 4741.5 5097.6 5123.7 5127.3 5159.0 4049.9 4331.7 4603.3 4615.1 4665.9 5755.3 5918.2 6039.9 6041.2 6045.9 5853.3 6345.3 6362.4 6404.3 6430.4 5949.9 6075.5 6110.9 6112.3 6121.7 5495.4 5545.4 5587.7 5637.0 5695.6 6509.9 6519.3 6539.8 6552.2 6554.1 6327.0 6327.1 6336.2 6343.6 6352.4 6356.3 6401.2 6428.0 6492.6 6535.7 6227.3 6248.3 6259.6 6273.6 6302.1 5603.5 6325.5 6341.9 6350.7 6351.0 5163.9 6115.9 6187.4 6253.5 6260.1 6161.8 6184.2 6206.0 6234.4 6249.2 4846.1 5291.3 6197.8 6241.3 6266.6 6117.6 6193.6 6211.8 6245.9 6268.7 5101.7 5146.8 6114.4 6139.1 6175.9 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:70866.60 Median:41322.17 stddev:153501.37 (371.5%) stddev-sans-first:153840.92 09:25:04 INFO - PROCESS | 1664 | Values: 445.6 504.9 527.9 540.8 558.5 30542.7 35448.3 41857.0 42001.6 42154.4 42452.8 42764.4 43100.6 43231.6 43284.1 9497.5 9687.4 9697.6 9708.9 9719.3 9616.9 9628.4 9638.7 9690.5 9693.1 9680.0 9688.3 9696.5 9756.3 9769.0 9679.3 9723.1 9725.4 9730.6 9733.8 9616.6 9652.2 9682.4 9700.3 9705.9 40759.4 40905.8 41280.0 41322.0 41322.4 3373.7 3470.2 3474.2 3621.0 3945.6 32087.0 33196.8 33321.3 33335.3 33348.0 3140.1 3157.7 3286.5 3302.6 3315.4 490009.0 494883.0 498025.0 498386.0 498707.0 61958.7 62143.4 62447.4 62518.0 62639.0 65438.0 66305.3 66344.0 66535.7 66587.0 15922.9 15963.1 16131.1 16140.8 16241.0 12494.3 12500.7 12523.3 12551.7 12560.6 17248.9 18102.6 18116.5 18116.6 18154.0 5530.5 6501.0 6520.7 6591.3 6592.6 867.6 878.4 958.2 1002.3 1010.5 29835.0 30249.0 30331.0 30426.8 30505.4 1029.6 1045.8 1077.6 1115.5 1120.6 14408.5 15609.8 15880.2 15880.8 15961.7 654267.0 667407.0 669044.0 669470.0 669822.0 59625.4 59763.0 60656.0 60984.8 61024.1 1316.9 1367.6 1374.4 1381.1 1399.9 28422.9 29485.9 29498.3 31996.0 32243.0 51709.5 52090.5 52525.2 52592.7 52622.5 529770.0 547815.0 551437.0 555392.0 557506.0 24549.4 24653.4 25390.9 26335.3 26758.9 46600.8 46748.8 48158.5 48580.0 48631.0 40687.2 40846.8 41071.6 41908.0 42360.6 39670.4 40026.4 40771.0 41089.6 41263.0 38323.2 38450.0 38731.2 38817.0 39507.6 35386.6 35530.5 35749.0 35944.5 35986.8 24259.9 26214.6 26452.2 26633.6 26767.5 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34466.95 Median:21763.25 stddev:95187.03 (437.4%) stddev-sans-first:95419.57 09:25:04 INFO - PROCESS | 1664 | Values: 342.8 372.1 376.5 377.4 398.9 20193.5 21340.5 21568.8 22127.4 22337.8 21190.3 21423.9 21455.8 21638.5 21720.7 5777.0 5786.8 5915.3 5985.8 6003.6 4134.4 5828.4 5922.2 6312.9 6588.4 6620.6 6638.5 6641.0 6663.2 6669.6 6386.0 6610.2 6631.0 6637.4 6640.0 5143.4 5447.6 5646.4 5759.4 5764.6 13261.9 13389.2 13409.0 13494.5 13509.7 2121.7 2136.8 2261.2 2583.6 2864.9 9823.0 10051.1 10142.4 10196.0 10346.3 1769.6 1779.0 1807.0 1883.3 1917.0 114502.0 116371.4 121109.4 122274.0 122450.0 10921.9 11112.3 11316.3 11339.6 11538.8 13880.7 13894.5 13925.8 13932.7 13934.0 8093.0 8246.7 8346.2 8440.6 8474.7 6756.3 8308.7 8324.7 8434.4 8490.2 4371.3 4373.6 4425.4 4462.6 4501.6 1588.4 1660.7 1675.6 1914.6 1979.2 920.3 945.5 993.0 1010.8 1021.5 20675.8 21805.8 22165.0 22273.0 23737.8 827.7 923.2 944.4 945.8 1038.5 9969.7 11141.3 11738.1 11818.9 11877.2 493193.0 570232.0 578710.0 588792.0 591490.0 134477.0 135485.6 136731.3 140591.0 143478.0 1044.8 1057.3 1080.8 1083.6 1086.1 17070.2 19660.9 19718.5 19848.3 19928.2 56872.1 57368.4 57975.0 58106.0 58998.0 78265.6 80987.6 83179.6 83766.0 85768.1 6908.5 7317.2 8045.5 8270.5 8351.2 11023.6 11872.3 12914.1 13448.5 13491.9 11124.7 11287.9 11655.0 11689.9 11727.5 10745.3 11021.2 11156.4 11284.4 11608.3 11376.4 11457.9 11646.7 11826.9 11948.9 8017.9 8198.8 8206.7 8335.9 8446.4 8257.0 11106.7 11211.9 11436.2 11676.8 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5657.37 Median:4900.91 stddev:3177.80 (64.8%) stddev-sans-first:3171.39 09:25:04 INFO - PROCESS | 1664 | Values: 1503.7 1533.3 1715.3 1796.8 1832.8 7851.0 8385.3 8432.5 8894.3 8907.2 8545.4 8654.9 8693.7 8696.5 8722.5 1980.3 2071.7 2227.5 2326.2 2354.0 2314.8 2318.2 2368.2 2369.4 2374.8 1978.8 2347.4 2369.6 2373.3 2380.5 2286.1 2316.2 2329.0 2332.8 2333.8 1936.6 2345.5 2347.6 2348.0 2350.1 8756.0 8812.6 8850.1 8879.1 8886.2 5205.6 5340.3 5342.9 5345.9 5360.7 3487.9 3540.0 3618.1 3658.5 3674.8 1045.9 1077.7 1083.5 1090.7 1102.5 11373.1 11541.0 11558.9 11627.4 11671.6 4521.6 4605.7 4766.8 4769.3 4774.7 9723.3 9750.5 9825.6 9866.1 9873.6 5200.5 5243.3 5245.9 5272.4 5315.4 4354.8 4697.0 4802.3 4818.3 4833.0 3907.1 3930.6 4015.7 4044.7 4074.9 1276.8 1287.8 1291.1 1296.2 1304.4 811.2 921.6 927.9 936.1 975.5 5717.5 5946.8 5978.8 6030.9 6073.9 411.6 422.1 424.7 431.0 435.6 3904.4 3964.4 3977.1 4081.6 4091.3 10267.7 10709.8 10712.1 10725.8 10729.5 10560.4 10653.7 10659.3 10676.0 10689.8 6415.6 6960.4 7882.4 8144.6 8260.1 5464.8 5792.7 6038.7 6134.4 6168.8 8193.3 9500.5 9962.0 10122.5 10127.6 8695.6 9990.0 10037.4 10067.3 10184.1 7452.3 7490.0 7538.7 7593.2 7646.2 8144.6 8240.0 8290.9 8337.4 8341.6 7509.7 7593.4 7639.7 7689.8 7759.7 7343.8 7456.9 7504.7 7517.7 7653.5 5967.7 7036.0 7096.0 7102.3 7111.4 4772.2 4973.2 4987.3 5010.4 5121.0 4968.9 5044.7 5150.8 5168.9 5215.0 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4685.54 Median:5127.91 stddev:1501.11 (29.3%) stddev-sans-first:1468.07 09:25:04 INFO - PROCESS | 1664 | Values: 257.6 293.7 310.0 311.7 313.2 5537.3 5665.7 5713.0 5752.7 5782.7 5611.6 5667.5 5715.7 5722.6 5752.3 3840.7 4367.1 4387.7 4408.9 4411.2 4025.4 4292.9 4361.6 4362.3 4365.7 3828.9 4136.9 4254.8 4273.8 4284.8 4135.8 4253.2 4253.8 4307.9 4355.2 3091.3 3265.8 3550.3 3689.6 3706.1 4320.5 5098.7 5484.3 5493.7 5536.7 4093.9 4282.9 4685.8 4916.6 4944.3 5072.6 5193.9 5209.3 5975.2 5996.0 4027.3 4042.5 4044.2 4080.7 4083.3 5600.3 5822.5 5898.0 5902.2 6335.1 3676.5 3712.1 4072.8 4078.3 4086.3 3285.5 3646.3 3790.8 4111.7 4122.9 4853.3 4876.4 4895.0 4917.0 4923.0 4800.6 5626.9 6053.2 6091.4 6111.8 1142.6 1291.8 1299.6 1368.9 1414.2 825.8 832.3 839.4 857.3 863.9 3794.8 3898.3 4237.9 4694.4 4696.6 4434.5 4899.7 5106.4 5120.5 5194.1 3960.8 4387.4 4656.4 4753.5 4777.1 2420.7 2426.3 2652.3 2729.9 2749.7 5310.5 5382.7 5397.0 5406.9 5449.7 5117.7 5273.4 5323.2 5403.7 5454.4 6378.4 6441.8 6450.7 6463.0 6536.9 5837.2 6260.0 6278.4 6309.7 6360.9 5761.0 6053.0 6059.7 6077.6 6179.7 5391.4 6008.6 6125.0 6457.2 6497.0 3946.2 4038.2 4060.8 4083.9 4107.8 4906.3 5093.4 5517.8 5904.4 6026.9 5135.3 5847.0 6073.5 6145.2 6173.6 5559.0 6082.9 6124.7 6126.7 6174.6 5204.8 5448.3 5941.4 5946.6 5994.3 6097.5 6123.0 6128.8 6152.5 6153.0 5247.5 5682.5 5857.9 6011.5 6015.3 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:25796.04 Median:22132.28 stddev:42583.37 (192.4%) stddev-sans-first:42660.93 09:25:04 INFO - PROCESS | 1664 | Values: 637.7 698.7 715.6 784.6 827.2 14116.7 14748.7 15261.4 15736.5 15931.8 13924.0 14081.9 14223.9 14282.1 14395.1 776.3 877.1 885.5 886.0 887.8 706.5 855.9 881.8 887.6 888.6 818.9 898.1 899.2 941.1 945.7 897.5 900.5 939.0 943.8 944.7 664.0 668.8 693.4 697.5 699.1 14580.9 14775.3 15050.2 15114.5 15184.7 14568.3 14753.8 14973.8 14979.1 15035.4 12009.5 12313.7 12527.1 12562.1 12588.7 3346.2 3533.2 3635.4 3785.3 3797.7 112268.4 113455.0 113913.0 114589.0 116855.8 8576.8 10336.7 10432.1 10458.5 10854.2 21557.5 21732.8 21836.2 21871.6 22393.0 8066.8 8120.5 8136.0 8201.7 8218.7 4384.1 4415.6 4453.8 4502.0 4531.9 3879.4 4104.3 4124.4 4124.8 4155.0 710.1 715.3 719.6 723.8 728.7 638.8 643.2 684.5 689.2 692.6 9186.3 9787.7 9904.6 10000.1 10053.5 577.8 654.6 663.5 681.1 699.2 4483.7 4807.7 4894.9 4897.4 4901.6 91275.5 114291.4 176663.1 177802.0 182490.1 139381.0 148722.3 151011.0 154791.0 155175.4 88817.6 99284.0 105221.0 124081.1 131642.0 9328.4 9337.5 9347.4 9378.6 9419.3 66207.3 66296.0 66745.0 67115.7 67951.0 98635.0 100324.0 100477.0 100711.0 102455.0 11999.7 12106.3 12127.1 12184.8 12305.0 10959.7 13549.0 13570.3 13717.7 13763.3 12549.0 12708.6 12733.4 12868.8 13091.8 11655.9 12454.4 12574.3 12922.0 12989.7 12162.3 12201.1 12295.4 12377.2 12668.0 10219.9 10407.0 10476.6 10525.3 10808.7 10551.5 10587.7 10822.4 10854.9 10866.2 09:25:04 INFO - PROCESS | 1664 | -------- Summary: end -------- 09:25:04 INFO - PROCESS | 1664 | 09:25:04 INFO - TEST-INFO | 1664: exit 0 09:25:04 INFO - TEST-OK | dromaeo_css | took 1114377ms 09:25:04 INFO - TEST-START | kraken 09:25:04 INFO - operating with platform_type : mac_ 09:25:04 INFO - Initialising browser for kraken test... 09:25:04 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpLMsFuu/profile http://localhost:49271/getInfo.html) 09:25:07 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 09:25:07 INFO - PROCESS | 1672 | colorDepth:24 09:25:07 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 09:25:07 INFO - PROCESS | 1672 | __metrics 09:25:07 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:25:08 INFO - TEST-INFO | 1672: exit 0 09:25:08 INFO - Browser initialized. 09:25:08 INFO - Running cycle 1/1 for kraken test... 09:25:08 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpLMsFuu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:20 INFO - PROCESS | 1674 | RSS: Main: 254763008 09:25:20 INFO - PROCESS | 1674 | 09:25:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:24 INFO - PROCESS | 1674 | RSS: Main: 267309056 09:25:24 INFO - PROCESS | 1674 | 09:25:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:25:27 INFO - PROCESS | 1674 | RSS: Main: 275955712 09:25:27 INFO - PROCESS | 1674 | 09:25:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:25:31 INFO - PROCESS | 1674 | RSS: Main: 278843392 09:25:31 INFO - PROCESS | 1674 | 09:25:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:25:33 INFO - PROCESS | 1674 | RSS: Main: 280268800 09:25:33 INFO - PROCESS | 1674 | 09:25:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:36 INFO - PROCESS | 1674 | RSS: Main: 280514560 09:25:36 INFO - PROCESS | 1674 | 09:25:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:40 INFO - PROCESS | 1674 | RSS: Main: 281948160 09:25:40 INFO - PROCESS | 1674 | 09:25:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:43 INFO - PROCESS | 1674 | RSS: Main: 281542656 09:25:43 INFO - PROCESS | 1674 | 09:25:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:25:47 INFO - PROCESS | 1674 | RSS: Main: 282279936 09:25:47 INFO - PROCESS | 1674 | 09:25:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:49 INFO - PROCESS | 1674 | RSS: Main: 281907200 09:25:49 INFO - PROCESS | 1674 | 09:25:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:52 INFO - PROCESS | 1674 | RSS: Main: 282140672 09:25:52 INFO - PROCESS | 1674 | 09:25:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:55 INFO - PROCESS | 1674 | RSS: Main: 282390528 09:25:55 INFO - PROCESS | 1674 | 09:25:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:58 INFO - PROCESS | 1674 | RSS: Main: 282132480 09:25:58 INFO - PROCESS | 1674 | 09:26:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:02 INFO - PROCESS | 1674 | RSS: Main: 282685440 09:26:02 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:26:04 INFO - PROCESS | 1674 | RSS: Main: 283860992 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | __start_tp_report 09:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 09:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 09:26:04 INFO - PROCESS | 1674 | |i|pagename|runs| 09:26:04 INFO - PROCESS | 1674 | |0;ai-astar;104;115;107;114;117;116;114;117;116;118 09:26:04 INFO - PROCESS | 1674 | |1;audio-beat-detection;148;111;136;155;113;143;131;111;157;113 09:26:04 INFO - PROCESS | 1674 | |2;audio-dft;226;282;215;220;226;189;200;201;197;195 09:26:04 INFO - PROCESS | 1674 | |3;audio-fft;70;84;75;143;58;58;61;65;145;60 09:26:04 INFO - PROCESS | 1674 | |4;audio-oscillator;70;73;126;73;72;74;112;73;102;138 09:26:04 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;87;90;129;127;86;93;87;90;86 09:26:04 INFO - PROCESS | 1674 | |6;imaging-darkroom;95;97;94;116;124;95;96;96;95;118 09:26:04 INFO - PROCESS | 1674 | |7;imaging-desaturate;91;95;83;146;148;119;93;129;131;151 09:26:04 INFO - PROCESS | 1674 | |8;json-parse-financial;54;52;56;84;86;57;56;57;54;56 09:26:04 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;66;70;71;77;79;65;97;62;84;103 09:26:04 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;85;85;83;82;105;86;86;89;79;85 09:26:04 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;139;138;135;148;123;161;172;173;164;176 09:26:04 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;168;167;170;167;170;172;145;203;211;223 09:26:04 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;67;68;66;71;74;86;87;64;78 09:26:04 INFO - PROCESS | 1674 | __end_tp_report 09:26:04 INFO - PROCESS | 1674 | __start_cc_report 09:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1044 09:26:04 INFO - PROCESS | 1674 | __end_cc_report 09:26:04 INFO - PROCESS | 1674 | __startTimestamp1470759964499__endTimestamp 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | ------- Summary: start ------- 09:26:04 INFO - PROCESS | 1674 | Number of tests: 14 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:113.80 Median:116.00 stddev:4.61 (4.0%) stddev-sans-first:3.26 09:26:04 INFO - PROCESS | 1674 | Values: 104.0 115.0 107.0 114.0 117.0 116.0 114.0 117.0 116.0 118.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:139.50 stddev:18.71 (13.4%) stddev-sans-first:18.91 09:26:04 INFO - PROCESS | 1674 | Values: 148.0 111.0 136.0 155.0 113.0 143.0 131.0 111.0 157.0 113.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:215.10 Median:217.50 stddev:27.03 (12.4%) stddev-sans-first:28.38 09:26:04 INFO - PROCESS | 1674 | Values: 226.0 282.0 215.0 220.0 226.0 189.0 200.0 201.0 197.0 195.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:81.90 Median:63.00 stddev:33.75 (53.6%) stddev-sans-first:35.52 09:26:04 INFO - PROCESS | 1674 | Values: 70.0 84.0 75.0 143.0 58.0 58.0 61.0 65.0 145.0 60.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:72.50 stddev:25.94 (35.8%) stddev-sans-first:26.35 09:26:04 INFO - PROCESS | 1674 | Values: 70.0 73.0 126.0 73.0 72.0 74.0 112.0 73.0 102.0 138.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:88.00 stddev:16.80 (19.1%) stddev-sans-first:17.61 09:26:04 INFO - PROCESS | 1674 | Values: 89.0 87.0 90.0 129.0 127.0 86.0 93.0 87.0 90.0 86.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:95.00 stddev:11.74 (12.4%) stddev-sans-first:12.13 09:26:04 INFO - PROCESS | 1674 | Values: 95.0 97.0 94.0 116.0 124.0 95.0 96.0 96.0 95.0 118.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:118.60 Median:117.00 stddev:26.18 (22.4%) stddev-sans-first:25.79 09:26:04 INFO - PROCESS | 1674 | Values: 91.0 95.0 83.0 146.0 148.0 119.0 93.0 129.0 131.0 151.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:56.50 stddev:12.65 (22.4%) stddev-sans-first:13.14 09:26:04 INFO - PROCESS | 1674 | Values: 54.0 52.0 56.0 84.0 86.0 57.0 56.0 57.0 54.0 56.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:74.00 stddev:13.75 (18.6%) stddev-sans-first:13.96 09:26:04 INFO - PROCESS | 1674 | Values: 66.0 70.0 71.0 77.0 79.0 65.0 97.0 62.0 84.0 103.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.00 stddev:7.03 (8.3%) stddev-sans-first:7.43 09:26:04 INFO - PROCESS | 1674 | Values: 85.0 85.0 83.0 82.0 105.0 86.0 86.0 89.0 79.0 85.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:162.50 stddev:18.69 (11.5%) stddev-sans-first:19.14 09:26:04 INFO - PROCESS | 1674 | Values: 139.0 138.0 135.0 148.0 123.0 161.0 172.0 173.0 164.0 176.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:171.00 stddev:24.29 (14.2%) stddev-sans-first:25.39 09:26:04 INFO - PROCESS | 1674 | Values: 168.0 167.0 170.0 167.0 170.0 172.0 145.0 203.0 211.0 223.0 09:26:04 INFO - PROCESS | 1674 | 09:26:04 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:72.50 stddev:8.24 (11.4%) stddev-sans-first:8.55 09:26:04 INFO - PROCESS | 1674 | Values: 68.0 67.0 68.0 66.0 71.0 74.0 86.0 87.0 64.0 78.0 09:26:04 INFO - PROCESS | 1674 | -------- Summary: end -------- 09:26:04 INFO - PROCESS | 1674 | 09:26:05 INFO - TEST-INFO | 1674: exit 0 09:26:05 INFO - TEST-OK | kraken | took 60603ms 09:26:05 INFO - SUITE-END | took 1174s 09:26:05 INFO - Completed test suite (00:19:35) 09:26:05 INFO - javascript benchmark 09:26:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.23975967726, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.9653603463976, 3477.530533377994, 3486.4073107571703, 3488.511608374826, 3530.5586801649793, 4897.265410188474, 4964.783628011133, 5680.147977803332, 5897.941020589798, 6036.969815150924, 5946.494547963428, 5948.31594366648, 5988.341282458937, 6008.789692360769, 6036.0, 5310.973445132789, 5376.731163441812, 5415.160650099241, 5457.945420545803, 5458.727063646822, 5321.4412486688925, 5327.600429967749, 5388.757505912244, 5423.267858839065, 5431.728413579325, 4903.289023091632, 4974.801007959677, 5379.058664733695, 5382.4886635769535, 5385.838424847222, 5397.8380648580605, 5399.352077750656, 5429.918551221735, 5436.320459942507, 5480.958617862633, 5168.896622067575, 5272.499112584337, 5351.384590772072, 5352.5182733553775, 5403.297571315704, 5870.26621672291, 6017.217761690952, 6029.065494848305, 6029.969850150765, 6091.177691011745, 6239.188905442309, 6283.931731605638, 6307.779227727054, 6311.93688063118, 6332.1135041094285, 6215.067739839015, 6254.186955695731, 6285.622862628257, 6362.809115726535, 6368.617882927039, 6099.408095342438, 6134.1904138279315, 6143.788236234952, 6153.876922461525, 6167.136600875881, 6434.227892652912, 6506.056621789814, 6517.4134327910715, 6522.641254731036, 6523.934760652428, 6163.84590385244, 6213.409726076106, 6225.128482012522, 6285.685715714196, 6302.338254483213, 6319.431251187415, 6336.461400780893, 6344.048392741033, 6356.173697419306, 6372.6495042773095, 6206.751729930752, 6243.594166379171, 6246.3753624637175, 6255.499560035186, 6260.624362538262, 6145.863015342176, 6176.66028368444, 6207.224096987877, 6241.812745617639, 6248.4376406123665, 4741.454732705714, 5097.592192624581, 5123.718195499283, 5127.282180494733, 5159.0, 4049.8785036448953, 4331.675124365685, 4603.286490593963, 4615.076984603093, 4665.883352916204, 5755.280589926259, 5918.23063001807, 6039.939600604026, 6041.184440100618, 6045.939540604626, 5853.268341457318, 6345.333739957238, 6362.427381535684, 6404.263509696351, 6430.356964303533, 5949.9107513387335, 6075.513958883279, 6110.877782444326, 6112.327643959161, 6121.724522396503, 5495.368032676293, 5545.390007099216, 5587.720613969285, 5637.0, 5695.6297840641055, 6509.934900651027, 6519.282878883414, 6539.771108011197, 6552.213734351908, 6554.14796076507, 6327.0, 6327.114204011534, 6336.239651241881, 6343.587666801828, 6352.428281454691, 6356.269029061717, 6401.167848179707, 6427.967860160669, 6492.610443373413, 6535.738570457129, 6227.314995350598, 6248.250209974832, 6259.561830671809, 6273.560850740587, 6302.149209856794, 5603.523700485504, 6325.4939604832425, 6341.8731625368155, 6350.68246587678, 6350.968245158745, 5163.922541161961, 6115.879294474783, 6187.443130118131, 6253.499720022478, 6260.092286618324, 6161.815145545641, 6184.196054512884, 6206.007038873759, 6234.438900498977, 6249.187605611241, 4846.079244943449, 5291.3385826771655, 6197.81406557804, 6241.282252540835, 6266.624002559679, 6117.64471673804, 6193.597416167935, 6211.81364559064, 6245.875082498415, 6268.655223962726, 5101.69389836611, 5146.845594632167, 6114.38856114385, 6139.062858969336, 6175.907361389673], "value": 5809.849615712294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.55667111224335, 504.90659228042813, 527.9155335146374, 540.7863893761964, 558.4973523828556, 30542.69457305426, 35448.2910341793, 41857.0, 42001.57998420015, 42154.36768448468, 42452.78773606128, 42764.358534622006, 43100.568994310044, 43231.56768432315, 43284.134317313714, 9497.525123743802, 9687.418754874694, 9697.563609637547, 9708.854367184498, 9719.319647624669, 9616.855747163798, 9628.374155679858, 9638.710838674851, 9690.46702431366, 9693.079157480028, 9679.95160024199, 9688.321817472779, 9696.46669433181, 9756.268279879003, 9768.951155244215, 9679.322447428684, 9723.076307750753, 9725.416475011521, 9730.610775568968, 9733.756656083584, 9616.567254473566, 9652.179564736936, 9682.419054856731, 9700.27247956399, 9705.902940970642, 40759.388609170885, 40905.79547102275, 41280.0, 41321.96695082647, 41322.38016429756, 3373.7469689773366, 3470.201853573667, 3474.166200111955, 3621.0, 3945.6448919597374, 32087.037388878136, 33196.834015830005, 33321.33357332864, 33335.333293334, 33348.0, 3140.105070055023, 3157.6684448132846, 3286.457734473809, 3302.6036875574846, 3315.419801534722, 490009.0, 494883.0, 498025.0, 498386.0, 498707.0, 61958.69020654868, 62143.37856621376, 62447.375526244155, 62518.0, 62639.0, 65438.0, 66305.33694662992, 66344.00483992744, 66535.66732166309, 66587.0, 15922.920385397998, 15963.122028288324, 16131.112788796494, 16140.75788863168, 16241.0, 12494.250344979331, 12500.749985000431, 12523.311217883103, 12551.686207844694, 12560.623181304576, 17248.913755431142, 18102.637947240983, 18116.456506304832, 18116.64125190616, 18154.0, 5530.5022547970875, 6500.967495162494, 6520.673966301666, 6591.274959754423, 6592.637404942679, 867.5835598912557, 878.4070752242211, 958.1903291718487, 1002.2683441087901, 1010.5099026971913, 29835.0, 30249.0, 30331.0, 30426.84786576053, 30505.38989220203, 1029.5881647340973, 1045.8065257927155, 1077.6443773554709, 1115.5426275227119, 1120.6077872744474, 14408.495702650356, 15609.765853512206, 15880.203368287359, 15880.761788573182, 15961.680766384607, 654267.0, 667407.0, 669044.0, 669470.0, 669822.0, 59625.40374596199, 59763.0, 60656.0, 60984.780304393666, 61024.084638730455, 1316.8683131686946, 1367.589723083071, 1374.4364810427676, 1381.095382524448, 1399.9160050396806, 28422.86308547635, 29485.85257073701, 29498.262543436587, 31996.0, 32243.0, 51709.48290517197, 52090.47909521008, 52525.212121818964, 52592.68518287074, 52622.47377526176, 529770.0, 547815.0, 551437.0, 555392.0, 557506.0, 24549.38626534351, 24653.38366540851, 25390.873045634653, 26335.34161645974, 26758.866205668848, 46600.83497912444, 46748.7662561685, 48158.5184148154, 48580.0, 48631.02737945292, 40687.1862562753, 40846.79576602098, 41071.589284106776, 41908.0, 42360.576394235664, 39670.404943925285, 40026.39960400655, 40770.9807254821, 41089.58910410977, 41263.0, 38323.233535329695, 38450.0, 38731.22537549177, 38817.0, 39507.60492395039, 35386.646133538336, 35530.467042993856, 35749.0, 35944.460833087, 35986.820065899505, 24259.878700606383, 26214.60678089792, 26452.206433807016, 26633.60049599219, 26767.464650707265], "value": 20158.202258076144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.83715235263253, 372.1069433359936, 376.54626175458577, 377.44138674761336, 398.8962869653891, 20193.52626321362, 21340.4664883378, 21568.784312156873, 22127.446813829643, 22337.776622233774, 21190.25834095807, 21423.892880535615, 21455.785442145574, 21638.459038524044, 21720.674189887166, 5776.989026920293, 5786.768529258835, 5915.349311575723, 5985.760569577212, 6003.609765365259, 4134.359174327984, 5828.358880523139, 5922.170896074553, 6312.873742525147, 6588.439982601484, 6620.6358650274215, 6638.4689224861895, 6641.0, 6663.200415950093, 6669.566478178927, 6385.968070159643, 6610.173728283965, 6630.9668451657435, 6637.435817955456, 6640.0, 5143.3570803649545, 5447.5641948644015, 5646.350669672999, 5759.395263497357, 5764.596478246524, 13261.86738132616, 13389.19664820114, 13408.994325425534, 13494.52769153075, 13509.729805403837, 2121.6817477378363, 2136.818370438499, 2261.1746712450004, 2583.5866261398273, 2864.8854045838143, 9823.017698230191, 10051.145652619536, 10142.442165680885, 10195.98040195982, 10346.32748871321, 1769.566456218222, 1779.0482092080674, 1806.97289540657, 1883.2655264446876, 1916.9808301916942, 114502.0, 116371.41814290959, 121109.39445302806, 122273.99999999911, 122450.0, 10921.890781092246, 11112.277387075259, 11316.321020738618, 11339.603113890975, 11538.826917596243, 13880.722385552232, 13894.513692020731, 13925.816305614137, 13932.721345573033, 13934.0, 8092.959535202286, 8246.670133194604, 8346.207110324509, 8440.62017209227, 8474.703385381483, 6756.2568117507035, 8308.70919517814, 8324.6670133194, 8434.367422443342, 8490.23587877094, 4371.30059190528, 4373.606375426227, 4425.424694789721, 4462.553744625511, 4501.617362524222, 1588.4440445843861, 1660.6844699507296, 1675.5894805772664, 1914.5692219250557, 1979.1786408640542, 920.2637889688223, 945.5036106044245, 992.9602815887428, 1010.757418219622, 1021.4504596527157, 20675.793242067688, 21805.824279406534, 22165.0, 22273.0, 23737.7626223739, 827.7227128911761, 923.196818767663, 944.40502483435, 945.7871978804851, 1038.46000079958, 9969.700908972742, 11141.275817071864, 11738.119641026957, 11818.940905295418, 11877.22798018126, 493193.0, 570232.0, 578709.9580518886, 588792.0, 591490.0, 134477.0, 135485.64514354928, 136731.31634341765, 140591.0, 143478.0, 1044.770150566874, 1057.2757661002238, 1080.8216644253766, 1083.588236470152, 1086.1256688365784, 17070.231839567, 19660.90169549143, 19718.507037324183, 19848.305309314106, 19928.202871885544, 56872.146917797094, 57368.426315737976, 57975.0, 58106.0, 58998.0, 78265.60867195627, 80987.59506202431, 83179.5841020791, 83766.0, 85768.14231857602, 6908.516403851682, 7317.15852676949, 8045.477043992122, 8270.545120018456, 8351.20663536963, 11023.61417350389, 11872.347020913932, 12914.09601327898, 13448.529301474793, 13491.86508134906, 11124.700454414678, 11287.927646873533, 11655.0, 11689.88310116922, 11727.472263748323, 10745.301555398873, 11021.173411993972, 11156.44217789091, 11284.379359134999, 11608.30350178992, 11376.431178441211, 11457.942710286396, 11646.650600481998, 11826.93557579822, 11948.940255298668, 8017.879731804144, 8198.754037378889, 8206.671733130846, 8335.874656921238, 8446.408751387344, 8257.00915890073, 11106.666799996014, 11211.943940280247, 11436.199466037298, 11676.766464670829], "value": 9547.390342923802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.676709507456, 1533.2793587014103, 1715.3138744502198, 1796.8141026922233, 1832.8442082422994, 7851.018622672166, 8385.2872505837, 8432.53621050842, 8894.288456923447, 8907.15382038707, 8545.359098067638, 8654.870176947335, 8693.652253909851, 8696.521691306976, 8722.520261385622, 1980.2870966452138, 2071.7203177570987, 2227.5433536125056, 2326.1742081561056, 2353.95292094158, 2314.780095890888, 2318.211807985285, 2368.1829768729845, 2369.407648087978, 2374.82188835838, 1978.7526559180103, 2347.401412639783, 2369.609014512603, 2373.2880135959144, 2380.547695937766, 2286.142696488817, 2316.224064938248, 2329.010170677464, 2332.7550607186254, 2333.7782910623464, 1936.5545924437458, 2345.5074434368803, 2347.5891718949288, 2347.97652023481, 2350.059976009593, 8755.956220218923, 8812.647494100229, 8850.114988501162, 8879.067697891758, 8886.155815197546, 5205.635605507616, 5340.332458442695, 5342.866428339323, 5345.866353341159, 5360.678359298455, 3487.877924272638, 3540.030362643223, 3618.0773902654655, 3658.4878117063367, 3674.7978861162624, 1045.900639439252, 1077.6766969908997, 1083.5286650307141, 1090.7436752363187, 1102.4510562659477, 11373.090152787758, 11541.0, 11558.942205289004, 11627.360495172763, 11671.649850504498, 4521.570450807168, 4605.654575906753, 4766.809327626856, 4769.284607308931, 4774.7135171889795, 9723.319367644339, 9750.463724495079, 9825.606975721033, 9866.125436167105, 9873.555689993967, 5200.453952335026, 5243.344581927259, 5245.895082098336, 5272.393674727378, 5315.3621565412395, 4354.825806967686, 4697.0, 4802.327674125625, 4818.301346304766, 4832.95167048325, 3907.1013666856784, 3930.6265904739003, 4015.678745700337, 4044.676425885922, 4074.9185016299507, 1276.8020956751718, 1287.8261434706194, 1291.063978615515, 1296.1898813241723, 1304.4325718312564, 811.2131232704268, 921.635953798246, 927.9350445468752, 936.1106948398912, 975.5268694683073, 5717.456841600041, 5946.821595352147, 5978.760849566055, 6030.879382412327, 6073.939260607426, 411.5740208883791, 422.1325176761784, 424.65815018909456, 430.9827606895752, 435.5753140687804, 3904.39481880309, 3964.365701487748, 3977.065389633434, 4081.6326530611796, 4091.2840252956207, 10267.71653543307, 10709.78580428387, 10712.089472394779, 10725.83911241332, 10729.517171727291, 10560.366378017343, 10653.680389588324, 10659.253852230424, 10675.985781350759, 10689.786204275872, 6415.615063096229, 6960.408365289007, 7882.448228623941, 8144.592770361458, 8260.132686067996, 5464.754086066057, 5792.681402522901, 6038.728257228523, 6134.4172303631085, 6168.784092556739, 8193.303569196685, 9500.524973751422, 9962.0, 10122.544485498318, 10127.594896204364, 8695.565221739014, 9990.000999900243, 10037.397756134655, 10067.345622534805, 10184.134348580454, 7452.292032256927, 7489.962550187214, 7538.698452061856, 7593.1647518774, 7646.235376462309, 8144.5520496373265, 8240.011198656199, 8290.87563686533, 8337.416380853281, 8341.582920853813, 7509.66206520697, 7593.354564862048, 7639.732609358646, 7689.8462030757955, 7759.650815713419, 7343.77968660941, 7456.9254307458405, 7504.737334193277, 7517.699292028257, 7653.540787552764, 5967.731452084753, 7035.964820175866, 7095.964520177573, 7102.289771022856, 7111.395531379684, 4772.164871147605, 4973.229149481836, 4987.326710893983, 5010.3737032870895, 5120.974395128001, 4968.875778105432, 5044.722540260321, 5150.819721309736, 5168.922466162935, 5214.97392513035], "value": 4470.634917755468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.6058630295647, 293.7488447377494, 309.97553087047305, 311.67741387663773, 313.20602273237347, 5537.335519737637, 5665.716714164296, 5713.028785106531, 5752.683602401867, 5782.653040817549, 5611.635243709156, 5667.489925906668, 5715.7420270445755, 5722.6280291781, 5752.252207213067, 3840.6543411093, 4367.061081867398, 4387.749491394945, 4408.933865991997, 4411.205982923088, 4025.396190571423, 4292.871213863574, 4361.60745532902, 4362.323839804835, 4365.668471116308, 3828.8659896903614, 4136.91726165478, 4254.765987870666, 4273.764942928137, 4284.785760711968, 4135.813888375, 4253.2131555662145, 4253.766042867641, 4307.892302692427, 4355.172517221749, 3091.30445649727, 3265.7713960022807, 3550.289942011608, 3689.5572531296148, 3706.054955986206, 4320.546342634041, 5098.694078355274, 5484.314460692413, 5493.697846618435, 5536.695481748502, 4093.8771836844944, 4282.892927676802, 4685.789139488731, 4916.558409113635, 4944.258361245842, 5072.568831649277, 5193.896122077537, 5209.322788037569, 5975.163477113208, 5995.970020149872, 4027.3153563893916, 4042.4542686737504, 4044.1507283470505, 4080.7347522410946, 4083.2650122977852, 5600.299962504687, 5822.505087067562, 5897.997340452091, 5902.170327198539, 6335.081413195107, 3676.485292059114, 3712.1462063724953, 4072.775997320176, 4078.286299897565, 4086.2644723949975, 3285.4743241081314, 3646.2889736501656, 3790.8104594770152, 4111.71218014742, 4122.876313710593, 4853.2720091985775, 4876.366072410564, 4894.95105048945, 4916.959461823303, 4922.987764971536, 4800.623691272773, 5626.856304144752, 6053.213082299361, 6091.390860913873, 6111.84720381994, 1142.611512085878, 1291.773939560592, 1299.616613099138, 1368.9110207836459, 1414.2080434956458, 825.7646281406267, 832.3008672714949, 839.366278459759, 857.3012994409536, 863.8531449653574, 3794.829232684536, 3898.335564569296, 4237.944596870515, 4694.413198350207, 4696.600788932979, 4434.490033646108, 4899.681520701143, 5106.412762532356, 5120.539151476385, 5194.0910340690225, 3960.821763020671, 4387.407699960529, 4656.3946686930485, 4753.47711751707, 4777.140114779304, 2420.6853109095705, 2426.344886880532, 2652.2706255779817, 2729.9489696466608, 2749.6866276137207, 5310.459966609717, 5382.730863456812, 5397.0, 5406.945930540723, 5449.719315960746, 5117.746152192736, 5273.419923808378, 5323.201519772065, 5403.729813509309, 5454.372747134051, 6378.394052564999, 6441.774537891245, 6450.7097180627925, 6462.967685161544, 6536.901946470807, 5837.153612726216, 6259.967105427736, 6278.4035516625845, 6309.684515774101, 6360.900902702189, 5761.0124507045, 6052.969735151296, 6059.697015149313, 6077.6353418795015, 6179.721912514037, 5391.433899440659, 6008.609440386361, 6124.989376752786, 6457.225132984072, 6497.025446182921, 3946.171304026072, 4038.1721747041197, 4060.7766572837595, 4083.8774836754947, 4107.774072426046, 4906.252498600795, 5093.439721630692, 5517.806876759294, 5904.409559044061, 6026.939730602638, 5135.281060651587, 5847.035239185487, 6073.514118870568, 6145.201123853871, 6173.580076582321, 5558.972205138948, 6082.939170608237, 6124.724387402489, 6126.702486567538, 6174.598651087665, 5204.791808327776, 5448.346198456211, 5941.405859414024, 5946.554008449297, 5994.250718660168, 6097.512199024156, 6122.969385153046, 6128.84364552247, 6152.50779937595, 6152.969235153795, 5247.475252474722, 5682.5453963681975, 5857.941420585739, 6011.489023433057, 6015.293118096962], "value": 4192.946698520033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.7225906730573, 698.6787362512478, 715.6278735057767, 784.5724080376194, 827.2430725885815, 14116.658917402856, 14748.705025899475, 15261.389544418224, 15736.527904162893, 15931.840681593181, 13924.0, 14081.859181408183, 14223.857761422383, 14282.143071415723, 14395.06432081914, 776.3090849144266, 877.1097336203742, 885.4731434796286, 885.9601317940708, 887.7514295997131, 706.5230969095866, 855.9400841941035, 881.823635272948, 887.5961437545933, 888.6267767537618, 818.8526065308242, 898.1467605774508, 899.2131884600974, 941.0824446165003, 945.654835984864, 897.5063714956813, 900.5497251374313, 938.9718308450791, 943.7923656795494, 944.6740874398322, 663.9933600663979, 668.7692746002622, 693.4175292754111, 697.504771612156, 699.1330749870175, 14580.854191458056, 14775.261236938217, 15050.172240526766, 15114.546563603, 15184.696306073927, 14568.271586420637, 14753.77869331961, 14973.775393369107, 14979.101253924691, 15035.398584056624, 12009.459574319177, 12313.69215769604, 12527.123101382907, 12562.120651554394, 12588.68528286791, 3346.247094403764, 3533.2403533240476, 3635.4365073413665, 3785.299719551892, 3797.7341586088983, 112268.43865780701, 113455.0, 113913.0, 114589.0, 116855.8314416862, 8576.785580360416, 10336.689899303034, 10432.061114499731, 10458.52936617854, 10854.240203185858, 21557.461063473223, 21732.78267217339, 21836.23573174931, 21871.562568748537, 22392.992315345524, 8066.798330041678, 8120.472169308976, 8136.023677158779, 8201.71294004719, 8218.712345067894, 4384.101259241847, 4415.580519850609, 4453.821847126079, 4501.954980450219, 4531.864044078683, 3879.4180872868733, 4104.343305071175, 4124.360724087711, 4124.835006599762, 4154.979225103855, 710.1123595505618, 715.2525610736689, 719.6114098386812, 723.8081908294306, 728.661172554754, 638.8402899275181, 643.2120652201016, 684.5037347922716, 689.2074114768056, 692.6121372031679, 9186.26509879208, 9787.657431989846, 9904.603815847286, 10000.0999910007, 10053.497325133714, 577.7515668262604, 654.6366766444573, 663.4791688524485, 681.1213534540486, 699.2029086841005, 4483.686141970031, 4807.663463557587, 4894.898647804287, 4897.436794768647, 4901.58336541398, 91275.54362228146, 114291.42854285675, 176663.11668441576, 177802.0, 182490.08754956405, 139381.0, 148722.25638871736, 151011.0, 154791.0, 155175.44824551835, 88817.55591222002, 99284.0, 105221.0, 124081.13878291832, 131642.0, 9328.440293582407, 9337.53312334367, 9347.439153650803, 9378.577963991773, 9419.340646154977, 66207.34481637998, 66296.0, 66744.97326176635, 67115.66442167954, 67951.0, 98635.01364986545, 100324.0, 100477.0, 100710.99289007016, 102454.97545024753, 11999.700007499883, 12106.273623582612, 12127.090468214743, 12184.756304873676, 12305.0, 10959.726006849893, 13549.0, 13570.347277387204, 13717.725645487233, 13763.31183440844, 12549.0, 12708.618741437771, 12733.426995785398, 12868.806967895302, 13091.803622945854, 11655.941720291345, 12454.439550220442, 12574.308413037004, 12922.0, 12989.740205196033, 12162.331071791137, 12201.145919785884, 12295.44670489848, 12377.167271101252, 12668.0, 10219.948900255451, 10407.011333923265, 10476.584832898314, 10525.263231574023, 10808.729781755519, 10551.472426378497, 10587.682369528926, 10822.40476773785, 10854.945725271324, 10866.239363244496], "value": 7892.346554354209, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 107.0, 114.0, 117.0, 116.0, 114.0, 117.0, 116.0, 118.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 136.0, 155.0, 113.0, 143.0, 131.0, 111.0, 157.0, 113.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 282.0, 215.0, 220.0, 226.0, 189.0, 200.0, 201.0, 197.0, 195.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 75.0, 143.0, 58.0, 58.0, 61.0, 65.0, 145.0, 60.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 126.0, 73.0, 72.0, 74.0, 112.0, 73.0, 102.0, 138.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 129.0, 127.0, 86.0, 93.0, 87.0, 90.0, 86.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 94.0, 116.0, 124.0, 95.0, 96.0, 96.0, 95.0, 118.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 83.0, 146.0, 148.0, 119.0, 93.0, 129.0, 131.0, 151.0], "value": 118.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 56.0, 84.0, 86.0, 57.0, 56.0, 57.0, 54.0, 56.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 71.0, 77.0, 79.0, 65.0, 97.0, 62.0, 84.0, 103.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 82.0, 105.0, 86.0, 86.0, 89.0, 79.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 135.0, 148.0, 123.0, 161.0, 172.0, 173.0, 164.0, 176.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 170.0, 167.0, 170.0, 172.0, 145.0, 203.0, 211.0, 223.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 71.0, 74.0, 86.0, 87.0, 64.0, 78.0], "value": 72.9, "unit": "score"}]}]} 09:26:05 INFO - Return code: 0 09:26:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:05 ERROR - # TBPL SUCCESS # 09:26:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:26:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:26:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:26:05 INFO - 2016-08-09 09:26:05.789 screenresolution[1679:10969] starting screenresolution argv=screenresolution get 09:26:05 INFO - 2016-08-09 09:26:05.793 screenresolution[1679:10969] Display 0: 1600x1200x32@60 09:26:05 INFO - 2016-08-09 09:26:05.800 screenresolution[1680:10972] starting screenresolution argv=screenresolution list 09:26:05 INFO - Available Modes on Display 0 09:26:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:26:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:26:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:26:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:26:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:26:06 INFO - Intel Iris: 09:26:06 INFO - Chipset Model: Intel Iris 09:26:06 INFO - Type: GPU 09:26:06 INFO - Bus: Built-In 09:26:06 INFO - VRAM (Dynamic, Max): 1536 MB 09:26:06 INFO - Vendor: Intel (0x8086) 09:26:06 INFO - Device ID: 0x0a2e 09:26:06 INFO - Revision ID: 0x0009 09:26:06 INFO - Displays: 09:26:06 INFO - Display: 09:26:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:26:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:26:06 INFO - Display Serial Number: 1600x1200 60 09:26:06 INFO - Main Display: Yes 09:26:06 INFO - Mirror: Off 09:26:06 INFO - Online: Yes 09:26:06 INFO - Rotation: Supported 09:26:06 INFO - Return code: 0 09:26:06 INFO - Running post-action listener: _resource_record_post_action 09:26:06 INFO - [mozharness: 2016-08-09 16:26:06.044101Z] Finished run-tests step (success) 09:26:06 INFO - Running post-run listener: _resource_record_post_run 09:26:06 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32766976; Write bytes: 708982272; Read time: 311; Write time: 1820 09:26:06 INFO - TinderboxPrint: CPU usage
54.3% 09:26:06 INFO - TinderboxPrint: I/O read bytes / time
32,766,976 / 311 09:26:06 INFO - TinderboxPrint: I/O write bytes / time
708,982,272 / 1,820 09:26:06 INFO - TinderboxPrint: CPU idle
2,211.9 (45.7%) 09:26:06 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 09:26:06 INFO - TinderboxPrint: CPU user
1,655.6 (34.2%) 09:26:06 INFO - TinderboxPrint: Swap in / out
435,900,416 / 0 09:26:06 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398578176; Write bytes: 392906240; Read time: 29586; Write time: 712 09:26:06 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30796800; Write bytes: 298233856; Read time: 291; Write time: 1070 09:26:06 INFO - Running post-run listener: _upload_blobber_files 09:26:06 INFO - Blob upload gear active. 09:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:07 INFO - (blobuploader) - INFO - Done attempting. 09:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:09 INFO - (blobuploader) - INFO - Done attempting. 09:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:11 INFO - (blobuploader) - INFO - Done attempting. 09:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:11 INFO - Return code: 0 09:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c690f7532b8c82f9fb0a3d9306f184c3ac4421afe23670e7c6dd412e2c6eafb0b73c85b857cd311e9b95734f961db54f22bbeab9e566a63ccd6015fd04b2283a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d808816ce24e81a2bcbbad33e5fbff7ec285674f4f2e261e6bf2b9a02ebebc3cd1136c4aea0508fe82ca64161c1f1b55ff44adc89a55562cd695d4e6314fc65a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb475a108311c8ec841ff698cb1593a10d506f3aac3152e4c61d5fc840e78ccecfc494514bbefec8ac1462ee180803a09bfda0559d688b297740fd56ec5697f3"} 09:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:11 INFO - Contents: 09:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c690f7532b8c82f9fb0a3d9306f184c3ac4421afe23670e7c6dd412e2c6eafb0b73c85b857cd311e9b95734f961db54f22bbeab9e566a63ccd6015fd04b2283a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d808816ce24e81a2bcbbad33e5fbff7ec285674f4f2e261e6bf2b9a02ebebc3cd1136c4aea0508fe82ca64161c1f1b55ff44adc89a55562cd695d4e6314fc65a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb475a108311c8ec841ff698cb1593a10d506f3aac3152e4c61d5fc840e78ccecfc494514bbefec8ac1462ee180803a09bfda0559d688b297740fd56ec5697f3"} 09:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:11 INFO - Copying logs to upload dir... 09:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.764657 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-09 09:26:11.714477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:26:11.718005) ========= 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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c690f7532b8c82f9fb0a3d9306f184c3ac4421afe23670e7c6dd412e2c6eafb0b73c85b857cd311e9b95734f961db54f22bbeab9e566a63ccd6015fd04b2283a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d808816ce24e81a2bcbbad33e5fbff7ec285674f4f2e261e6bf2b9a02ebebc3cd1136c4aea0508fe82ca64161c1f1b55ff44adc89a55562cd695d4e6314fc65a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb475a108311c8ec841ff698cb1593a10d506f3aac3152e4c61d5fc840e78ccecfc494514bbefec8ac1462ee180803a09bfda0559d688b297740fd56ec5697f3"} build_url:https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010897 build_url: 'https://queue.taskcluster.net/v1/task/XgOsSOVOTv2086ZWg2c2jw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c690f7532b8c82f9fb0a3d9306f184c3ac4421afe23670e7c6dd412e2c6eafb0b73c85b857cd311e9b95734f961db54f22bbeab9e566a63ccd6015fd04b2283a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d808816ce24e81a2bcbbad33e5fbff7ec285674f4f2e261e6bf2b9a02ebebc3cd1136c4aea0508fe82ca64161c1f1b55ff44adc89a55562cd695d4e6314fc65a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb475a108311c8ec841ff698cb1593a10d506f3aac3152e4c61d5fc840e78ccecfc494514bbefec8ac1462ee180803a09bfda0559d688b297740fd56ec5697f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:26:11.749865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:26:11.750183) ========= 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.Sxc8twLeEP/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.QXg9w3uhIK/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:26:11.798491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:26:11.798929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:26:11.799291) ========= ========= Total master_lag: 0.17 =========