builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0237 starttime: 1467228434.94 results: success (0) buildid: 20160629102628 builduid: 44393065e3024815b25a833868fe4b6b revision: 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:14.936099) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:14.936577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:14.936862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:14.959916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:14.960180) ========= 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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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-06-29 12:27:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-06-29 12:27:15 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129084 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:15.311525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:15.311851) ========= 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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.020611 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:15.352453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 12:27:15.352804) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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-06-29 12:27:15,429 truncating revision to first 12 chars 2016-06-29 12:27:15,429 Setting DEBUG logging. 2016-06-29 12:27:15,429 attempt 1/10 2016-06-29 12:27:15,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1a1d7ef3cb0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 12:27:16,525 unpacking tar archive at: autoland-1a1d7ef3cb0e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 12:27:16.748652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:16.748938) ========= script_repo_revision: 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:16.749357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:16.749620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 12:27:16.767394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-29 12:27:16.767668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:16 INFO - MultiFileLogger online at 20160629 12:27:16 in /builds/slave/test 12:27:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:27:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:27:16 INFO - {'append_to_log': False, 12:27:16 INFO - 'base_work_dir': '/builds/slave/test', 12:27:16 INFO - 'blob_upload_branch': 'Autoland', 12:27:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:27:16 INFO - 'branch': 'Autoland', 12:27:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:27:16 INFO - 'config_files': ('talos/mac_config.py',), 12:27:16 INFO - 'default_actions': ('clobber', 12:27:16 INFO - 'read-buildbot-config', 12:27:16 INFO - 'download-and-extract', 12:27:16 INFO - 'populate-webroot', 12:27:16 INFO - 'create-virtualenv', 12:27:16 INFO - 'install', 12:27:16 INFO - 'run-tests'), 12:27:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:27:16 INFO - 'download_minidump_stackwalk': True, 12:27:16 INFO - 'download_symbols': 'ondemand', 12:27:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:27:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:27:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:27:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:27:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:27:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:27:16 INFO - 'installer_path': 'installer.exe', 12:27:16 INFO - 'log_level': 'info', 12:27:16 INFO - 'log_name': 'talos', 12:27:16 INFO - 'log_to_console': True, 12:27:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:27:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:27:16 INFO - 'opt_config_files': (), 12:27:16 INFO - 'pip_index': False, 12:27:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:27:16 INFO - 'cmd': ('bash', 12:27:16 INFO - '-c', 12:27:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:27:16 INFO - 'enabled': True, 12:27:16 INFO - 'halt_on_failure': False, 12:27:16 INFO - 'name': 'check_screen_resolution'},), 12:27:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:27:16 INFO - 'cmd': ('bash', 12:27:16 INFO - '-c', 12:27:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:27:16 INFO - 'enabled': True, 12:27:16 INFO - 'halt_on_failure': False, 12:27:16 INFO - 'name': 'check_screen_resolution'},), 12:27:16 INFO - 'run_cmd_checks_enabled': True, 12:27:16 INFO - 'sps_profile': False, 12:27:16 INFO - 'sps_profile_interval': 0, 12:27:16 INFO - 'suite': 'dromaeojs-e10s', 12:27:16 INFO - 'system_bits': '32', 12:27:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:27:16 INFO - 'title': 't-yosemite-r7-0237', 12:27:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:27:16 INFO - 'use_talos_json': True, 12:27:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:27:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:27:16 INFO - 'work_dir': 'build'} 12:27:16 INFO - ##### 12:27:16 INFO - ##### Running clobber step. 12:27:16 INFO - ##### 12:27:16 INFO - Running pre-action listener: _resource_record_pre_action 12:27:16 INFO - Running main action method: clobber 12:27:16 INFO - rmtree: /builds/slave/test/build 12:27:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:27:18 INFO - Running post-action listener: _resource_record_post_action 12:27:18 INFO - ##### 12:27:18 INFO - ##### Finished clobber step (success) 12:27:18 INFO - ##### 12:27:18 INFO - ##### 12:27:18 INFO - ##### Running read-buildbot-config step. 12:27:18 INFO - ##### 12:27:18 INFO - Running pre-action listener: _resource_record_pre_action 12:27:18 INFO - Running main action method: read_buildbot_config 12:27:18 INFO - Using buildbot properties: 12:27:18 INFO - { 12:27:18 INFO - "project": "", 12:27:18 INFO - "product": "firefox", 12:27:18 INFO - "script_repo_revision": "production", 12:27:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 12:27:18 INFO - "repository": "", 12:27:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 12:27:18 INFO - "buildid": "20160629102628", 12:27:18 INFO - "pgo_build": "False", 12:27:18 INFO - "basedir": "/builds/slave/test", 12:27:18 INFO - "buildnumber": 14, 12:27:18 INFO - "slavename": "t-yosemite-r7-0237", 12:27:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:27:18 INFO - "platform": "yosemite_r7", 12:27:18 INFO - "scheduler": "tests-autoland-macosx64-talos", 12:27:18 INFO - "branch": "autoland", 12:27:18 INFO - "repo_path": "integration/autoland", 12:27:18 INFO - "revision": "1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f", 12:27:18 INFO - "stage_platform": "macosx64", 12:27:18 INFO - "builduid": "44393065e3024815b25a833868fe4b6b", 12:27:18 INFO - "slavebuilddir": "test" 12:27:18 INFO - } 12:27:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 12:27:18 INFO - Running post-action listener: _resource_record_post_action 12:27:18 INFO - ##### 12:27:18 INFO - ##### Finished read-buildbot-config step (success) 12:27:18 INFO - ##### 12:27:18 INFO - ##### 12:27:18 INFO - ##### Running download-and-extract step. 12:27:18 INFO - ##### 12:27:18 INFO - Running pre-action listener: _resource_record_pre_action 12:27:18 INFO - Running main action method: download_and_extract 12:27:18 INFO - mkdir: /builds/slave/test/build/tests 12:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:18 INFO - https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 12:27:19 INFO - Downloaded 1199 bytes. 12:27:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:27:19 INFO - Using the following test package requirements: 12:27:19 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:27:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 12:27:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 12:27:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'jsshell-mac.zip'], 12:27:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 12:27:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:27:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 12:27:19 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 12:27:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 12:27:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:27:19 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 12:27:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:19 INFO - https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:27:20 INFO - Downloaded 18788475 bytes. 12:27:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:27:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:27:23 INFO - Return code: 0 12:27:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:27:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:23 INFO - https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:27:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:27:28 INFO - Downloaded 18788475 bytes. 12:27:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:27:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:27:31 INFO - Return code: 0 12:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:31 INFO - https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:27:33 INFO - Downloaded 14405245 bytes. 12:27:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:27:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:27:33 INFO - Return code: 0 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:33 INFO - https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:27:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:27:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:27:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 12:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 12:27:37 INFO - Downloaded 112469340 bytes. 12:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:27:37 INFO - mkdir: /builds/slave/test/properties 12:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 12:27:37 INFO - Contents: 12:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:27:38 INFO - Running post-action listener: _resource_record_post_action 12:27:38 INFO - Running post-action listener: set_extra_try_arguments 12:27:38 INFO - ##### 12:27:38 INFO - ##### Finished download-and-extract step (success) 12:27:38 INFO - ##### 12:27:38 INFO - ##### 12:27:38 INFO - ##### Running populate-webroot step. 12:27:38 INFO - ##### 12:27:38 INFO - Running pre-action listener: _resource_record_pre_action 12:27:38 INFO - Running main action method: populate_webroot 12:27:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:27:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:27:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:27:38 INFO - '--tppagecycles', 12:27:38 INFO - '7'], 12:27:38 INFO - 'tests': ['tsvgm']}}, 12:27:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:27:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:27:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:27:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:27:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['damp', 'tps']}, 12:27:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'tests': ['damp', 'tps']}, 12:27:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['dromaeo_dom']}, 12:27:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:27:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['basic_compositor_video']}, 12:27:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:27:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'other-e10s': {'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['a11yr', 12:27:38 INFO - 'ts_paint', 12:27:38 INFO - 'tpaint', 12:27:38 INFO - 'sessionrestore', 12:27:38 INFO - 'sessionrestore_no_auto_restore', 12:27:38 INFO - 'tabpaint']}, 12:27:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['tsvgx', 12:27:38 INFO - 'tsvgr_opacity', 12:27:38 INFO - 'tart', 12:27:38 INFO - 'tscrollx', 12:27:38 INFO - 'cart']}, 12:27:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:27:38 INFO - 'tsvgr_opacity', 12:27:38 INFO - 'tart', 12:27:38 INFO - 'tscrollx', 12:27:38 INFO - 'cart']}, 12:27:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'talos_options': ['--disable-e10s'], 12:27:38 INFO - 'tests': ['tp5o']}, 12:27:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'tests': ['tp5o']}, 12:27:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'talos_options': ['--disable-e10s', 12:27:38 INFO - '--xperf_path', 12:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:38 INFO - 'tests': ['tp5n']}, 12:27:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:38 INFO - 'talos_options': ['--xperf_path', 12:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:38 INFO - 'tests': ['tp5n']}}, 12:27:38 INFO - 'talos.zip': {'path': '', 12:27:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:27:38 INFO - Running post-action listener: _resource_record_post_action 12:27:38 INFO - ##### 12:27:38 INFO - ##### Finished populate-webroot step (success) 12:27:38 INFO - ##### 12:27:38 INFO - ##### 12:27:38 INFO - ##### Running create-virtualenv step. 12:27:38 INFO - ##### 12:27:38 INFO - Running pre-action listener: _resource_record_pre_action 12:27:38 INFO - Running main action method: create_virtualenv 12:27:38 INFO - Creating virtualenv /builds/slave/test/build/venv 12:27:38 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 12:27:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:27:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:27:38 INFO - Using real prefix '/tools/python27' 12:27:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:27:39 INFO - Installing distribute.............................................................................................................................................................................................done. 12:27:42 INFO - Installing pip.................done. 12:27:42 INFO - Return code: 0 12:27:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:27:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:42 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:42 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 12:27:42 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 12:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:42 INFO - 'HOME': '/Users/cltbld', 12:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:42 INFO - 'LOGNAME': 'cltbld', 12:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:42 INFO - 'MOZ_NO_REMOTE': '1', 12:27:42 INFO - 'NO_EM_RESTART': '1', 12:27:42 INFO - 'PAGER': '/bin/cat', 12:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:42 INFO - 'PWD': '/builds/slave/test', 12:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:42 INFO - 'SHELL': '/bin/bash', 12:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:42 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:42 INFO - 'USER': 'cltbld', 12:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:42 INFO - 'XPC_FLAGS': '0x0', 12:27:42 INFO - 'XPC_SERVICE_NAME': '0', 12:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:42 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 12:27:42 INFO - Cleaning up... 12:27:42 INFO - Return code: 0 12:27:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:27:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:42 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:42 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 12:27:42 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 12:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:42 INFO - 'HOME': '/Users/cltbld', 12:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:42 INFO - 'LOGNAME': 'cltbld', 12:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:42 INFO - 'MOZ_NO_REMOTE': '1', 12:27:42 INFO - 'NO_EM_RESTART': '1', 12:27:42 INFO - 'PAGER': '/bin/cat', 12:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:42 INFO - 'PWD': '/builds/slave/test', 12:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:42 INFO - 'SHELL': '/bin/bash', 12:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:42 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:42 INFO - 'USER': 'cltbld', 12:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:42 INFO - 'XPC_FLAGS': '0x0', 12:27:42 INFO - 'XPC_SERVICE_NAME': '0', 12:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:42 INFO - Downloading/unpacking psutil>=3.1.1 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:27:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:46 INFO - Installing collected packages: psutil 12:27:46 INFO - Running setup.py install for psutil 12:27:46 INFO - building 'psutil._psutil_osx' extension 12:27:46 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 12:27:46 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 12:27:46 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 12:27:46 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 12:27:46 INFO - building 'psutil._psutil_posix' extension 12:27:46 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 12:27:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:27:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:27:46 INFO - ^ 12:27:46 INFO - 1 warning generated. 12:27:46 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 12:27:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:46 INFO - Successfully installed psutil 12:27:46 INFO - Cleaning up... 12:27:46 INFO - Return code: 0 12:27:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:27:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:46 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:46 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 12:27:46 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 12:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:46 INFO - 'HOME': '/Users/cltbld', 12:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:46 INFO - 'LOGNAME': 'cltbld', 12:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:46 INFO - 'MOZ_NO_REMOTE': '1', 12:27:46 INFO - 'NO_EM_RESTART': '1', 12:27:46 INFO - 'PAGER': '/bin/cat', 12:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:46 INFO - 'PWD': '/builds/slave/test', 12:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:46 INFO - 'SHELL': '/bin/bash', 12:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:46 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:46 INFO - 'USER': 'cltbld', 12:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:46 INFO - 'XPC_FLAGS': '0x0', 12:27:46 INFO - 'XPC_SERVICE_NAME': '0', 12:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:27:47 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 12:27:47 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 12:27:47 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 12:27:47 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 12:27:47 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 12:27:47 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 12:27:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:27:49 INFO - Installing collected packages: mozsystemmonitor 12:27:49 INFO - Running setup.py install for mozsystemmonitor 12:27:49 INFO - Successfully installed mozsystemmonitor 12:27:49 INFO - Cleaning up... 12:27:49 INFO - Return code: 0 12:27:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:49 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:49 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 12:27:49 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 12:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:49 INFO - 'HOME': '/Users/cltbld', 12:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:49 INFO - 'LOGNAME': 'cltbld', 12:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:49 INFO - 'MOZ_NO_REMOTE': '1', 12:27:49 INFO - 'NO_EM_RESTART': '1', 12:27:49 INFO - 'PAGER': '/bin/cat', 12:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:49 INFO - 'PWD': '/builds/slave/test', 12:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:49 INFO - 'SHELL': '/bin/bash', 12:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:49 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:49 INFO - 'USER': 'cltbld', 12:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:49 INFO - 'XPC_FLAGS': '0x0', 12:27:49 INFO - 'XPC_SERVICE_NAME': '0', 12:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:27:50 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 12:27:50 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 12:27:50 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 12:27:50 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 12:27:50 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 12:27:50 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 12:27:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:27:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:27:53 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 12:27:53 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 12:27:53 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 12:27:53 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 12:27:53 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 12:27:53 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 12:27:53 INFO - Downloading functools32-3.2.3-2.tar.gz 12:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:27:53 INFO - warning: no files found matching '*.txt' 12:27:53 INFO - no previously-included directories found matching 'build' 12:27:53 INFO - no previously-included directories found matching 'dist' 12:27:53 INFO - no previously-included directories found matching '.git*' 12:27:53 INFO - Installing collected packages: jsonschema, functools32 12:27:53 INFO - Running setup.py install for functools32 12:27:53 INFO - warning: no files found matching '*.txt' 12:27:53 INFO - no previously-included directories found matching 'build' 12:27:53 INFO - no previously-included directories found matching 'dist' 12:27:53 INFO - no previously-included directories found matching '.git*' 12:27:53 INFO - Successfully installed jsonschema functools32 12:27:53 INFO - Cleaning up... 12:27:54 INFO - Return code: 0 12:27:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:27:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:54 INFO - 'HOME': '/Users/cltbld', 12:27:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:54 INFO - 'LOGNAME': 'cltbld', 12:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:54 INFO - 'MOZ_NO_REMOTE': '1', 12:27:54 INFO - 'NO_EM_RESTART': '1', 12:27:54 INFO - 'PAGER': '/bin/cat', 12:27:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:54 INFO - 'PWD': '/builds/slave/test', 12:27:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:54 INFO - 'SHELL': '/bin/bash', 12:27:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:54 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:54 INFO - 'USER': 'cltbld', 12:27:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:54 INFO - 'XPC_FLAGS': '0x0', 12:27:54 INFO - 'XPC_SERVICE_NAME': '0', 12:27:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:27:54 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 12:27:54 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 12:27:54 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 12:27:54 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 12:27:54 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 12:27:54 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 12:27:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:27:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:27:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:57 INFO - Downloading docopt-0.6.1.tar.gz 12:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:27:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:27:57 INFO - Running setup.py install for blobuploader 12:27:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:27:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:27:58 INFO - Running setup.py install for requests 12:27:58 INFO - Running setup.py install for docopt 12:27:58 INFO - Successfully installed blobuploader requests docopt 12:27:58 INFO - Cleaning up... 12:27:58 INFO - Return code: 0 12:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:58 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:27:58 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 12:27:58 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 12:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:58 INFO - 'HOME': '/Users/cltbld', 12:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:58 INFO - 'LOGNAME': 'cltbld', 12:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:58 INFO - 'MOZ_NO_REMOTE': '1', 12:27:58 INFO - 'NO_EM_RESTART': '1', 12:27:58 INFO - 'PAGER': '/bin/cat', 12:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:58 INFO - 'PWD': '/builds/slave/test', 12:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:58 INFO - 'SHELL': '/bin/bash', 12:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:27:58 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:58 INFO - 'USER': 'cltbld', 12:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:58 INFO - 'XPC_FLAGS': '0x0', 12:27:58 INFO - 'XPC_SERVICE_NAME': '0', 12:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-CFx5FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-57Iugq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-O3SpHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-JqOsgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ZSpq8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-UomOYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-q1EjPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-3fiE14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:27:59 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-7wW0pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-HrP1Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-LvKbIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-dCsvAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-KBhREH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-uRnMGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-YJB0sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ypf78Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:00 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2E9c6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:28:00 INFO - Running setup.py install for manifestparser 12:28:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:28:01 INFO - Running setup.py install for mozcrash 12:28:01 INFO - Running setup.py install for mozdebug 12:28:01 INFO - Running setup.py install for mozdevice 12:28:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:28:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:28:01 INFO - Running setup.py install for mozfile 12:28:01 INFO - Running setup.py install for mozhttpd 12:28:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:28:01 INFO - Running setup.py install for mozinfo 12:28:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:28:01 INFO - Running setup.py install for mozInstall 12:28:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Running setup.py install for mozleak 12:28:02 INFO - Running setup.py install for mozlog 12:28:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Running setup.py install for moznetwork 12:28:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Running setup.py install for mozprocess 12:28:02 INFO - Running setup.py install for mozprofile 12:28:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:28:02 INFO - Running setup.py install for mozrunner 12:28:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:28:03 INFO - Running setup.py install for mozscreenshot 12:28:03 INFO - Running setup.py install for moztest 12:28:03 INFO - Running setup.py install for mozversion 12:28:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:28:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:28:03 INFO - Cleaning up... 12:28:03 INFO - Return code: 0 12:28:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:03 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:28:03 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 12:28:03 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 12:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:03 INFO - 'HOME': '/Users/cltbld', 12:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:03 INFO - 'LOGNAME': 'cltbld', 12:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:03 INFO - 'MOZ_NO_REMOTE': '1', 12:28:03 INFO - 'NO_EM_RESTART': '1', 12:28:03 INFO - 'PAGER': '/bin/cat', 12:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:03 INFO - 'PWD': '/builds/slave/test', 12:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:03 INFO - 'SHELL': '/bin/bash', 12:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:28:03 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:03 INFO - 'USER': 'cltbld', 12:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:03 INFO - 'XPC_FLAGS': '0x0', 12:28:03 INFO - 'XPC_SERVICE_NAME': '0', 12:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ZeUv6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:03 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)) 12:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-gxU05C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:03 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)) 12:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:03 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-mjjsox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-TvGfL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-T1Ltu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-_n_d2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-KI3OoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-6p9Xa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-3TsRxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-NlsANa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-VuUkG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:04 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:04 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-iUy5FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:05 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-6azHbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:05 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)) 12:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:05 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Bg8LCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:05 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-BNPgc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:05 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)) 12:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:05 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ibMjdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:05 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)) 12:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:05 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-6KByS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:05 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)) 12:28:05 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)) 12:28:05 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)) 12:28:05 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)) 12:28:05 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)) 12:28:05 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)) 12:28:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:28:05 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 12:28:05 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 12:28:05 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 12:28:05 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 12:28:05 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 12:28:05 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 12:28:07 INFO - Downloading blessings-1.6.tar.gz 12:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:28:08 INFO - Installing collected packages: blessings 12:28:08 INFO - Running setup.py install for blessings 12:28:08 INFO - Successfully installed blessings 12:28:08 INFO - Cleaning up... 12:28:08 INFO - Return code: 0 12:28:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:08 INFO - Reading from file tmpfile_stdout 12:28:08 INFO - Current package versions: 12:28:08 INFO - blessings == 1.6 12:28:08 INFO - blobuploader == 1.2.4 12:28:08 INFO - docopt == 0.6.1 12:28:08 INFO - functools32 == 3.2.3-2 12:28:08 INFO - jsonschema == 2.5.1 12:28:08 INFO - manifestparser == 1.1 12:28:08 INFO - mozInstall == 1.12 12:28:08 INFO - mozcrash == 0.17 12:28:08 INFO - mozdebug == 0.1 12:28:08 INFO - mozdevice == 0.48 12:28:08 INFO - mozfile == 1.2 12:28:08 INFO - mozhttpd == 0.7 12:28:08 INFO - mozinfo == 0.9 12:28:08 INFO - mozleak == 0.1 12:28:08 INFO - mozlog == 3.2 12:28:08 INFO - moznetwork == 0.27 12:28:08 INFO - mozprocess == 0.22 12:28:08 INFO - mozprofile == 0.28 12:28:08 INFO - mozrunner == 6.11 12:28:08 INFO - mozscreenshot == 0.1 12:28:08 INFO - mozsystemmonitor == 0.3 12:28:08 INFO - moztest == 0.7 12:28:08 INFO - mozversion == 1.4 12:28:08 INFO - psutil == 3.1.1 12:28:08 INFO - requests == 1.2.3 12:28:08 INFO - wsgiref == 0.1.2 12:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:08 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 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:28:08 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 12:28:08 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 12:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:08 INFO - 'HOME': '/Users/cltbld', 12:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:08 INFO - 'LOGNAME': 'cltbld', 12:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:08 INFO - 'MOZ_NO_REMOTE': '1', 12:28:08 INFO - 'NO_EM_RESTART': '1', 12:28:08 INFO - 'PAGER': '/bin/cat', 12:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:08 INFO - 'PWD': '/builds/slave/test', 12:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:08 INFO - 'SHELL': '/bin/bash', 12:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:28:08 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:08 INFO - 'USER': 'cltbld', 12:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:08 INFO - 'XPC_FLAGS': '0x0', 12:28:08 INFO - 'XPC_SERVICE_NAME': '0', 12:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 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)) 12:28:08 INFO - Cleaning up... 12:28:08 INFO - Return code: 0 12:28:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10745a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd2cc08f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, '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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 12:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:08 INFO - 'HOME': '/Users/cltbld', 12:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:08 INFO - 'LOGNAME': 'cltbld', 12:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:08 INFO - 'MOZ_NO_REMOTE': '1', 12:28:08 INFO - 'NO_EM_RESTART': '1', 12:28:08 INFO - 'PAGER': '/bin/cat', 12:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:08 INFO - 'PWD': '/builds/slave/test', 12:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:08 INFO - 'SHELL': '/bin/bash', 12:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:28:08 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:08 INFO - 'USER': 'cltbld', 12:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:08 INFO - 'XPC_FLAGS': '0x0', 12:28:08 INFO - 'XPC_SERVICE_NAME': '0', 12:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:28:09 INFO - Cleaning up... 12:28:09 INFO - Return code: 0 12:28:09 INFO - Running post-action listener: _resource_record_post_action 12:28:09 INFO - Running post-action listener: _start_resource_monitoring 12:28:09 INFO - Starting resource monitoring. 12:28:09 INFO - ##### 12:28:09 INFO - ##### Finished create-virtualenv step (success) 12:28:09 INFO - ##### 12:28:09 INFO - ##### 12:28:09 INFO - ##### Running install step. 12:28:09 INFO - ##### 12:28:09 INFO - Running pre-action listener: _resource_record_pre_action 12:28:09 INFO - Running main action method: install 12:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:09 INFO - Reading from file tmpfile_stdout 12:28:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:28:09 INFO - Reading from file tmpfile_stdout 12:28:09 INFO - Output received: 12:28:09 INFO - Usage: mozinstall [options] installer 12:28:09 INFO - Options: 12:28:09 INFO - -h, --help show this help message and exit 12:28:09 INFO - -d DEST, --destination=DEST 12:28:09 INFO - Directory to install application into. [default: 12:28:09 INFO - "/builds/slave/test"] 12:28:09 INFO - --app=APP Application being installed. [default: firefox] 12:28:09 INFO - mkdir: /builds/slave/test/build/application 12:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:28:44 INFO - Reading from file tmpfile_stdout 12:28:44 INFO - Output received: 12:28:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:28:44 INFO - Running post-action listener: _resource_record_post_action 12:28:44 INFO - ##### 12:28:44 INFO - ##### Finished install step (success) 12:28:44 INFO - ##### 12:28:44 INFO - ##### 12:28:44 INFO - ##### Running run-tests step. 12:28:44 INFO - ##### 12:28:44 INFO - Running pre-action listener: _resource_record_pre_action 12:28:44 INFO - Running main action method: run_tests 12:28:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:28:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:28:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:28:44 INFO - 2016-06-29 12:28:44.419 screenresolution[1914:17530] starting screenresolution argv=screenresolution get 12:28:44 INFO - 2016-06-29 12:28:44.422 screenresolution[1914:17530] Display 0: 1600x1200x32@60 12:28:44 INFO - 2016-06-29 12:28:44.428 screenresolution[1915:17533] starting screenresolution argv=screenresolution list 12:28:44 INFO - Available Modes on Display 0 12:28:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:28:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:28:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:28:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:28:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:28:44 INFO - Intel Iris: 12:28:44 INFO - Chipset Model: Intel Iris 12:28:44 INFO - Type: GPU 12:28:44 INFO - Bus: Built-In 12:28:44 INFO - VRAM (Dynamic, Max): 1536 MB 12:28:44 INFO - Vendor: Intel (0x8086) 12:28:44 INFO - Device ID: 0x0a2e 12:28:44 INFO - Revision ID: 0x0009 12:28:44 INFO - Displays: 12:28:44 INFO - Display: 12:28:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:28:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:28:44 INFO - Display Serial Number: 1600x1200 60 12:28:44 INFO - Main Display: Yes 12:28:44 INFO - Mirror: Off 12:28:44 INFO - Online: Yes 12:28:44 INFO - Rotation: Supported 12:28:44 INFO - Return code: 0 12:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:28:44 INFO - Python 2.7.3 12:28:44 INFO - Return code: 0 12:28:44 INFO - grabbing minidump binary from tooltool 12:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:44 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 0x107329d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107321b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:28:44 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 12:28:44 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 12:28:44 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 12:28:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:28:44 INFO - Return code: 0 12:28:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:28:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:28:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:28:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:28:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 12:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0237 --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 12:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SRi5L0p9Nq/Render', 12:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:44 INFO - 'HOME': '/Users/cltbld', 12:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:44 INFO - 'LOGNAME': 'cltbld', 12:28:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:28:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:44 INFO - 'MOZ_NO_REMOTE': '1', 12:28:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:28:44 INFO - 'NO_EM_RESTART': '1', 12:28:44 INFO - 'PAGER': '/bin/cat', 12:28:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:44 INFO - 'PWD': '/builds/slave/test', 12:28:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:44 INFO - 'SHELL': '/bin/bash', 12:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E7G59kUOTh/Listeners', 12:28:44 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 12:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:44 INFO - 'USER': 'cltbld', 12:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:44 INFO - 'XPC_FLAGS': '0x0', 12:28:44 INFO - 'XPC_SERVICE_NAME': '0', 12:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 12:28:45 INFO - mozversion application_buildid: 20160629102628 12:28:45 INFO - mozversion application_changeset: 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f 12:28:45 INFO - mozversion application_display_name: Nightly 12:28:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:28:45 INFO - mozversion application_name: Firefox 12:28:45 INFO - mozversion application_remotingname: firefox 12:28:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:28:45 INFO - mozversion application_vendor: Mozilla 12:28:45 INFO - mozversion application_version: 50.0a1 12:28:45 INFO - mozversion platform_buildid: 20160629102628 12:28:45 INFO - mozversion platform_changeset: 1a1d7ef3cb0e6076f98088b57ebf7c2946e4c52f 12:28:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:28:45 INFO - mozversion platform_version: 50.0a1 12:28:45 INFO - using testdate: 1467228525 12:28:45 INFO - actual date: 1467228525 12:28:45 INFO - starting webserver on 'localhost:52764' 12:28:45 INFO - SUITE-START | Running 2 tests 12:28:45 INFO - TEST-START | dromaeo_css 12:28:45 INFO - operating with platform_type : mac_ 12:28:45 INFO - Initialising browser for dromaeo_css test... 12:28:45 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpfZRmmE/profile http://localhost:52764/getInfo.html) 12:28:47 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 12:28:47 INFO - PROCESS | 1925 | colorDepth:24 12:28:47 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 12:28:47 INFO - PROCESS | 1925 | __metrics 12:28:47 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:28:48 INFO - TEST-INFO | 1925: exit 0 12:28:48 INFO - Browser initialized. 12:28:48 INFO - Running cycle 1/1 for dromaeo_css test... 12:28:48 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpfZRmmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:00 INFO - PROCESS | 1928 | RSS: Main: 255569920 12:29:00 INFO - PROCESS | 1928 | 12:29:50 INFO - PROCESS | 1928 | 1467228590384 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] 12:32:01 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52764/tests/dromaeo/cssquery-ext.html) 12:32:02 INFO - PROCESS | 1928 | RSS: Main: 268013568 12:32:02 INFO - PROCESS | 1928 | 12:35:04 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-ext.html (next: http://localhost:52764/tests/dromaeo/cssquery-jquery.html) 12:35:05 INFO - PROCESS | 1928 | RSS: Main: 276516864 12:35:05 INFO - PROCESS | 1928 | 12:38:07 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52764/tests/dromaeo/cssquery-mootools.html) 12:38:08 INFO - PROCESS | 1928 | RSS: Main: 281419776 12:38:08 INFO - PROCESS | 1928 | 12:41:09 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52764/tests/dromaeo/cssquery-prototype.html) 12:41:10 INFO - PROCESS | 1928 | RSS: Main: 280383488 12:41:10 INFO - PROCESS | 1928 | 12:44:13 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52764/tests/dromaeo/cssquery-yui.html) 12:44:13 INFO - PROCESS | 1928 | RSS: Main: 283934720 12:44:13 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-yui.html (next: http://localhost:52764/tests/dromaeo/cssquery-dojo.html) 12:47:16 INFO - PROCESS | 1928 | RSS: Main: 284151808 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | __start_tp_report 12:47:16 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 12:47:16 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 12:47:16 INFO - PROCESS | 1928 | |i|pagename|runs| 12:47:16 INFO - PROCESS | 1928 | |0;dojo.html;2960.422717570074;3331.2005118771485;3339.8998030059106;3354.530365748794;3356.4797456394253;5675.177099320596;5709.314882214135;5808.448197421249;5830.795922142725;5844.7662093516265;4391.890202744925;5628.099504079348;5698.601097923147;5759.884802303952;5769;5139.9206166705135;5173.224016397533;5257.421683614799;5257.658252213613;5324.254604355393;428.2858615917582;5251.186066159751;5258.973705131469;5265.131253343213;5306.442823503535;5082.898342033157;5237.240600112981;5242.580593552526;5244.475552444763;5269.341332333458;4289.2922667759785;5139.948600513984;5250.212468129773;5266.710330931797;5286.682799032071;4836.927446088276;5104.9744751276;5139.794408223666;5178.559822415062;5219.5041471060185;5647.265855438808;5734.512566431858;5803.21656576361;5804.564657650693;5821.18503409523;6129.7854575090105;6181.907271390933;6267.279262884781;6302.590331628429;6316.052592111174;4669;6245.188125543696;6288.402601752826;6303.432691057781;6498;5877.559183061245;5889.146073819272;5892.1161825726485;5897.410258974069;5914.37899020601;5184.377874655065;5262.526372626482;6215.378462153749;6218.81343559694;6337.2395312562785;5097.362829646294;6239.469645080128;6251.343608921089;6252.093446450239;6278.246610406781;5156.587473002151;6279.277883043417;6284.277308109535;6305.414779940203;6317.368263173646;6105.236845394325;6142.314611233313;6214.4407003369915;6230.096635987847;6312.210973628296;6137.5302083125;6165.722542485599;6178.073289006685;6256.468200202943;6274.592151510137;5051.343325367752;5052.9242061369105;5055.140626093573;5060.51925067118;5062.392512898476;4415.359772832985;4429.689921705514;4460.598546130864;4529.207388707029;4556.840510582114;5684.744186511617;5842.649441033552;5928.140419639214;5953.226080609493;5953.493953014043;6272.717727702265;6302.401271879165;6306.873862522724;6307.810765677037;6311.368863113652;5733.885322293614;5859.853503662357;5898.321693005273;5933.080372542263;5974;5451.04606693827;5456.836294911159;5465.617406781487;5472.20653005312;5475.233467314579;6185.381461853779;6407.487401007908;6411.4229719325485;6419.51853610981;6427.068075129174;6214.751409943552;6237.656928868956;6274.717637706405;6296.401841825019;6304.18045654062;6348.77779277723;6384.808455746335;6401.263854656588;6420.903686444801;6434.710438030206;6122;6146.907796383147;6258.749650013949;6280.0893870389455;6287.654179020198;6219.284782250099;6260.906086408617;6306.306306306211;6310.400511951358;6336.271328797063;5876.529877609695;6127.142200091902;6202.7208775606105;6208.192934918432;6224.751009959551;5778.104393818965;6095.512359011357;6120.812855101138;6223.595466294676;6234.3453937337745;5843.357230704704;5891.1457838614015;5937.139114828412;6002.249718785152;6070;6149.569530132848;6205.47253483459;6217;6218.347073557211;6245.250569931637;5895.7052147393315;5993.640381577119;6035.78874739382;6041.969790151021;6127.448529632355 12:47:16 INFO - PROCESS | 1928 | |1;ext.html;454.37296530787506;501.5160370242715;527.678116349027;533.519832151064;536.7530935769546;27374.86312568437;41323.760287191355;41339.966500837494;41360.79319603405;41382.7930860346;41321.58678413215;41821.58178418215;41875.581244187546;41885.371719424154;42039.36940945888;9505.239580833533;9705.854412183788;9710.902890971105;9721.173700235453;9739.220862331033;9592.760180995496;9684.12842844144;9691.515424228795;9714.31999760017;9748.658796942109;9727.270454715925;9751.414915105117;9754.512274386288;9754.756131096743;9828.115469607734;8069.072056713494;8449.873251901226;9650.083242092025;9705.563249653713;9710.320277580537;8095.150009249061;9577.90422095784;9638.518074096337;9649.421034737868;9659.855102173402;33289.6671033289;39317;39404;39629.40555891664;39831;3034.8027378220345;3078.5074388097796;3242.983785081083;3253.2842774589553;3466.5493485846678;29215.85392073026;30514.54228186579;31150.06549803487;31259.062228133193;31311.686883131333;3102.813831170137;3134.2634480896972;3206.3426997465463;3297.7361811055057;3316.502524621302;368725;429660;433906;435420;438326.9999999968;30577.38845223083;32598.674013259562;33606.66393336084;33611.15972100668;33739;33457.665423345454;33522;34092.829535852165;34365.65634343675;34378.48432273518;14564;14695.632609184642;14710.63223419423;14841.480548180762;14910.925445372704;12677.049221308438;12788.104832661624;12788.488460461664;12805.231686098863;12810.935945320214;7590.127135379392;7628.160902300742;7677.347425468786;7701.653425595861;7701.998740163855;3198.4882418812876;3208.5668434761474;3219.0825614699697;3223.0814217947773;3269.5749552558013;899.9010108888017;925.8518637018045;942.6135284533308;975.0541974284932;1005;26671.86664066706;29124.563131553045;29932.251693707396;30084.947026853955;30138;1043.4678314059731;1056.2447849787438;1088.5319312695458;1122.4836575175348;1176.2589568571746;15654.060756354655;15706.921465392828;15751.842481575266;15779.842201577838;16100.597485062966;669065;680494;689184;692457.5377123082;693165.5341723259;58303.708481457325;58893;58899.41100589025;58965.82068358695;59098.704506477196;1187.8515185601973;1337.5987203838808;1343.06656873472;1371.814805001332;1372.0395722993944;25280.74719252784;27396.45207095887;29949.85025074861;30662.540061898642;30772.922947696723;44769.77615111903;56385.43614563802;58303.12545311739;58313;60930.56277749018;628068;636481;640039;640086;641182;43828.687723218536;44566;44668;44956.201751929555;45152.54847451615;48349.27476087791;48528.27207591818;48758.53724388274;49083.754581226865;49738.25392619186;39356.80321598374;40669.38995915123;40957;41583;42049.369259461746;36541.634583653824;36559.81720091382;40300.79849600733;41001.97495062647;41790.582094178666;38818;39300;39343.80328098341;39442.40836387514;39561;33028.50457243191;34536.82731586326;35683.92948211558;36218;36333.81833090818;26107.216783496526;26173.60739588946;26245;26276.605850912634;26519.86740066287 12:47:16 INFO - PROCESS | 1928 | |2;jquery.html;376.21746766725215;378.1284140057168;383.8483798899435;393.4098851722416;399.504614278295;19872.503187420323;21396.49853731953;21507.892460537696;22064.88967555164;22096.447588810268;20579.073941672625;21145.471363215926;21458;21489.46276343088;21591;5564.4713752193675;5876.618019828718;5916.112583112546;5932.6143800653035;5997.130416089664;3850.634189751969;5798.3331916829475;5906.763729450817;6137.723802428902;6153;5899;6049.818505444844;6111.327753947062;6134.846628834271;6147.7233524491285;5945.286565612154;5999.640021598674;6122.63264204147;6139.263288405397;6156.1996940397685;4031.879043628696;5315.681059136464;5725.341585717654;5749.683767392792;5866;13141.605751827461;13260.53588124411;13356.799648005288;13360.39878205483;20422.69365959512;1865.6082222733241;2304.51605162916;2308.815294776414;2419.721732000825;2877.2519145022234;9968.551415186334;10067.848982265272;10576.735581610445;10880.564777408894;15825.52523424299;1761.5772214668516;1825.963480730378;1840.6226723521645;1869.672807258738;1889.3576184097474;129295;133204.3339783295;134055;134863.32568337195;134928.6507134926;11453.427328633536;11633.302001879914;11636;11649.534018639159;11756.353400563052;14582.4896128635;14583.854161458461;14594.124352538882;14601.342939567745;14692.779608305884;8613.095624959415;8674.39279250459;8703.216710496086;8712.738617841474;8725.21473067427;8641.783955401166;8641.870371944426;8658.354912566718;8713.128687131237;8728.519931403707;4508.48152462471;4586.4266966629175;4589.242774942097;4595.172868883633;4614.515475874985;1592.896461729984;1738.452387497934;1788.937387191442;1867.9719804202948;1909.9140538675792;827.4869580859905;844.9691376520635;904.8235594059227;988.204495381225;1023.6673081248475;21407.57184856294;21563;21661.025253863612;21749.238776642742;22223.333300001024;906.9727908162765;951.6478902806006;959.165525992391;965.3098034905076;992.3698451483216;8918.687845925362;10981.341119532854;11429.085673146128;11582.247153934968;11611.303321800719;589352;593853;601078;612340;612754;76804.61597691975;137055;137752;140466;141660.29169854085;941.317544780029;954.9999999999861;972.0765272990687;976.5312649927932;977.7604486900755;16492.752608710638;18721.906390468506;19121.279084882426;19211;19627.80372196317;51558.48441515537;51900.74049629728;51934.740326298124;53760.19359709529;56085;74278.25721742713;74756.50486990338;74899.25100748923;75960;76492;8186.7953301167945;8279.793005174919;8284.83430331402;8292.17078292166;8486.151384861465;12843.422046007765;13065.673358166121;13107;13129.671758205739;13144.342782860627;11258.38078905668;11277.605283815026;11379.943100284445;11396.601118960796;11432.199746017699;8720.78198045054;9704.951475242578;11008.669739907815;11289.887101129212;11310;11408.429578520874;11542.961133498025;11585.942070289932;11660.650180494598;11692.064634829023;8079.3536517079665;8208.507489550646;8296.668133274843;8411.53736544496;8416.957915210385;9339.346245762732;9715.854262185932;10432.582696692047;11367.488463019019;11487.597934072268 12:47:16 INFO - PROCESS | 1928 | |3;mootools.html;1518.2181176694005;1559.6412825050238;1775.698131317676;1892.8391086757633;1902.7145928110774;7983.802429635558;8542;8829.29365650748;9000.45997240166;9002.099790020995;6923;8650.307975361971;8761.299096072315;8790.6923257686;8799.692010779623;2326.325365643961;2354.0819080558595;2358.870262135582;2361.161787565415;2363.8936247868887;2309.618912879373;2323.9651405228933;2324.2213858357472;2333.5449587330477;2343.660169275454;2342.8711420871846;2349.0368948731025;2355.5053438777877;2357.139644029934;2364.18435639704;2295.5523672883796;2327.6043072677685;2335.544568809083;2341.543399037197;2348.095983046522;2327.0226504867996;2328.5342931413616;2329.603967325542;2333.7316208636053;2338.3452633262546;8736.694215702484;8765.254953328975;8851.46891186531;8872.245859101984;8890.06654301302;5165.690058596496;5180.611454140917;5309.150535914274;5322.787088516455;5357.357117145929;3557.3596752584526;3601.8919432416806;3667.5965643779164;3671.1372827385544;3696.1334526064434;1069.6951368859916;1080.195254535376;1095.8575385199952;1100.257326304749;1118.5693507999479;9736.95131524338;10506.84239736397;11618.767624647544;11683.123765717604;11714.824277635842;4554.43069616298;4589.609883159902;4758.904821903542;4796.736179510091;4806.759662016885;8149.837003259901;8538.231559159705;9864.802703945881;9866.358686685486;9868.50657467138;5287.154055351125;5300.1519756838725;5309.495597918191;5316.680999140064;5326.627136100513;4368.759718215529;4698.647601429906;4746.477887432379;4864.343313652683;4872.074305881871;3205.246767009751;3517.8416971236356;3885.3589157788647;3933.586973367755;4032.6773858091283;1050.4012712753656;1066.9679909602723;1085.234909388879;1227.6378468351857;1278.2458349573797;882.2677177942293;889.4352086425038;912.9726108216764;918.554501066982;932.5943214701626;6008.09878518217;6071.726772295257;6080;6129.019356902963;6240.521988985601;905.463093185181;931.6273490603812;935.9766005849908;964.8263312603799;971.504532688334;3954.9209015819524;4048.817803198863;4106.507219133723;4108.383742438658;4113.239050775616;10396.16830653546;10703.304285221435;10783;10824.4046577439;10829;10630.46847657614;10650.254482186172;10781.838272425919;10807.35155890649;10825.07986821129;8049.55727434985;8215.219554142346;8278.958605206935;8321.708740194184;8347.874781878276;5796.449337312949;5828.883422331614;5869.6771677558145;5907.232059832194;5993.430624090704;9979.201663866728;10007.049330313608;10044.949775251076;10067;10133.986601339808;8985.371024028254;10113.988601139827;10151.847722284025;10275.17798576097;10305.381677099398;6537.182852143482;6894.965525172342;7072.469564782559;7132.928670713434;7149.106361704787;8404.915950840657;8498.872516912375;8520.573971301286;8576;8576.828463430822;7492.962535187289;7556.8488630228185;7586;7681.731139410093;7719.614019299125;7413.1104267488245;7423.257674232534;7457.925420745723;7588.165301816685;7610.505317154367;7031.929680703332;7055.2944705529035;7058.894116588358;7080.2919708028785;7082.716691332289;4855.101806165871;5042.915773108799;5115;5125.154349532286;5146.665466744649;4990.850274491771;5043.218301163325;5089.465606111305;5146.974265128651;5238.423773384849 12:47:16 INFO - PROCESS | 1928 | |4;prototype.html;291.63836842315527;303.615925853795;306.904859493557;307.9698408822489;310.3358812142015;5461.672299662018;5479.890402191953;5484.588655850807;5503.449655034495;5515.779368825247;4365.930347064974;4962.900741985158;4989.4055091352475;5099.541041306291;5264.631195889077;3448.6896179343853;3919.804009799506;4026.892604533762;4071.4707088078508;4093.2427500912277;3552.1829979104823;4039.939400908989;4124.618252885287;4140.689448291375;4150.211459822639;3229.838508074587;3346.6318704942437;3639.381305178113;3991.880243592697;4111.403846442279;3164.955564663667;3584.8028358440274;3651.6488899107235;3823.6426068745473;3872.883813485586;3465.8440370183403;3470.6355832637464;3474.739394545419;3483.965160348415;3495.7727747696317;5214.843554693365;5235.738213089368;5250.68495890244;5277.788888444457;5290.365156181244;4044.817983190734;4509.616682581985;4652.534746525354;4657.115148121846;4674.859754207345;4461.375407442961;4650.720956742606;5503.064479038573;5563.554915606742;5680.318361796611;2995.430868135047;3390.525121572124;3461.238527523941;3720.962790372089;3851.9614803852164;4352.912941741148;5388.568914486832;5560.666360018371;5773.037167363117;5929.466348028698;3359.824061578428;3580.5524309461316;3823;3917.8236979335998;3930.5283365995692;3924.3524818404644;3991.4811074560703;4011.498562679665;4015.0966032642423;4035.7780322082567;4266.381374700651;4665.813367465331;4677.789499472464;4680.555347242007;4697.31888876111;4856.80572777092;5639.603168653306;5793.710314484259;5821.88356232873;5838.4453476919625;1069.235496619905;1350.4193196925416;1365.3855764905634;1367.131871261736;1385.5081446086494;737.1633196322213;799.792054065947;833.6869430646756;840.2521755637365;840.6427268411023;4270.722403043855;4653.813847446132;4951.777170027357;5313.946860531422;5317.7872885084935;5850.23946886902;5905.261842269716;5909.468147866713;5944.583879128506;5951.851203719942;4943.9258411123865;5268.525832675001;5307.4692530746615;5331.573474122139;5426.945730542723;2916.4458752836895;3088.830114343688;3113.5952326197903;3115.2367669921014;3131.389379071105;4987.426445958688;5143.099957507421;6160.815175544741;6161.938380616226;6188.412100850412;5350.545203657655;5646.85882852932;6108.72510737009;6111.694415279218;6113.786017489367;4719.480857105716;5378.2739330189925;6160.907586386208;6179.5983261086985;6185.41238582334;5208.401033881152;5507.366652834975;5526.839363733661;5872.677002764889;5888.852778680396;4743.762811859462;4877.365942427462;5878.0616986618215;5887.499562537232;5908.586398952032;6140.482402215071;6164.907526387018;6168.9691551541955;6207.503399727921;6213.875722485615;3450.3961806684233;3642.7814331140216;3944.4872166618156;3960.8415663373144;3982.581828907923;4895.73073480962;5794.710264486843;5837.066069428871;5842.152887831326;5845.590808643354;4415.779211039371;5710.314762228393;5727.713614319351;5734.99637563433;5774.48029677331;4498.942748454046;5407.918881216863;5518.171599850131;5685.118806584986;5711.428857114255;4260.744355338689;5142.485751424977;5646.153077038477;5671.347795003628;5690.004249256446;4830.855074347634;5699.230603868425;5733.340665823317;5733.340665823317;5771.855703607275;4704.858854234379;5648.717564121695;5670.716464176692;5678.261825962599;5680.733578192473 12:47:16 INFO - PROCESS | 1928 | |5;yui.html;694.9930500694994;729.9635018249093;749.9887501687472;782.4405550031726;787.5629025890632;11331.490082946266;14531.12813231207;15434;15791.44729934451;15855.365785368585;13745.106568073094;13746.793798093036;14094.083884547523;14115.647108822259;14243.216623085726;666.3270097201813;815.0504662068682;832.1428928203944;848.817504236589;848.868425394065;848.8514509960763;851.825375797963;854.0989256334565;854.74784938443;856.5802756649229;883.995580022099;890.1988210610438;895.807401408697;910.1399177777004;910.276330317396;879.1999280654574;879.366855863777;892.9821403571892;906.0169715858302;908.4503875155535;653.8561516466369;653.9738410463576;655.4526969980072;668.7091115364832;674.639068098565;12375.443105060294;12762.936185319015;14709.485168019068;14724.19016954067;14829.110253384832;12041.819372709417;12170;14810.777838332433;14821.703565928728;15005.3247603857;11999.280043197436;12003.93998030013;12010.219335743148;12011.579594714143;12173.093614383137;3400.6769356911054;3835.5780864104927;3897.824597893073;3937.8031098444962;4038.575949525287;102806;107264.4636776819;110976.4451177747;111622;115067.84932150655;11505.884941150482;11603.419829008515;11615.36115513638;11681.415929203506;11689.298642081503;23542.17602383908;24088;24166.879165604412;24203.39491512726;24257.75742242555;8163.0612479564425;8213.630386632616;8400.873986890201;8435.789105272295;8483.872741908875;4471.530489298577;4478.955210447919;4585.10590434862;4597.103564804898;4601.953980460219;3211.309568442796;3803.372443546784;3806.5812760596314;3807.5430948286385;3946.1910308386714;720.1178556268529;726.0778810910115;726.96728647211;734.6693987705554;741.6514238307986;551.8923809857039;553.9473749993745;568.7937700703276;607.6111288775187;627.3851625407035;9084.772880678036;9496.447143821211;9511.191548718436;9532.571034303335;9730.61077556904;562.8902364039055;602.5601311042964;656.5076192855358;662.2814246542459;672.2168673495421;4025.9597404025585;4414.580614841585;4576.4508259009135;4597.839075632403;4680.859574212779;123634;153355.6996645051;154463.6830447544;158415;161812;109059.45470272598;139888.6011139896;141833;142482;144093.27953360375;54016.72991634938;121524;122525.64846109261;123286;124561;9789.265805064506;9877.30858839903;9998.450085245091;10000.799984000425;10108.1408080314;47415.52584474111;56078;56203.43796562146;58367.12449313349;63885;62255.443613910014;77867;77877.221227787;90531.64202536836;90745.09254907367;12087.274763514217;13308.86691133115;13355.26546039977;13396.531121410704;14029.3686784097;12358.75282494327;14997.475088371855;15024.624384390478;15177.24113794328;15758.921205393899;11855.407229638657;13648.529881751374;13682.247476388895;13725.862741372459;13994.230317332644;10243.539040743035;12154.75690486203;13386.598402047954;14020.088694234842;14405.279736013366;10199.54102065394;10833.620823271147;13463.596092117252;14230.573082807532;14248.073875198079;11264.211505194558;11375.715607109889;11462.828057578976;11649.534018639159;11847.703807404883;9716.465594392377;10718.265021886067;10729.678109656723;10813.56745730162;11705.239159454608 12:47:16 INFO - PROCESS | 1928 | __end_tp_report 12:47:16 INFO - PROCESS | 1928 | __start_cc_report 12:47:16 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,432 12:47:16 INFO - PROCESS | 1928 | __end_cc_report 12:47:16 INFO - PROCESS | 1928 | __startTimestamp1467229636580__endTimestamp 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | ------- Summary: start ------- 12:47:16 INFO - PROCESS | 1928 | Number of tests: 6 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5715.22 Median:5937.14 stddev:797.37 (13.4%) stddev-sans-first:769.97 12:47:16 INFO - PROCESS | 1928 | Values: 2960.4 3331.2 3339.9 3354.5 3356.5 5675.2 5709.3 5808.4 5830.8 5844.8 4391.9 5628.1 5698.6 5759.9 5769.0 5139.9 5173.2 5257.4 5257.7 5324.3 428.3 5251.2 5259.0 5265.1 5306.4 5082.9 5237.2 5242.6 5244.5 5269.3 4289.3 5139.9 5250.2 5266.7 5286.7 4836.9 5105.0 5139.8 5178.6 5219.5 5647.3 5734.5 5803.2 5804.6 5821.2 6129.8 6181.9 6267.3 6302.6 6316.1 4669.0 6245.2 6288.4 6303.4 6498.0 5877.6 5889.1 5892.1 5897.4 5914.4 5184.4 5262.5 6215.4 6218.8 6337.2 5097.4 6239.5 6251.3 6252.1 6278.2 5156.6 6279.3 6284.3 6305.4 6317.4 6105.2 6142.3 6214.4 6230.1 6312.2 6137.5 6165.7 6178.1 6256.5 6274.6 5051.3 5052.9 5055.1 5060.5 5062.4 4415.4 4429.7 4460.6 4529.2 4556.8 5684.7 5842.6 5928.1 5953.2 5953.5 6272.7 6302.4 6306.9 6307.8 6311.4 5733.9 5859.9 5898.3 5933.1 5974.0 5451.0 5456.8 5465.6 5472.2 5475.2 6185.4 6407.5 6411.4 6419.5 6427.1 6214.8 6237.7 6274.7 6296.4 6304.2 6348.8 6384.8 6401.3 6420.9 6434.7 6122.0 6146.9 6258.7 6280.1 6287.7 6219.3 6260.9 6306.3 6310.4 6336.3 5876.5 6127.1 6202.7 6208.2 6224.8 5778.1 6095.5 6120.8 6223.6 6234.3 5843.4 5891.1 5937.1 6002.2 6070.0 6149.6 6205.5 6217.0 6218.3 6245.3 5895.7 5993.6 6035.8 6042.0 6127.4 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:69956.32 Median:40065.90 stddev:159041.37 (396.9%) stddev-sans-first:159401.91 12:47:16 INFO - PROCESS | 1928 | Values: 454.4 501.5 527.7 533.5 536.8 27374.9 41323.8 41340.0 41360.8 41382.8 41321.6 41821.6 41875.6 41885.4 42039.4 9505.2 9705.9 9710.9 9721.2 9739.2 9592.8 9684.1 9691.5 9714.3 9748.7 9727.3 9751.4 9754.5 9754.8 9828.1 8069.1 8449.9 9650.1 9705.6 9710.3 8095.2 9577.9 9638.5 9649.4 9659.9 33289.7 39317.0 39404.0 39629.4 39831.0 3034.8 3078.5 3243.0 3253.3 3466.5 29215.9 30514.5 31150.1 31259.1 31311.7 3102.8 3134.3 3206.3 3297.7 3316.5 368725.0 429660.0 433906.0 435420.0 438327.0 30577.4 32598.7 33606.7 33611.2 33739.0 33457.7 33522.0 34092.8 34365.7 34378.5 14564.0 14695.6 14710.6 14841.5 14910.9 12677.0 12788.1 12788.5 12805.2 12810.9 7590.1 7628.2 7677.3 7701.7 7702.0 3198.5 3208.6 3219.1 3223.1 3269.6 899.9 925.9 942.6 975.1 1005.0 26671.9 29124.6 29932.3 30084.9 30138.0 1043.5 1056.2 1088.5 1122.5 1176.3 15654.1 15706.9 15751.8 15779.8 16100.6 669065.0 680494.0 689184.0 692457.5 693165.5 58303.7 58893.0 58899.4 58965.8 59098.7 1187.9 1337.6 1343.1 1371.8 1372.0 25280.7 27396.5 29949.9 30662.5 30772.9 44769.8 56385.4 58303.1 58313.0 60930.6 628068.0 636481.0 640039.0 640086.0 641182.0 43828.7 44566.0 44668.0 44956.2 45152.5 48349.3 48528.3 48758.5 49083.8 49738.3 39356.8 40669.4 40957.0 41583.0 42049.4 36541.6 36559.8 40300.8 41002.0 41790.6 38818.0 39300.0 39343.8 39442.4 39561.0 33028.5 34536.8 35683.9 36218.0 36333.8 26107.2 26173.6 26245.0 26276.6 26519.9 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:35278.29 Median:380.99 stddev:100860.33 (26473.3%) stddev-sans-first:101109.22 12:47:16 INFO - PROCESS | 1928 | Values: 376.2 378.1 383.8 393.4 399.5 19872.5 21396.5 21507.9 22064.9 22096.4 20579.1 21145.5 21458.0 21489.5 21591.0 5564.5 5876.6 5916.1 5932.6 5997.1 3850.6 5798.3 5906.8 6137.7 6153.0 5899.0 6049.8 6111.3 6134.8 6147.7 5945.3 5999.6 6122.6 6139.3 6156.2 4031.9 5315.7 5725.3 5749.7 5866.0 13141.6 13260.5 13356.8 13360.4 20422.7 1865.6 2304.5 2308.8 2419.7 2877.3 9968.6 10067.8 10576.7 10880.6 15825.5 1761.6 1826.0 1840.6 1869.7 1889.4 129295.0 133204.3 134055.0 134863.3 134928.7 11453.4 11633.3 11636.0 11649.5 11756.4 14582.5 14583.9 14594.1 14601.3 14692.8 8613.1 8674.4 8703.2 8712.7 8725.2 8641.8 8641.9 8658.4 8713.1 8728.5 4508.5 4586.4 4589.2 4595.2 4614.5 1592.9 1738.5 1788.9 1868.0 1909.9 827.5 845.0 904.8 988.2 1023.7 21407.6 21563.0 21661.0 21749.2 22223.3 907.0 951.6 959.2 965.3 992.4 8918.7 10981.3 11429.1 11582.2 11611.3 589352.0 593853.0 601078.0 612340.0 612754.0 76804.6 137055.0 137752.0 140466.0 141660.3 941.3 955.0 972.1 976.5 977.8 16492.8 18721.9 19121.3 19211.0 19627.8 51558.5 51900.7 51934.7 53760.2 56085.0 74278.3 74756.5 74899.3 75960.0 76492.0 8186.8 8279.8 8284.8 8292.2 8486.2 12843.4 13065.7 13107.0 13129.7 13144.3 11258.4 11277.6 11379.9 11396.6 11432.2 8720.8 9705.0 11008.7 11289.9 11310.0 11408.4 11543.0 11585.9 11660.7 11692.1 8079.4 8208.5 8296.7 8411.5 8417.0 9339.3 9715.9 10432.6 11367.5 11487.6 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5683.06 Median:5066.34 stddev:3152.66 (62.2%) stddev-sans-first:3145.96 12:47:16 INFO - PROCESS | 1928 | Values: 1518.2 1559.6 1775.7 1892.8 1902.7 7983.8 8542.0 8829.3 9000.5 9002.1 6923.0 8650.3 8761.3 8790.7 8799.7 2326.3 2354.1 2358.9 2361.2 2363.9 2309.6 2324.0 2324.2 2333.5 2343.7 2342.9 2349.0 2355.5 2357.1 2364.2 2295.6 2327.6 2335.5 2341.5 2348.1 2327.0 2328.5 2329.6 2333.7 2338.3 8736.7 8765.3 8851.5 8872.2 8890.1 5165.7 5180.6 5309.2 5322.8 5357.4 3557.4 3601.9 3667.6 3671.1 3696.1 1069.7 1080.2 1095.9 1100.3 1118.6 9737.0 10506.8 11618.8 11683.1 11714.8 4554.4 4589.6 4758.9 4796.7 4806.8 8149.8 8538.2 9864.8 9866.4 9868.5 5287.2 5300.2 5309.5 5316.7 5326.6 4368.8 4698.6 4746.5 4864.3 4872.1 3205.2 3517.8 3885.4 3933.6 4032.7 1050.4 1067.0 1085.2 1227.6 1278.2 882.3 889.4 913.0 918.6 932.6 6008.1 6071.7 6080.0 6129.0 6240.5 905.5 931.6 936.0 964.8 971.5 3954.9 4048.8 4106.5 4108.4 4113.2 10396.2 10703.3 10783.0 10824.4 10829.0 10630.5 10650.3 10781.8 10807.4 10825.1 8049.6 8215.2 8279.0 8321.7 8347.9 5796.4 5828.9 5869.7 5907.2 5993.4 9979.2 10007.0 10044.9 10067.0 10134.0 8985.4 10114.0 10151.8 10275.2 10305.4 6537.2 6895.0 7072.5 7132.9 7149.1 8404.9 8498.9 8520.6 8576.0 8576.8 7493.0 7556.8 7586.0 7681.7 7719.6 7413.1 7423.3 7457.9 7588.2 7610.5 7031.9 7055.3 7058.9 7080.3 7082.7 4855.1 5042.9 5115.0 5125.2 5146.7 4990.9 5043.2 5089.5 5147.0 5238.4 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:4542.68 Median:5044.47 stddev:1449.07 (28.7%) stddev-sans-first:1417.58 12:47:16 INFO - PROCESS | 1928 | Values: 291.6 303.6 306.9 308.0 310.3 5461.7 5479.9 5484.6 5503.4 5515.8 4365.9 4962.9 4989.4 5099.5 5264.6 3448.7 3919.8 4026.9 4071.5 4093.2 3552.2 4039.9 4124.6 4140.7 4150.2 3229.8 3346.6 3639.4 3991.9 4111.4 3165.0 3584.8 3651.6 3823.6 3872.9 3465.8 3470.6 3474.7 3484.0 3495.8 5214.8 5235.7 5250.7 5277.8 5290.4 4044.8 4509.6 4652.5 4657.1 4674.9 4461.4 4650.7 5503.1 5563.6 5680.3 2995.4 3390.5 3461.2 3721.0 3852.0 4352.9 5388.6 5560.7 5773.0 5929.5 3359.8 3580.6 3823.0 3917.8 3930.5 3924.4 3991.5 4011.5 4015.1 4035.8 4266.4 4665.8 4677.8 4680.6 4697.3 4856.8 5639.6 5793.7 5821.9 5838.4 1069.2 1350.4 1365.4 1367.1 1385.5 737.2 799.8 833.7 840.3 840.6 4270.7 4653.8 4951.8 5313.9 5317.8 5850.2 5905.3 5909.5 5944.6 5951.9 4943.9 5268.5 5307.5 5331.6 5426.9 2916.4 3088.8 3113.6 3115.2 3131.4 4987.4 5143.1 6160.8 6161.9 6188.4 5350.5 5646.9 6108.7 6111.7 6113.8 4719.5 5378.3 6160.9 6179.6 6185.4 5208.4 5507.4 5526.8 5872.7 5888.9 4743.8 4877.4 5878.1 5887.5 5908.6 6140.5 6164.9 6169.0 6207.5 6213.9 3450.4 3642.8 3944.5 3960.8 3982.6 4895.7 5794.7 5837.1 5842.2 5845.6 4415.8 5710.3 5727.7 5735.0 5774.5 4498.9 5407.9 5518.2 5685.1 5711.4 4260.7 5142.5 5646.2 5671.3 5690.0 4830.9 5699.2 5733.3 5733.3 5771.9 4704.9 5648.7 5670.7 5678.3 5680.7 12:47:16 INFO - PROCESS | 1928 | 12:47:16 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:24577.87 Median:3305.99 stddev:39938.10 (1208.1%) stddev-sans-first:40009.88 12:47:16 INFO - PROCESS | 1928 | Values: 695.0 730.0 750.0 782.4 787.6 11331.5 14531.1 15434.0 15791.4 15855.4 13745.1 13746.8 14094.1 14115.6 14243.2 666.3 815.1 832.1 848.8 848.9 848.9 851.8 854.1 854.7 856.6 884.0 890.2 895.8 910.1 910.3 879.2 879.4 893.0 906.0 908.5 653.9 654.0 655.5 668.7 674.6 12375.4 12762.9 14709.5 14724.2 14829.1 12041.8 12170.0 14810.8 14821.7 15005.3 11999.3 12003.9 12010.2 12011.6 12173.1 3400.7 3835.6 3897.8 3937.8 4038.6 102806.0 107264.5 110976.4 111622.0 115067.8 11505.9 11603.4 11615.4 11681.4 11689.3 23542.2 24088.0 24166.9 24203.4 24257.8 8163.1 8213.6 8400.9 8435.8 8483.9 4471.5 4479.0 4585.1 4597.1 4602.0 3211.3 3803.4 3806.6 3807.5 3946.2 720.1 726.1 727.0 734.7 741.7 551.9 553.9 568.8 607.6 627.4 9084.8 9496.4 9511.2 9532.6 9730.6 562.9 602.6 656.5 662.3 672.2 4026.0 4414.6 4576.5 4597.8 4680.9 123634.0 153355.7 154463.7 158415.0 161812.0 109059.5 139888.6 141833.0 142482.0 144093.3 54016.7 121524.0 122525.6 123286.0 124561.0 9789.3 9877.3 9998.5 10000.8 10108.1 47415.5 56078.0 56203.4 58367.1 63885.0 62255.4 77867.0 77877.2 90531.6 90745.1 12087.3 13308.9 13355.3 13396.5 14029.4 12358.8 14997.5 15024.6 15177.2 15758.9 11855.4 13648.5 13682.2 13725.9 13994.2 10243.5 12154.8 13386.6 14020.1 14405.3 10199.5 10833.6 13463.6 14230.6 14248.1 11264.2 11375.7 11462.8 11649.5 11847.7 9716.5 10718.3 10729.7 10813.6 11705.2 12:47:16 INFO - PROCESS | 1928 | -------- Summary: end -------- 12:47:16 INFO - PROCESS | 1928 | 12:47:17 INFO - TEST-INFO | 1928: exit 0 12:47:17 INFO - TEST-OK | dromaeo_css | took 1112141ms 12:47:17 INFO - TEST-START | kraken 12:47:17 INFO - operating with platform_type : mac_ 12:47:17 INFO - Initialising browser for kraken test... 12:47:17 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpix4gly/profile http://localhost:52764/getInfo.html) 12:47:20 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 12:47:20 INFO - PROCESS | 1934 | colorDepth:24 12:47:20 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 12:47:20 INFO - PROCESS | 1934 | __metrics 12:47:20 ERROR - PROCESS | 1934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:47:21 INFO - TEST-INFO | 1934: exit 0 12:47:21 INFO - Browser initialized. 12:47:21 INFO - Running cycle 1/1 for kraken test... 12:47:21 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpix4gly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:33 INFO - PROCESS | 1936 | RSS: Main: 255729664 12:47:33 INFO - PROCESS | 1936 | 12:47:35 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-beat-detection) 12:47:36 INFO - PROCESS | 1936 | RSS: Main: 268615680 12:47:36 INFO - PROCESS | 1936 | 12:47:39 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-dft) 12:47:40 INFO - PROCESS | 1936 | RSS: Main: 272572416 12:47:40 INFO - PROCESS | 1936 | 12:47:43 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-fft) 12:47:44 INFO - PROCESS | 1936 | RSS: Main: 273354752 12:47:44 INFO - PROCESS | 1936 | 12:47:46 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-oscillator) 12:47:46 INFO - PROCESS | 1936 | RSS: Main: 274284544 12:47:46 INFO - PROCESS | 1936 | 12:47:49 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:47:49 INFO - PROCESS | 1936 | RSS: Main: 275054592 12:47:49 INFO - PROCESS | 1936 | 12:47:52 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-darkroom) 12:47:53 INFO - PROCESS | 1936 | RSS: Main: 275771392 12:47:53 INFO - PROCESS | 1936 | 12:47:56 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-desaturate) 12:47:56 INFO - PROCESS | 1936 | RSS: Main: 275791872 12:47:56 INFO - PROCESS | 1936 | 12:47:59 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52764/tests/kraken/driver.html?testName=json-parse-financial) 12:48:00 INFO - PROCESS | 1936 | RSS: Main: 276168704 12:48:00 INFO - PROCESS | 1936 | 12:48:01 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:48:02 INFO - PROCESS | 1936 | RSS: Main: 275996672 12:48:02 INFO - PROCESS | 1936 | 12:48:04 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:48:05 INFO - PROCESS | 1936 | RSS: Main: 275849216 12:48:05 INFO - PROCESS | 1936 | 12:48:07 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:48:08 INFO - PROCESS | 1936 | RSS: Main: 276099072 12:48:08 INFO - PROCESS | 1936 | 12:48:10 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:48:11 INFO - PROCESS | 1936 | RSS: Main: 276008960 12:48:11 INFO - PROCESS | 1936 | 12:48:14 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:48:15 INFO - PROCESS | 1936 | RSS: Main: 275996672 12:48:15 INFO - PROCESS | 1936 | 12:48:16 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52764/tests/kraken/driver.html?testName=ai-astar) 12:48:17 INFO - PROCESS | 1936 | RSS: Main: 277217280 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | __start_tp_report 12:48:17 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 12:48:17 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 12:48:17 INFO - PROCESS | 1936 | |i|pagename|runs| 12:48:17 INFO - PROCESS | 1936 | |0;ai-astar;105;116;106;114;114;117;114;116;119;116 12:48:17 INFO - PROCESS | 1936 | |1;audio-beat-detection;142;112;144;193;114;135;128;111;161;117 12:48:17 INFO - PROCESS | 1936 | |2;audio-dft;198;198;208;221;216;204;199;201;203;193 12:48:17 INFO - PROCESS | 1936 | |3;audio-fft;82;111;95;149;59;62;75;89;153;83 12:48:17 INFO - PROCESS | 1936 | |4;audio-oscillator;69;73;115;101;105;117;127;72;71;119 12:48:17 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;129;90;93;91;92;88;92;89;92;89 12:48:17 INFO - PROCESS | 1936 | |6;imaging-darkroom;122;121;97;97;97;98;118;152;110;152 12:48:17 INFO - PROCESS | 1936 | |7;imaging-desaturate;93;92;102;85;94;92;90;95;89;92 12:48:17 INFO - PROCESS | 1936 | |8;json-parse-financial;55;56;58;59;59;56;58;59;56;57 12:48:17 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;70;69;80;110;121;77;67;70;68;69 12:48:17 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;101;83;88;84;84;83;86;91;86;87 12:48:17 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;129;138;149;152;152;159;137;135;176;155 12:48:17 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;173;170;162;167;166;185;150;217;171;168 12:48:17 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;69;67;69;66;70;66;81;92;77;66 12:48:17 INFO - PROCESS | 1936 | __end_tp_report 12:48:17 INFO - PROCESS | 1936 | __start_cc_report 12:48:17 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1114 12:48:17 INFO - PROCESS | 1936 | __end_cc_report 12:48:17 INFO - PROCESS | 1936 | __startTimestamp1467229697105__endTimestamp 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | ------- Summary: start ------- 12:48:17 INFO - PROCESS | 1936 | Number of tests: 14 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:113.70 Median:116.00 stddev:4.60 (4.0%) stddev-sans-first:3.64 12:48:17 INFO - PROCESS | 1936 | Values: 105.0 116.0 106.0 114.0 114.0 117.0 114.0 116.0 119.0 116.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:138.50 stddev:26.00 (18.8%) stddev-sans-first:27.48 12:48:17 INFO - PROCESS | 1936 | Values: 142.0 112.0 144.0 193.0 114.0 135.0 128.0 111.0 161.0 117.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:204.10 Median:203.50 stddev:8.67 (4.3%) stddev-sans-first:8.91 12:48:17 INFO - PROCESS | 1936 | Values: 198.0 198.0 208.0 221.0 216.0 204.0 199.0 201.0 203.0 193.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:95.80 Median:78.50 stddev:32.77 (41.7%) stddev-sans-first:34.37 12:48:17 INFO - PROCESS | 1936 | Values: 82.0 111.0 95.0 149.0 59.0 62.0 75.0 89.0 153.0 83.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:98.00 stddev:23.21 (23.7%) stddev-sans-first:22.32 12:48:17 INFO - PROCESS | 1936 | Values: 69.0 73.0 115.0 101.0 105.0 117.0 127.0 72.0 71.0 119.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:91.50 stddev:12.23 (13.4%) stddev-sans-first:1.73 12:48:17 INFO - PROCESS | 1936 | Values: 129.0 90.0 93.0 91.0 92.0 88.0 92.0 89.0 92.0 89.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:116.40 Median:124.50 stddev:21.34 (17.1%) stddev-sans-first:22.54 12:48:17 INFO - PROCESS | 1936 | Values: 122.0 121.0 97.0 97.0 97.0 98.0 118.0 152.0 110.0 152.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:92.00 stddev:4.40 (4.8%) stddev-sans-first:4.66 12:48:17 INFO - PROCESS | 1936 | Values: 93.0 92.0 102.0 85.0 94.0 92.0 90.0 95.0 89.0 92.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:1.49 (2.6%) stddev-sans-first:1.33 12:48:17 INFO - PROCESS | 1936 | Values: 55.0 56.0 58.0 59.0 59.0 56.0 58.0 59.0 56.0 57.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:69.50 stddev:19.28 (27.7%) stddev-sans-first:20.10 12:48:17 INFO - PROCESS | 1936 | Values: 70.0 69.0 80.0 110.0 121.0 77.0 67.0 70.0 68.0 69.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:5.42 (6.3%) stddev-sans-first:2.64 12:48:17 INFO - PROCESS | 1936 | Values: 101.0 83.0 88.0 84.0 84.0 83.0 86.0 91.0 86.0 87.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:152.00 stddev:13.89 (9.1%) stddev-sans-first:12.88 12:48:17 INFO - PROCESS | 1936 | Values: 129.0 138.0 149.0 152.0 152.0 159.0 137.0 135.0 176.0 155.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:170.50 stddev:17.80 (10.4%) stddev-sans-first:18.88 12:48:17 INFO - PROCESS | 1936 | Values: 173.0 170.0 162.0 167.0 166.0 185.0 150.0 217.0 171.0 168.0 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:69.50 stddev:8.56 (12.3%) stddev-sans-first:9.00 12:48:17 INFO - PROCESS | 1936 | Values: 69.0 67.0 69.0 66.0 70.0 66.0 81.0 92.0 77.0 66.0 12:48:17 INFO - PROCESS | 1936 | -------- Summary: end -------- 12:48:17 INFO - PROCESS | 1936 | 12:48:17 INFO - TEST-INFO | 1936: exit 0 12:48:17 INFO - TEST-OK | kraken | took 60728ms 12:48:17 INFO - SUITE-END | took 1172s 12:48:18 INFO - Completed test suite (00:19:33) 12:48:18 INFO - javascript benchmark 12:48:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7259.876777935256, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2960.422717570074, 3331.2005118771485, 3339.8998030059106, 3354.530365748794, 3356.4797456394253, 5675.177099320596, 5709.314882214135, 5808.448197421249, 5830.795922142725, 5844.7662093516265, 4391.890202744925, 5628.099504079348, 5698.601097923147, 5759.884802303952, 5769.0, 5139.9206166705135, 5173.224016397533, 5257.421683614799, 5257.658252213613, 5324.254604355393, 428.2858615917582, 5251.186066159751, 5258.973705131469, 5265.131253343213, 5306.442823503535, 5082.898342033157, 5237.240600112981, 5242.580593552526, 5244.475552444763, 5269.341332333458, 4289.2922667759785, 5139.948600513984, 5250.212468129773, 5266.710330931797, 5286.682799032071, 4836.927446088276, 5104.9744751276, 5139.794408223666, 5178.559822415062, 5219.5041471060185, 5647.265855438808, 5734.512566431858, 5803.21656576361, 5804.564657650693, 5821.18503409523, 6129.7854575090105, 6181.907271390933, 6267.279262884781, 6302.590331628429, 6316.052592111174, 4669.0, 6245.188125543696, 6288.402601752826, 6303.432691057781, 6498.0, 5877.559183061245, 5889.146073819272, 5892.1161825726485, 5897.410258974069, 5914.37899020601, 5184.377874655065, 5262.526372626482, 6215.378462153749, 6218.81343559694, 6337.2395312562785, 5097.362829646294, 6239.469645080128, 6251.343608921089, 6252.093446450239, 6278.246610406781, 5156.587473002151, 6279.277883043417, 6284.277308109535, 6305.414779940203, 6317.368263173646, 6105.236845394325, 6142.314611233313, 6214.4407003369915, 6230.096635987847, 6312.210973628296, 6137.5302083125, 6165.722542485599, 6178.073289006685, 6256.468200202943, 6274.592151510137, 5051.343325367752, 5052.9242061369105, 5055.140626093573, 5060.51925067118, 5062.392512898476, 4415.359772832985, 4429.689921705514, 4460.598546130864, 4529.207388707029, 4556.840510582114, 5684.744186511617, 5842.649441033552, 5928.140419639214, 5953.226080609493, 5953.493953014043, 6272.717727702265, 6302.401271879165, 6306.873862522724, 6307.810765677037, 6311.368863113652, 5733.885322293614, 5859.853503662357, 5898.321693005273, 5933.080372542263, 5974.0, 5451.04606693827, 5456.836294911159, 5465.617406781487, 5472.20653005312, 5475.233467314579, 6185.381461853779, 6407.487401007908, 6411.4229719325485, 6419.51853610981, 6427.068075129174, 6214.751409943552, 6237.656928868956, 6274.717637706405, 6296.401841825019, 6304.18045654062, 6348.77779277723, 6384.808455746335, 6401.263854656588, 6420.903686444801, 6434.710438030206, 6122.0, 6146.907796383147, 6258.749650013949, 6280.0893870389455, 6287.654179020198, 6219.284782250099, 6260.906086408617, 6306.306306306211, 6310.400511951358, 6336.271328797063, 5876.529877609695, 6127.142200091902, 6202.7208775606105, 6208.192934918432, 6224.751009959551, 5778.104393818965, 6095.512359011357, 6120.812855101138, 6223.595466294676, 6234.3453937337745, 5843.357230704704, 5891.1457838614015, 5937.139114828412, 6002.249718785152, 6070.0, 6149.569530132848, 6205.47253483459, 6217.0, 6218.347073557211, 6245.250569931637, 5895.7052147393315, 5993.640381577119, 6035.78874739382, 6041.969790151021, 6127.448529632355], "value": 5666.3657454805525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.37296530787506, 501.5160370242715, 527.678116349027, 533.519832151064, 536.7530935769546, 27374.86312568437, 41323.760287191355, 41339.966500837494, 41360.79319603405, 41382.7930860346, 41321.58678413215, 41821.58178418215, 41875.581244187546, 41885.371719424154, 42039.36940945888, 9505.239580833533, 9705.854412183788, 9710.902890971105, 9721.173700235453, 9739.220862331033, 9592.760180995496, 9684.12842844144, 9691.515424228795, 9714.31999760017, 9748.658796942109, 9727.270454715925, 9751.414915105117, 9754.512274386288, 9754.756131096743, 9828.115469607734, 8069.072056713494, 8449.873251901226, 9650.083242092025, 9705.563249653713, 9710.320277580537, 8095.150009249061, 9577.90422095784, 9638.518074096337, 9649.421034737868, 9659.855102173402, 33289.6671033289, 39317.0, 39404.0, 39629.40555891664, 39831.0, 3034.8027378220345, 3078.5074388097796, 3242.983785081083, 3253.2842774589553, 3466.5493485846678, 29215.85392073026, 30514.54228186579, 31150.06549803487, 31259.062228133193, 31311.686883131333, 3102.813831170137, 3134.2634480896972, 3206.3426997465463, 3297.7361811055057, 3316.502524621302, 368725.0, 429660.0, 433906.0, 435420.0, 438326.9999999968, 30577.38845223083, 32598.674013259562, 33606.66393336084, 33611.15972100668, 33739.0, 33457.665423345454, 33522.0, 34092.829535852165, 34365.65634343675, 34378.48432273518, 14564.0, 14695.632609184642, 14710.63223419423, 14841.480548180762, 14910.925445372704, 12677.049221308438, 12788.104832661624, 12788.488460461664, 12805.231686098863, 12810.935945320214, 7590.127135379392, 7628.160902300742, 7677.347425468786, 7701.653425595861, 7701.998740163855, 3198.4882418812876, 3208.5668434761474, 3219.0825614699697, 3223.0814217947773, 3269.5749552558013, 899.9010108888017, 925.8518637018045, 942.6135284533308, 975.0541974284932, 1005.0, 26671.86664066706, 29124.563131553045, 29932.251693707396, 30084.947026853955, 30138.0, 1043.4678314059731, 1056.2447849787438, 1088.5319312695458, 1122.4836575175348, 1176.2589568571746, 15654.060756354655, 15706.921465392828, 15751.842481575266, 15779.842201577838, 16100.597485062966, 669065.0, 680494.0, 689184.0, 692457.5377123082, 693165.5341723259, 58303.708481457325, 58893.0, 58899.41100589025, 58965.82068358695, 59098.704506477196, 1187.8515185601973, 1337.5987203838808, 1343.06656873472, 1371.814805001332, 1372.0395722993944, 25280.74719252784, 27396.45207095887, 29949.85025074861, 30662.540061898642, 30772.922947696723, 44769.77615111903, 56385.43614563802, 58303.12545311739, 58313.0, 60930.56277749018, 628068.0, 636481.0, 640039.0, 640086.0, 641182.0, 43828.687723218536, 44566.0, 44668.0, 44956.201751929555, 45152.54847451615, 48349.27476087791, 48528.27207591818, 48758.53724388274, 49083.754581226865, 49738.25392619186, 39356.80321598374, 40669.38995915123, 40957.0, 41583.0, 42049.369259461746, 36541.634583653824, 36559.81720091382, 40300.79849600733, 41001.97495062647, 41790.582094178666, 38818.0, 39300.0, 39343.80328098341, 39442.40836387514, 39561.0, 33028.50457243191, 34536.82731586326, 35683.92948211558, 36218.0, 36333.81833090818, 26107.216783496526, 26173.60739588946, 26245.0, 26276.605850912634, 26519.86740066287], "value": 18662.074627365775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.21746766725215, 378.1284140057168, 383.8483798899435, 393.4098851722416, 399.504614278295, 19872.503187420323, 21396.49853731953, 21507.892460537696, 22064.88967555164, 22096.447588810268, 20579.073941672625, 21145.471363215926, 21458.0, 21489.46276343088, 21591.0, 5564.4713752193675, 5876.618019828718, 5916.112583112546, 5932.6143800653035, 5997.130416089664, 3850.634189751969, 5798.3331916829475, 5906.763729450817, 6137.723802428902, 6153.0, 5899.0, 6049.818505444844, 6111.327753947062, 6134.846628834271, 6147.7233524491285, 5945.286565612154, 5999.640021598674, 6122.63264204147, 6139.263288405397, 6156.1996940397685, 4031.879043628696, 5315.681059136464, 5725.341585717654, 5749.683767392792, 5866.0, 13141.605751827461, 13260.53588124411, 13356.799648005288, 13360.39878205483, 20422.69365959512, 1865.6082222733241, 2304.51605162916, 2308.815294776414, 2419.721732000825, 2877.2519145022234, 9968.551415186334, 10067.848982265272, 10576.735581610445, 10880.564777408894, 15825.52523424299, 1761.5772214668516, 1825.963480730378, 1840.6226723521645, 1869.672807258738, 1889.3576184097474, 129295.0, 133204.3339783295, 134055.0, 134863.32568337195, 134928.6507134926, 11453.427328633536, 11633.302001879914, 11636.0, 11649.534018639159, 11756.353400563052, 14582.4896128635, 14583.854161458461, 14594.124352538882, 14601.342939567745, 14692.779608305884, 8613.095624959415, 8674.39279250459, 8703.216710496086, 8712.738617841474, 8725.21473067427, 8641.783955401166, 8641.870371944426, 8658.354912566718, 8713.128687131237, 8728.519931403707, 4508.48152462471, 4586.4266966629175, 4589.242774942097, 4595.172868883633, 4614.515475874985, 1592.896461729984, 1738.452387497934, 1788.937387191442, 1867.9719804202948, 1909.9140538675792, 827.4869580859905, 844.9691376520635, 904.8235594059227, 988.204495381225, 1023.6673081248475, 21407.57184856294, 21563.0, 21661.025253863612, 21749.238776642742, 22223.333300001024, 906.9727908162765, 951.6478902806006, 959.165525992391, 965.3098034905076, 992.3698451483216, 8918.687845925362, 10981.341119532854, 11429.085673146128, 11582.247153934968, 11611.303321800719, 589352.0, 593853.0, 601078.0, 612340.0, 612754.0, 76804.61597691975, 137055.0, 137752.0, 140466.0, 141660.29169854085, 941.317544780029, 954.9999999999861, 972.0765272990687, 976.5312649927932, 977.7604486900755, 16492.752608710638, 18721.906390468506, 19121.279084882426, 19211.0, 19627.80372196317, 51558.48441515537, 51900.74049629728, 51934.740326298124, 53760.19359709529, 56085.0, 74278.25721742713, 74756.50486990338, 74899.25100748923, 75960.0, 76492.0, 8186.7953301167945, 8279.793005174919, 8284.83430331402, 8292.17078292166, 8486.151384861465, 12843.422046007765, 13065.673358166121, 13107.0, 13129.671758205739, 13144.342782860627, 11258.38078905668, 11277.605283815026, 11379.943100284445, 11396.601118960796, 11432.199746017699, 8720.78198045054, 9704.951475242578, 11008.669739907815, 11289.887101129212, 11310.0, 11408.429578520874, 11542.961133498025, 11585.942070289932, 11660.650180494598, 11692.064634829023, 8079.3536517079665, 8208.507489550646, 8296.668133274843, 8411.53736544496, 8416.957915210385, 9339.346245762732, 9715.854262185932, 10432.582696692047, 11367.488463019019, 11487.597934072268], "value": 9516.724885743857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.2181176694005, 1559.6412825050238, 1775.698131317676, 1892.8391086757633, 1902.7145928110774, 7983.802429635558, 8542.0, 8829.29365650748, 9000.45997240166, 9002.099790020995, 6923.0, 8650.307975361971, 8761.299096072315, 8790.6923257686, 8799.692010779623, 2326.325365643961, 2354.0819080558595, 2358.870262135582, 2361.161787565415, 2363.8936247868887, 2309.618912879373, 2323.9651405228933, 2324.2213858357472, 2333.5449587330477, 2343.660169275454, 2342.8711420871846, 2349.0368948731025, 2355.5053438777877, 2357.139644029934, 2364.18435639704, 2295.5523672883796, 2327.6043072677685, 2335.544568809083, 2341.543399037197, 2348.095983046522, 2327.0226504867996, 2328.5342931413616, 2329.603967325542, 2333.7316208636053, 2338.3452633262546, 8736.694215702484, 8765.254953328975, 8851.46891186531, 8872.245859101984, 8890.06654301302, 5165.690058596496, 5180.611454140917, 5309.150535914274, 5322.787088516455, 5357.357117145929, 3557.3596752584526, 3601.8919432416806, 3667.5965643779164, 3671.1372827385544, 3696.1334526064434, 1069.6951368859916, 1080.195254535376, 1095.8575385199952, 1100.257326304749, 1118.5693507999479, 9736.95131524338, 10506.84239736397, 11618.767624647544, 11683.123765717604, 11714.824277635842, 4554.43069616298, 4589.609883159902, 4758.904821903542, 4796.736179510091, 4806.759662016885, 8149.837003259901, 8538.231559159705, 9864.802703945881, 9866.358686685486, 9868.50657467138, 5287.154055351125, 5300.1519756838725, 5309.495597918191, 5316.680999140064, 5326.627136100513, 4368.759718215529, 4698.647601429906, 4746.477887432379, 4864.343313652683, 4872.074305881871, 3205.246767009751, 3517.8416971236356, 3885.3589157788647, 3933.586973367755, 4032.6773858091283, 1050.4012712753656, 1066.9679909602723, 1085.234909388879, 1227.6378468351857, 1278.2458349573797, 882.2677177942293, 889.4352086425038, 912.9726108216764, 918.554501066982, 932.5943214701626, 6008.09878518217, 6071.726772295257, 6080.0, 6129.019356902963, 6240.521988985601, 905.463093185181, 931.6273490603812, 935.9766005849908, 964.8263312603799, 971.504532688334, 3954.9209015819524, 4048.817803198863, 4106.507219133723, 4108.383742438658, 4113.239050775616, 10396.16830653546, 10703.304285221435, 10783.0, 10824.4046577439, 10829.0, 10630.46847657614, 10650.254482186172, 10781.838272425919, 10807.35155890649, 10825.07986821129, 8049.55727434985, 8215.219554142346, 8278.958605206935, 8321.708740194184, 8347.874781878276, 5796.449337312949, 5828.883422331614, 5869.6771677558145, 5907.232059832194, 5993.430624090704, 9979.201663866728, 10007.049330313608, 10044.949775251076, 10067.0, 10133.986601339808, 8985.371024028254, 10113.988601139827, 10151.847722284025, 10275.17798576097, 10305.381677099398, 6537.182852143482, 6894.965525172342, 7072.469564782559, 7132.928670713434, 7149.106361704787, 8404.915950840657, 8498.872516912375, 8520.573971301286, 8576.0, 8576.828463430822, 7492.962535187289, 7556.8488630228185, 7586.0, 7681.731139410093, 7719.614019299125, 7413.1104267488245, 7423.257674232534, 7457.925420745723, 7588.165301816685, 7610.505317154367, 7031.929680703332, 7055.2944705529035, 7058.894116588358, 7080.2919708028785, 7082.716691332289, 4855.101806165871, 5042.915773108799, 5115.0, 5125.154349532286, 5146.665466744649, 4990.850274491771, 5043.218301163325, 5089.465606111305, 5146.974265128651, 5238.423773384849], "value": 4577.574720563867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.63836842315527, 303.615925853795, 306.904859493557, 307.9698408822489, 310.3358812142015, 5461.672299662018, 5479.890402191953, 5484.588655850807, 5503.449655034495, 5515.779368825247, 4365.930347064974, 4962.900741985158, 4989.4055091352475, 5099.541041306291, 5264.631195889077, 3448.6896179343853, 3919.804009799506, 4026.892604533762, 4071.4707088078508, 4093.2427500912277, 3552.1829979104823, 4039.939400908989, 4124.618252885287, 4140.689448291375, 4150.211459822639, 3229.838508074587, 3346.6318704942437, 3639.381305178113, 3991.880243592697, 4111.403846442279, 3164.955564663667, 3584.8028358440274, 3651.6488899107235, 3823.6426068745473, 3872.883813485586, 3465.8440370183403, 3470.6355832637464, 3474.739394545419, 3483.965160348415, 3495.7727747696317, 5214.843554693365, 5235.738213089368, 5250.68495890244, 5277.788888444457, 5290.365156181244, 4044.817983190734, 4509.616682581985, 4652.534746525354, 4657.115148121846, 4674.859754207345, 4461.375407442961, 4650.720956742606, 5503.064479038573, 5563.554915606742, 5680.318361796611, 2995.430868135047, 3390.525121572124, 3461.238527523941, 3720.962790372089, 3851.9614803852164, 4352.912941741148, 5388.568914486832, 5560.666360018371, 5773.037167363117, 5929.466348028698, 3359.824061578428, 3580.5524309461316, 3823.0, 3917.8236979335998, 3930.5283365995692, 3924.3524818404644, 3991.4811074560703, 4011.498562679665, 4015.0966032642423, 4035.7780322082567, 4266.381374700651, 4665.813367465331, 4677.789499472464, 4680.555347242007, 4697.31888876111, 4856.80572777092, 5639.603168653306, 5793.710314484259, 5821.88356232873, 5838.4453476919625, 1069.235496619905, 1350.4193196925416, 1365.3855764905634, 1367.131871261736, 1385.5081446086494, 737.1633196322213, 799.792054065947, 833.6869430646756, 840.2521755637365, 840.6427268411023, 4270.722403043855, 4653.813847446132, 4951.777170027357, 5313.946860531422, 5317.7872885084935, 5850.23946886902, 5905.261842269716, 5909.468147866713, 5944.583879128506, 5951.851203719942, 4943.9258411123865, 5268.525832675001, 5307.4692530746615, 5331.573474122139, 5426.945730542723, 2916.4458752836895, 3088.830114343688, 3113.5952326197903, 3115.2367669921014, 3131.389379071105, 4987.426445958688, 5143.099957507421, 6160.815175544741, 6161.938380616226, 6188.412100850412, 5350.545203657655, 5646.85882852932, 6108.72510737009, 6111.694415279218, 6113.786017489367, 4719.480857105716, 5378.2739330189925, 6160.907586386208, 6179.5983261086985, 6185.41238582334, 5208.401033881152, 5507.366652834975, 5526.839363733661, 5872.677002764889, 5888.852778680396, 4743.762811859462, 4877.365942427462, 5878.0616986618215, 5887.499562537232, 5908.586398952032, 6140.482402215071, 6164.907526387018, 6168.9691551541955, 6207.503399727921, 6213.875722485615, 3450.3961806684233, 3642.7814331140216, 3944.4872166618156, 3960.8415663373144, 3982.581828907923, 4895.73073480962, 5794.710264486843, 5837.066069428871, 5842.152887831326, 5845.590808643354, 4415.779211039371, 5710.314762228393, 5727.713614319351, 5734.99637563433, 5774.48029677331, 4498.942748454046, 5407.918881216863, 5518.171599850131, 5685.118806584986, 5711.428857114255, 4260.744355338689, 5142.485751424977, 5646.153077038477, 5671.347795003628, 5690.004249256446, 4830.855074347634, 5699.230603868425, 5733.340665823317, 5733.340665823317, 5771.855703607275, 4704.858854234379, 5648.717564121695, 5670.716464176692, 5678.261825962599, 5680.733578192473], "value": 4079.3646041633806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.9930500694994, 729.9635018249093, 749.9887501687472, 782.4405550031726, 787.5629025890632, 11331.490082946266, 14531.12813231207, 15434.0, 15791.44729934451, 15855.365785368585, 13745.106568073094, 13746.793798093036, 14094.083884547523, 14115.647108822259, 14243.216623085726, 666.3270097201813, 815.0504662068682, 832.1428928203944, 848.817504236589, 848.868425394065, 848.8514509960763, 851.825375797963, 854.0989256334565, 854.74784938443, 856.5802756649229, 883.995580022099, 890.1988210610438, 895.807401408697, 910.1399177777004, 910.276330317396, 879.1999280654574, 879.366855863777, 892.9821403571892, 906.0169715858302, 908.4503875155535, 653.8561516466369, 653.9738410463576, 655.4526969980072, 668.7091115364832, 674.639068098565, 12375.443105060294, 12762.936185319015, 14709.485168019068, 14724.19016954067, 14829.110253384832, 12041.819372709417, 12170.0, 14810.777838332433, 14821.703565928728, 15005.3247603857, 11999.280043197436, 12003.93998030013, 12010.219335743148, 12011.579594714143, 12173.093614383137, 3400.6769356911054, 3835.5780864104927, 3897.824597893073, 3937.8031098444962, 4038.575949525287, 102806.0, 107264.4636776819, 110976.4451177747, 111622.0, 115067.84932150655, 11505.884941150482, 11603.419829008515, 11615.36115513638, 11681.415929203506, 11689.298642081503, 23542.17602383908, 24088.0, 24166.879165604412, 24203.39491512726, 24257.75742242555, 8163.0612479564425, 8213.630386632616, 8400.873986890201, 8435.789105272295, 8483.872741908875, 4471.530489298577, 4478.955210447919, 4585.10590434862, 4597.103564804898, 4601.953980460219, 3211.309568442796, 3803.372443546784, 3806.5812760596314, 3807.5430948286385, 3946.1910308386714, 720.1178556268529, 726.0778810910115, 726.96728647211, 734.6693987705554, 741.6514238307986, 551.8923809857039, 553.9473749993745, 568.7937700703276, 607.6111288775187, 627.3851625407035, 9084.772880678036, 9496.447143821211, 9511.191548718436, 9532.571034303335, 9730.61077556904, 562.8902364039055, 602.5601311042964, 656.5076192855358, 662.2814246542459, 672.2168673495421, 4025.9597404025585, 4414.580614841585, 4576.4508259009135, 4597.839075632403, 4680.859574212779, 123634.0, 153355.6996645051, 154463.6830447544, 158415.0, 161812.0, 109059.45470272598, 139888.6011139896, 141833.0, 142482.0, 144093.27953360375, 54016.72991634938, 121524.0, 122525.64846109261, 123286.0, 124561.0, 9789.265805064506, 9877.30858839903, 9998.450085245091, 10000.799984000425, 10108.1408080314, 47415.52584474111, 56078.0, 56203.43796562146, 58367.12449313349, 63885.0, 62255.443613910014, 77867.0, 77877.221227787, 90531.64202536836, 90745.09254907367, 12087.274763514217, 13308.86691133115, 13355.26546039977, 13396.531121410704, 14029.3686784097, 12358.75282494327, 14997.475088371855, 15024.624384390478, 15177.24113794328, 15758.921205393899, 11855.407229638657, 13648.529881751374, 13682.247476388895, 13725.862741372459, 13994.230317332644, 10243.539040743035, 12154.75690486203, 13386.598402047954, 14020.088694234842, 14405.279736013366, 10199.54102065394, 10833.620823271147, 13463.596092117252, 14230.573082807532, 14248.073875198079, 11264.211505194558, 11375.715607109889, 11462.828057578976, 11649.534018639159, 11847.703807404883, 9716.465594392377, 10718.265021886067, 10729.678109656723, 10813.56745730162, 11705.239159454608], "value": 7790.25719395861, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 106.0, 114.0, 114.0, 117.0, 114.0, 116.0, 119.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 144.0, 193.0, 114.0, 135.0, 128.0, 111.0, 161.0, 117.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 208.0, 221.0, 216.0, 204.0, 199.0, 201.0, 203.0, 193.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 111.0, 95.0, 149.0, 59.0, 62.0, 75.0, 89.0, 153.0, 83.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 115.0, 101.0, 105.0, 117.0, 127.0, 72.0, 71.0, 119.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 90.0, 93.0, 91.0, 92.0, 88.0, 92.0, 89.0, 92.0, 89.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 97.0, 97.0, 97.0, 98.0, 118.0, 152.0, 110.0, 152.0], "value": 116.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 102.0, 85.0, 94.0, 92.0, 90.0, 95.0, 89.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 59.0, 59.0, 56.0, 58.0, 59.0, 56.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 80.0, 110.0, 121.0, 77.0, 67.0, 70.0, 68.0, 69.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 83.0, 88.0, 84.0, 84.0, 83.0, 86.0, 91.0, 86.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 138.0, 149.0, 152.0, 152.0, 159.0, 137.0, 135.0, 176.0, 155.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 162.0, 167.0, 166.0, 185.0, 150.0, 217.0, 171.0, 168.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 70.0, 66.0, 81.0, 92.0, 77.0, 66.0], "value": 72.3, "unit": "score"}]}]} 12:48:18 INFO - Return code: 0 12:48:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:48:18 ERROR - # TBPL SUCCESS # 12:48:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:18 INFO - 2016-06-29 12:48:18.426 screenresolution[1941:20101] starting screenresolution argv=screenresolution get 12:48:18 INFO - 2016-06-29 12:48:18.428 screenresolution[1941:20101] Display 0: 1600x1200x32@60 12:48:18 INFO - 2016-06-29 12:48:18.434 screenresolution[1942:20104] starting screenresolution argv=screenresolution list 12:48:18 INFO - Available Modes on Display 0 12:48:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:18 INFO - Intel Iris: 12:48:18 INFO - Chipset Model: Intel Iris 12:48:18 INFO - Type: GPU 12:48:18 INFO - Bus: Built-In 12:48:18 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:18 INFO - Vendor: Intel (0x8086) 12:48:18 INFO - Device ID: 0x0a2e 12:48:18 INFO - Revision ID: 0x0009 12:48:18 INFO - Displays: 12:48:18 INFO - Display: 12:48:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:18 INFO - Display Serial Number: 1600x1200 60 12:48:18 INFO - Main Display: Yes 12:48:18 INFO - Mirror: Off 12:48:18 INFO - Online: Yes 12:48:18 INFO - Rotation: Supported 12:48:18 INFO - Return code: 0 12:48:18 INFO - Running post-action listener: _resource_record_post_action 12:48:18 INFO - ##### 12:48:18 INFO - ##### Finished run-tests step (success) 12:48:18 INFO - ##### 12:48:18 INFO - Running post-run listener: _resource_record_post_run 12:48:18 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1048576; Write bytes: 707021312; Read time: 8; Write time: 2011 12:48:18 INFO - TinderboxPrint: CPU usage
54.1% 12:48:18 INFO - TinderboxPrint: I/O read bytes / time
1,048,576 / 8 12:48:18 INFO - TinderboxPrint: I/O write bytes / time
707,021,312 / 2,011 12:48:18 INFO - TinderboxPrint: CPU idle
2,220.9 (45.9%) 12:48:18 INFO - TinderboxPrint: CPU system
976.1 (20.2%) 12:48:18 INFO - TinderboxPrint: CPU user
1,640.8 (33.9%) 12:48:18 INFO - TinderboxPrint: Swap in / out
407,629,824 / 0 12:48:18 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 404572672; Write bytes: 398653440; Read time: 30522; Write time: 864 12:48:18 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 901120; Write bytes: 296575488; Read time: 6; Write time: 1108 12:48:19 INFO - Running post-run listener: _upload_blobber_files 12:48:19 INFO - Blob upload gear active. 12:48:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:48:19 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 12:48:19 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:48:19 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:48:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:20 INFO - (blobuploader) - INFO - Done attempting. 12:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:21 INFO - (blobuploader) - INFO - Done attempting. 12:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:24 INFO - (blobuploader) - INFO - Done attempting. 12:48:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:48:24 INFO - Return code: 0 12:48:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:48:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:48:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e98161eecc1ed823bb870947a8258187094947545484912f86672af2d73cce350a16699faef38c0c8ee76be709914436346eabdb8d881cc26447d98bccaab653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c4ab48aa5d3ea35cfb8f5175ccd17ad3261b1eea28e51d1667c24a10cf322392656eba5b41351be864f34aee6aa6e7982c8d910ab48ff46855a305c19719248a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03d15a9f17d09beb041a82f512a4017692a7104d64cef719f236df16f55a4d74f724d6d81bb8ae69cdd40c62472d1c2f57646021f0d1eadbaaeccbcc8427a750"} 12:48:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:48:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:48:24 INFO - Contents: 12:48:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e98161eecc1ed823bb870947a8258187094947545484912f86672af2d73cce350a16699faef38c0c8ee76be709914436346eabdb8d881cc26447d98bccaab653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c4ab48aa5d3ea35cfb8f5175ccd17ad3261b1eea28e51d1667c24a10cf322392656eba5b41351be864f34aee6aa6e7982c8d910ab48ff46855a305c19719248a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03d15a9f17d09beb041a82f512a4017692a7104d64cef719f236df16f55a4d74f724d6d81bb8ae69cdd40c62472d1c2f57646021f0d1eadbaaeccbcc8427a750"} 12:48:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:48:24 INFO - Copying logs to upload dir... 12:48:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:48:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.353268 ========= master_lag: 3.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-29 12:48:27.837707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 12:48:27.838975) ========= 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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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/Autoland/sha512/e98161eecc1ed823bb870947a8258187094947545484912f86672af2d73cce350a16699faef38c0c8ee76be709914436346eabdb8d881cc26447d98bccaab653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c4ab48aa5d3ea35cfb8f5175ccd17ad3261b1eea28e51d1667c24a10cf322392656eba5b41351be864f34aee6aa6e7982c8d910ab48ff46855a305c19719248a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03d15a9f17d09beb041a82f512a4017692a7104d64cef719f236df16f55a4d74f724d6d81bb8ae69cdd40c62472d1c2f57646021f0d1eadbaaeccbcc8427a750"} build_url:https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/KVE_b-P8T86gxbAUklHjng/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e98161eecc1ed823bb870947a8258187094947545484912f86672af2d73cce350a16699faef38c0c8ee76be709914436346eabdb8d881cc26447d98bccaab653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c4ab48aa5d3ea35cfb8f5175ccd17ad3261b1eea28e51d1667c24a10cf322392656eba5b41351be864f34aee6aa6e7982c8d910ab48ff46855a305c19719248a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03d15a9f17d09beb041a82f512a4017692a7104d64cef719f236df16f55a4d74f724d6d81bb8ae69cdd40c62472d1c2f57646021f0d1eadbaaeccbcc8427a750"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 12:48:28.549653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-06-29 12:48:28.550001) ========= 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.SRi5L0p9Nq/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.E7G59kUOTh/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.005090 ========= master_lag: 3.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-06-29 12:48:31.602423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 12:48:31.602752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 12:48:31.756947) ========= ========= Total master_lag: 7.73 =========