builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0219 starttime: 1465219273.79 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.790753) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.791182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.791454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.834078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.834504) ========= 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.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-06 06:21:13-- 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% 159M=0s 2016-06-06 06:21:14 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.433860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.290962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.291291) ========= 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.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.020194 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.356517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.356824) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-06 06:21:14,439 truncating revision to first 12 chars 2016-06-06 06:21:14,439 Setting DEBUG logging. 2016-06-06 06:21:14,439 attempt 1/10 2016-06-06 06:21:14,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:21:15,093 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.318192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.318497) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.318888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.319167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.336694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-06 06:21:15.336989) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:15 INFO - MultiFileLogger online at 20160606 06:21:15 in /builds/slave/test 06:21:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:21:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:15 INFO - {'append_to_log': False, 06:21:15 INFO - 'base_work_dir': '/builds/slave/test', 06:21:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:21:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:15 INFO - 'branch': 'Mozilla-Beta', 06:21:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:15 INFO - 'config_files': ('talos/mac_config.py',), 06:21:15 INFO - 'default_actions': ('clobber', 06:21:15 INFO - 'read-buildbot-config', 06:21:15 INFO - 'download-and-extract', 06:21:15 INFO - 'populate-webroot', 06:21:15 INFO - 'create-virtualenv', 06:21:15 INFO - 'install', 06:21:15 INFO - 'run-tests'), 06:21:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:15 INFO - 'download_minidump_stackwalk': True, 06:21:15 INFO - 'download_symbols': 'ondemand', 06:21:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:15 INFO - 'installer_path': 'installer.exe', 06:21:15 INFO - 'log_level': 'info', 06:21:15 INFO - 'log_name': 'talos', 06:21:15 INFO - 'log_to_console': True, 06:21:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:21:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:21:15 INFO - 'opt_config_files': (), 06:21:15 INFO - 'pip_index': False, 06:21:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:21:15 INFO - 'cmd': ('bash', 06:21:15 INFO - '-c', 06:21:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:21:15 INFO - 'enabled': True, 06:21:15 INFO - 'halt_on_failure': False, 06:21:15 INFO - 'name': 'check_screen_resolution'},), 06:21:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:21:15 INFO - 'cmd': ('bash', 06:21:15 INFO - '-c', 06:21:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:21:15 INFO - 'enabled': True, 06:21:15 INFO - 'halt_on_failure': False, 06:21:15 INFO - 'name': 'check_screen_resolution'},), 06:21:15 INFO - 'run_cmd_checks_enabled': True, 06:21:15 INFO - 'sps_profile': False, 06:21:15 INFO - 'sps_profile_interval': 0, 06:21:15 INFO - 'suite': 'dromaeojs-e10s', 06:21:15 INFO - 'system_bits': '32', 06:21:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:15 INFO - 'title': 't-yosemite-r7-0219', 06:21:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:15 INFO - 'use_talos_json': True, 06:21:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:15 INFO - 'work_dir': 'build'} 06:21:15 INFO - ##### 06:21:15 INFO - ##### Running clobber step. 06:21:15 INFO - ##### 06:21:15 INFO - Running pre-action listener: _resource_record_pre_action 06:21:15 INFO - Running main action method: clobber 06:21:15 INFO - rmtree: /builds/slave/test/build 06:21:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:16 INFO - Running post-action listener: _resource_record_post_action 06:21:16 INFO - ##### 06:21:16 INFO - ##### Running read-buildbot-config step. 06:21:16 INFO - ##### 06:21:16 INFO - Running pre-action listener: _resource_record_pre_action 06:21:16 INFO - Running main action method: read_buildbot_config 06:21:16 INFO - Using buildbot properties: 06:21:16 INFO - { 06:21:16 INFO - "project": "", 06:21:16 INFO - "product": "firefox", 06:21:16 INFO - "script_repo_revision": "production", 06:21:16 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 06:21:16 INFO - "repository": "", 06:21:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 06:21:16 INFO - "buildid": "20160602140837", 06:21:16 INFO - "pgo_build": "False", 06:21:16 INFO - "basedir": "/builds/slave/test", 06:21:16 INFO - "buildnumber": 17, 06:21:16 INFO - "slavename": "t-yosemite-r7-0219", 06:21:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:21:16 INFO - "platform": "yosemite_r7", 06:21:16 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:21:16 INFO - "branch": "mozilla-beta", 06:21:16 INFO - "repo_path": "releases/mozilla-beta", 06:21:16 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:21:16 INFO - "stage_platform": "macosx64", 06:21:16 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:21:16 INFO - "slavebuilddir": "test" 06:21:16 INFO - } 06:21:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:21:16 INFO - Running post-action listener: _resource_record_post_action 06:21:16 INFO - ##### 06:21:16 INFO - ##### Running download-and-extract step. 06:21:16 INFO - ##### 06:21:16 INFO - Running pre-action listener: _resource_record_pre_action 06:21:16 INFO - Running main action method: download_and_extract 06:21:16 INFO - mkdir: /builds/slave/test/build/tests 06:21:16 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')]} 06:21:16 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:21:17 INFO - Downloaded 1241 bytes. 06:21:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:21:17 INFO - Using the following test package requirements: 06:21:17 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:17 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:21:17 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:21:17 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:21:17 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:21:17 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:17 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:21:17 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:21:17 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:21:17 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:17 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:17 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:21:17 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:21:17 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')]} 06:21:17 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:21:18 INFO - Downloaded 17816944 bytes. 06:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:21:21 INFO - Return code: 0 06:21:21 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:21:21 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')]} 06:21:21 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:21:22 INFO - Downloaded 17816944 bytes. 06:21:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:21:25 INFO - Return code: 0 06:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:25 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:21:26 INFO - Downloaded 10845194 bytes. 06:21:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:21:27 INFO - Return code: 0 06:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:27 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:21:29 INFO - Downloaded 88466458 bytes. 06:21:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:21:29 INFO - mkdir: /builds/slave/test/properties 06:21:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:29 INFO - Contents: 06:21:29 INFO - build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:21:30 INFO - Running post-action listener: _resource_record_post_action 06:21:30 INFO - Running post-action listener: set_extra_try_arguments 06:21:30 INFO - ##### 06:21:30 INFO - ##### Running populate-webroot step. 06:21:30 INFO - ##### 06:21:30 INFO - Running pre-action listener: _resource_record_pre_action 06:21:30 INFO - Running main action method: populate_webroot 06:21:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:30 INFO - '--tppagecycles', 06:21:30 INFO - '7'], 06:21:30 INFO - 'tests': ['tsvgm']}}, 06:21:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:21:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:21:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'tests': ['damp', 'tps']}, 06:21:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['damp', 'tps']}, 06:21:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:21:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:30 INFO - 'other': {'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'other_l64': {'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'other_nol64': {'tests': ['a11yr', 06:21:30 INFO - 'ts_paint', 06:21:30 INFO - 'tpaint', 06:21:30 INFO - 'sessionrestore', 06:21:30 INFO - 'sessionrestore_no_auto_restore', 06:21:30 INFO - 'tabpaint']}, 06:21:30 INFO - 'svgr': {'tests': ['tsvgx', 06:21:30 INFO - 'tsvgr_opacity', 06:21:30 INFO - 'tart', 06:21:30 INFO - 'tscrollx', 06:21:30 INFO - 'cart']}, 06:21:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['tsvgx', 06:21:30 INFO - 'tsvgr_opacity', 06:21:30 INFO - 'tart', 06:21:30 INFO - 'tscrollx', 06:21:30 INFO - 'cart']}, 06:21:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'tests': ['tp5o']}, 06:21:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'talos_options': ['--e10s'], 06:21:30 INFO - 'tests': ['tp5o']}, 06:21:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'talos_options': ['--xperf_path', 06:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:30 INFO - 'tests': ['tp5n']}, 06:21:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:30 INFO - 'talos_options': ['--e10s', 06:21:30 INFO - '--xperf_path', 06:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:30 INFO - 'tests': ['tp5n']}}, 06:21:30 INFO - 'talos.zip': {'path': '', 06:21:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:30 INFO - Running post-action listener: _resource_record_post_action 06:21:30 INFO - ##### 06:21:30 INFO - ##### Running create-virtualenv step. 06:21:30 INFO - ##### 06:21:30 INFO - Running pre-action listener: _resource_record_pre_action 06:21:30 INFO - Running main action method: create_virtualenv 06:21:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:30 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 06:21:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:31 INFO - Using real prefix '/tools/python27' 06:21:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:34 INFO - Installing pip.................done. 06:21:34 INFO - Return code: 0 06:21:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:34 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')]} 06:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:34 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')]} 06:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:34 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 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:34 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 06:21:34 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 06:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:34 INFO - 'HOME': '/Users/cltbld', 06:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:34 INFO - 'LOGNAME': 'cltbld', 06:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:34 INFO - 'MOZ_NO_REMOTE': '1', 06:21:34 INFO - 'NO_EM_RESTART': '1', 06:21:34 INFO - 'PAGER': '/bin/cat', 06:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:34 INFO - 'PWD': '/builds/slave/test', 06:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:34 INFO - 'SHELL': '/bin/bash', 06:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:34 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:34 INFO - 'USER': 'cltbld', 06:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:34 INFO - 'XPC_FLAGS': '0x0', 06:21:34 INFO - 'XPC_SERVICE_NAME': '0', 06:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:34 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 06:21:34 INFO - Cleaning up... 06:21:34 INFO - Return code: 0 06:21:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:34 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')]} 06:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:34 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')]} 06:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:34 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:34 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>=0.7.1'] in /builds/slave/test/build 06:21:34 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>=0.7.1 06:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:34 INFO - 'HOME': '/Users/cltbld', 06:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:34 INFO - 'LOGNAME': 'cltbld', 06:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:34 INFO - 'MOZ_NO_REMOTE': '1', 06:21:34 INFO - 'NO_EM_RESTART': '1', 06:21:34 INFO - 'PAGER': '/bin/cat', 06:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:34 INFO - 'PWD': '/builds/slave/test', 06:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:34 INFO - 'SHELL': '/bin/bash', 06:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:34 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:34 INFO - 'USER': 'cltbld', 06:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:34 INFO - 'XPC_FLAGS': '0x0', 06:21:34 INFO - 'XPC_SERVICE_NAME': '0', 06:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:35 INFO - Downloading/unpacking psutil>=0.7.1 06:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:38 INFO - Installing collected packages: psutil 06:21:38 INFO - Running setup.py install for psutil 06:21:38 INFO - building 'psutil._psutil_osx' extension 06:21:38 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 06:21:38 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 06:21:39 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 06:21:39 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 06:21:39 INFO - building 'psutil._psutil_posix' extension 06:21:39 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 06:21:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:21:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:21:39 INFO - ^ 06:21:39 INFO - 1 warning generated. 06:21:39 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 06:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:39 INFO - Successfully installed psutil 06:21:39 INFO - Cleaning up... 06:21:39 INFO - Return code: 0 06:21:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:21:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:39 INFO - 'HOME': '/Users/cltbld', 06:21:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:39 INFO - 'LOGNAME': 'cltbld', 06:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:39 INFO - 'MOZ_NO_REMOTE': '1', 06:21:39 INFO - 'NO_EM_RESTART': '1', 06:21:39 INFO - 'PAGER': '/bin/cat', 06:21:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:39 INFO - 'PWD': '/builds/slave/test', 06:21:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:39 INFO - 'SHELL': '/bin/bash', 06:21:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:39 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:39 INFO - 'USER': 'cltbld', 06:21:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:39 INFO - 'XPC_FLAGS': '0x0', 06:21:39 INFO - 'XPC_SERVICE_NAME': '0', 06:21:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:21:42 INFO - Installing collected packages: mozsystemmonitor 06:21:42 INFO - Running setup.py install for mozsystemmonitor 06:21:42 INFO - Successfully installed mozsystemmonitor 06:21:42 INFO - Cleaning up... 06:21:42 INFO - Return code: 0 06:21:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21: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')]} 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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')]} 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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', '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 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21: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 blobuploader==1.2.4 06:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:42 INFO - 'HOME': '/Users/cltbld', 06:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:42 INFO - 'LOGNAME': 'cltbld', 06:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:42 INFO - 'MOZ_NO_REMOTE': '1', 06:21:42 INFO - 'NO_EM_RESTART': '1', 06:21:42 INFO - 'PAGER': '/bin/cat', 06:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:42 INFO - 'PWD': '/builds/slave/test', 06:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:42 INFO - 'SHELL': '/bin/bash', 06:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:42 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:42 INFO - 'USER': 'cltbld', 06:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:42 INFO - 'XPC_FLAGS': '0x0', 06:21:42 INFO - 'XPC_SERVICE_NAME': '0', 06:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:42 INFO - Downloading/unpacking blobuploader==1.2.4 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:46 INFO - Downloading docopt-0.6.1.tar.gz 06:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:46 INFO - Running setup.py install for blobuploader 06:21:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:46 INFO - Running setup.py install for requests 06:21:47 INFO - Running setup.py install for docopt 06:21:47 INFO - Successfully installed blobuploader requests docopt 06:21:47 INFO - Cleaning up... 06:21:47 INFO - Return code: 0 06:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:47 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')]} 06:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:47 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')]} 06:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:47 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 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:47 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 06:21:47 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 06:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:47 INFO - 'HOME': '/Users/cltbld', 06:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:47 INFO - 'LOGNAME': 'cltbld', 06:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:47 INFO - 'MOZ_NO_REMOTE': '1', 06:21:47 INFO - 'NO_EM_RESTART': '1', 06:21:47 INFO - 'PAGER': '/bin/cat', 06:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:47 INFO - 'PWD': '/builds/slave/test', 06:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:47 INFO - 'SHELL': '/bin/bash', 06:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:47 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:47 INFO - 'USER': 'cltbld', 06:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:47 INFO - 'XPC_FLAGS': '0x0', 06:21:47 INFO - 'XPC_SERVICE_NAME': '0', 06:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:47 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-HiolY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:47 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-NZ43jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:47 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-IX71N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-spvai8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-eU4oTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-AUuoYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-00Cld1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-v7VSiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-D3HQ5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-FLniBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-_fYcjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-bOq765-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-cG9qr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-rMVTb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-gOwH_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1MxmfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-xa7N_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:49 INFO - Running setup.py install for manifestparser 06:21:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:49 INFO - Running setup.py install for mozcrash 06:21:49 INFO - Running setup.py install for mozdebug 06:21:49 INFO - Running setup.py install for mozdevice 06:21:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozfile 06:21:50 INFO - Running setup.py install for mozhttpd 06:21:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozinfo 06:21:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozInstall 06:21:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozleak 06:21:50 INFO - Running setup.py install for mozlog 06:21:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for moznetwork 06:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozprocess 06:21:51 INFO - Running setup.py install for mozprofile 06:21:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozrunner 06:21:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozscreenshot 06:21:51 INFO - Running setup.py install for moztest 06:21:51 INFO - Running setup.py install for mozversion 06:21:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:51 INFO - Cleaning up... 06:21:51 INFO - Return code: 0 06:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:51 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')]} 06:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:51 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')]} 06:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:51 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 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:51 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 06:21:51 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 06:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:51 INFO - 'HOME': '/Users/cltbld', 06:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:51 INFO - 'LOGNAME': 'cltbld', 06:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:51 INFO - 'MOZ_NO_REMOTE': '1', 06:21:51 INFO - 'NO_EM_RESTART': '1', 06:21:51 INFO - 'PAGER': '/bin/cat', 06:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:51 INFO - 'PWD': '/builds/slave/test', 06:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:51 INFO - 'SHELL': '/bin/bash', 06:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:51 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:51 INFO - 'USER': 'cltbld', 06:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:51 INFO - 'XPC_FLAGS': '0x0', 06:21:51 INFO - 'XPC_SERVICE_NAME': '0', 06:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-9X0XgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-O0PzT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-vk8TOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-KI23OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1hShV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-T9e6Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-RPBifA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:52 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1qTZqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-K3t4G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-i96UEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-QCaHg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Lif210-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-mJSWxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-k_g9VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-BENYAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-76LGVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-QLnGAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:54 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)) 06:21:54 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)) 06:21:54 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)) 06:21:54 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)) 06:21:54 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)) 06:21:54 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)) 06:21:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21:56 INFO - Downloading blessings-1.6.tar.gz 06:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:56 INFO - Installing collected packages: blessings 06:21:56 INFO - Running setup.py install for blessings 06:21:56 INFO - Successfully installed blessings 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:57 INFO - Reading from file tmpfile_stdout 06:21:57 INFO - Current package versions: 06:21:57 INFO - blessings == 1.6 06:21:57 INFO - blobuploader == 1.2.4 06:21:57 INFO - docopt == 0.6.1 06:21:57 INFO - manifestparser == 1.1 06:21:57 INFO - mozInstall == 1.12 06:21:57 INFO - mozcrash == 0.17 06:21:57 INFO - mozdebug == 0.1 06:21:57 INFO - mozdevice == 0.48 06:21:57 INFO - mozfile == 1.2 06:21:57 INFO - mozhttpd == 0.7 06:21:57 INFO - mozinfo == 0.9 06:21:57 INFO - mozleak == 0.1 06:21:57 INFO - mozlog == 3.1 06:21:57 INFO - moznetwork == 0.27 06:21:57 INFO - mozprocess == 0.22 06:21:57 INFO - mozprofile == 0.28 06:21:57 INFO - mozrunner == 6.11 06:21:57 INFO - mozscreenshot == 0.1 06:21:57 INFO - mozsystemmonitor == 0.0 06:21:57 INFO - moztest == 0.7 06:21:57 INFO - mozversion == 1.4 06:21:57 INFO - psutil == 3.1.1 06:21:57 INFO - requests == 1.2.3 06:21:57 INFO - wsgiref == 0.1.2 06:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:57 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 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:57 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 06:21:57 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 06:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:57 INFO - 'HOME': '/Users/cltbld', 06:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:57 INFO - 'LOGNAME': 'cltbld', 06:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:57 INFO - 'MOZ_NO_REMOTE': '1', 06:21:57 INFO - 'NO_EM_RESTART': '1', 06:21:57 INFO - 'PAGER': '/bin/cat', 06:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:57 INFO - 'PWD': '/builds/slave/test', 06:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:57 INFO - 'SHELL': '/bin/bash', 06:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:57 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:57 INFO - 'USER': 'cltbld', 06:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:57 INFO - 'XPC_FLAGS': '0x0', 06:21:57 INFO - 'XPC_SERVICE_NAME': '0', 06:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 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)) 06:21:57 INFO - Cleaning up... 06:21:57 INFO - Return code: 0 06:21:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:57 INFO - 'HOME': '/Users/cltbld', 06:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:57 INFO - 'LOGNAME': 'cltbld', 06:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:57 INFO - 'MOZ_NO_REMOTE': '1', 06:21:57 INFO - 'NO_EM_RESTART': '1', 06:21:57 INFO - 'PAGER': '/bin/cat', 06:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:57 INFO - 'PWD': '/builds/slave/test', 06:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:57 INFO - 'SHELL': '/bin/bash', 06:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:21:57 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:57 INFO - 'USER': 'cltbld', 06:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:57 INFO - 'XPC_FLAGS': '0x0', 06:21:57 INFO - 'XPC_SERVICE_NAME': '0', 06:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:57 INFO - Downloading/unpacking jsonschema 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:22:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:00 INFO - warning: no files found matching '*.txt' 06:22:00 INFO - no previously-included directories found matching 'build' 06:22:00 INFO - no previously-included directories found matching 'dist' 06:22:00 INFO - no previously-included directories found matching '.git*' 06:22:00 INFO - Installing collected packages: jsonschema, functools32 06:22:00 INFO - Running setup.py install for functools32 06:22:00 INFO - warning: no files found matching '*.txt' 06:22:00 INFO - no previously-included directories found matching 'build' 06:22:00 INFO - no previously-included directories found matching 'dist' 06:22:00 INFO - no previously-included directories found matching '.git*' 06:22:00 INFO - Successfully installed jsonschema functools32 06:22:00 INFO - Cleaning up... 06:22:00 INFO - Return code: 0 06:22:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdfd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb725beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, '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.iHOBRPHMn5/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.cONjP72EhZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 06:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:22:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:22:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:00 INFO - 'HOME': '/Users/cltbld', 06:22:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:00 INFO - 'LOGNAME': 'cltbld', 06:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:00 INFO - 'MOZ_NO_REMOTE': '1', 06:22:00 INFO - 'NO_EM_RESTART': '1', 06:22:00 INFO - 'PAGER': '/bin/cat', 06:22:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:00 INFO - 'PWD': '/builds/slave/test', 06:22:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:00 INFO - 'SHELL': '/bin/bash', 06:22:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:22:00 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:22:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:00 INFO - 'USER': 'cltbld', 06:22:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:00 INFO - 'XPC_FLAGS': '0x0', 06:22:00 INFO - 'XPC_SERVICE_NAME': '0', 06:22:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:01 INFO - Downloading/unpacking flake8 06:22:01 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 06:22:01 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 06:22:01 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 06:22:01 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 06:22:01 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 06:22:01 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 06:22:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:22:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:22:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:04 INFO - no previously-included directories found matching 'docs/_build' 06:22:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:22:04 INFO - Running setup.py install for pep8 06:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:04 INFO - no previously-included directories found matching 'docs/_build' 06:22:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:22:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:22:05 INFO - Cleaning up... 06:22:05 INFO - Return code: 0 06:22:05 INFO - Running post-action listener: _resource_record_post_action 06:22:05 INFO - Running post-action listener: _start_resource_monitoring 06:22:05 INFO - Starting resource monitoring. 06:22:05 INFO - ##### 06:22:05 INFO - ##### Running install step. 06:22:05 INFO - ##### 06:22:05 INFO - Running pre-action listener: _resource_record_pre_action 06:22:05 INFO - Running main action method: install 06:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:05 INFO - Reading from file tmpfile_stdout 06:22:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:05 INFO - Reading from file tmpfile_stdout 06:22:05 INFO - Output received: 06:22:05 INFO - Usage: mozinstall [options] installer 06:22:05 INFO - Options: 06:22:05 INFO - -h, --help show this help message and exit 06:22:05 INFO - -d DEST, --destination=DEST 06:22:05 INFO - Directory to install application into. [default: 06:22:05 INFO - "/builds/slave/test"] 06:22:05 INFO - --app=APP Application being installed. [default: firefox] 06:22:05 INFO - mkdir: /builds/slave/test/build/application 06:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:22:27 INFO - Reading from file tmpfile_stdout 06:22:27 INFO - Output received: 06:22:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:22:27 INFO - Running post-action listener: _resource_record_post_action 06:22:27 INFO - ##### 06:22:27 INFO - ##### Running run-tests step. 06:22:27 INFO - ##### 06:22:27 INFO - Running pre-action listener: _resource_record_pre_action 06:22:27 INFO - Running main action method: run_tests 06:22:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:22:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:22:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:22:27 INFO - 2016-06-06 06:22:27.939 screenresolution[6344:105293] starting screenresolution argv=screenresolution get 06:22:27 INFO - 2016-06-06 06:22:27.941 screenresolution[6344:105293] Display 0: 1600x1200x32@60 06:22:27 INFO - 2016-06-06 06:22:27.947 screenresolution[6345:105296] starting screenresolution argv=screenresolution list 06:22:27 INFO - Available Modes on Display 0 06:22:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:22:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:22:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:22:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:22:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:22:28 INFO - Intel Iris: 06:22:28 INFO - Chipset Model: Intel Iris 06:22:28 INFO - Type: GPU 06:22:28 INFO - Bus: Built-In 06:22:28 INFO - VRAM (Dynamic, Max): 1536 MB 06:22:28 INFO - Vendor: Intel (0x8086) 06:22:28 INFO - Device ID: 0x0a2e 06:22:28 INFO - Revision ID: 0x0009 06:22:28 INFO - Displays: 06:22:28 INFO - Display: 06:22:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:22:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:22:28 INFO - Display Serial Number: 1600x1200 60 06:22:28 INFO - Main Display: Yes 06:22:28 INFO - Mirror: Off 06:22:28 INFO - Online: Yes 06:22:28 INFO - Rotation: Supported 06:22:28 INFO - Return code: 0 06:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:28 INFO - Python 2.7.3 06:22:28 INFO - Return code: 0 06:22:28 INFO - grabbing minidump binary from tooltool 06:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:22:28 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc9ad30>, '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 0x10cafedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc91b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:28 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 06:22:28 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 06:22:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:28 INFO - Return code: 0 06:22:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:22:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:22:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:29 INFO - Return code: 0 06:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 06:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0219 --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 06:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHOBRPHMn5/Render', 06:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:29 INFO - 'HOME': '/Users/cltbld', 06:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:29 INFO - 'LOGNAME': 'cltbld', 06:22:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:29 INFO - 'MOZ_NO_REMOTE': '1', 06:22:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:29 INFO - 'NO_EM_RESTART': '1', 06:22:29 INFO - 'PAGER': '/bin/cat', 06:22:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:29 INFO - 'PWD': '/builds/slave/test', 06:22:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:29 INFO - 'SHELL': '/bin/bash', 06:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cONjP72EhZ/Listeners', 06:22:29 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:29 INFO - 'USER': 'cltbld', 06:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:29 INFO - 'XPC_FLAGS': '0x0', 06:22:29 INFO - 'XPC_SERVICE_NAME': '0', 06:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 06:22:29 INFO - mozversion application_buildid: 20160602140837 06:22:29 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:29 INFO - mozversion application_display_name: Firefox 06:22:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:29 INFO - mozversion application_name: Firefox 06:22:29 INFO - mozversion application_remotingname: firefox 06:22:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:29 INFO - mozversion application_vendor: Mozilla 06:22:29 INFO - mozversion application_version: 47.0 06:22:29 INFO - mozversion platform_buildid: 20160602140837 06:22:29 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:29 INFO - mozversion platform_version: 47.0 06:22:29 INFO - using testdate: 1465219349 06:22:29 INFO - actual date: 1465219349 06:22:29 INFO - starting webserver on 'localhost:57303' 06:22:29 INFO - SUITE-START | Running 2 tests 06:22:29 INFO - TEST-START | dromaeo_css 06:22:29 INFO - operating with platform_type : mac_ 06:22:29 INFO - Initialising browser for dromaeo_css test... 06:22:29 INFO - TEST-INFO | started process 6363 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp4XCqrq/profile http://localhost:57303/getInfo.html) 06:22:32 INFO - PROCESS | 6363 | __metrics Screen width/height:1600/1200 06:22:32 INFO - PROCESS | 6363 | colorDepth:24 06:22:32 INFO - PROCESS | 6363 | Browser inner width/height: 1024/689 06:22:32 INFO - PROCESS | 6363 | __metrics 06:22:32 ERROR - PROCESS | 6363 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:22:32 INFO - TEST-INFO | 6363: exit 0 06:22:32 INFO - Browser initialized. 06:22:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:32 INFO - TEST-INFO | started process 6368 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp4XCqrq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:44 INFO - PROCESS | 6368 | RSS: Main: 168050688 06:22:44 INFO - PROCESS | 6368 | 06:23:34 INFO - PROCESS | 6368 | 1465219414553 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] 06:25:44 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57303/tests/dromaeo/cssquery-ext.html) 06:25:45 INFO - PROCESS | 6368 | RSS: Main: 179253248 06:25:45 INFO - PROCESS | 6368 | 06:28:47 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-ext.html (next: http://localhost:57303/tests/dromaeo/cssquery-jquery.html) 06:28:48 INFO - PROCESS | 6368 | RSS: Main: 189980672 06:28:48 INFO - PROCESS | 6368 | 06:31:50 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57303/tests/dromaeo/cssquery-mootools.html) 06:31:50 INFO - PROCESS | 6368 | RSS: Main: 192028672 06:31:50 INFO - PROCESS | 6368 | 06:34:52 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57303/tests/dromaeo/cssquery-prototype.html) 06:34:52 INFO - PROCESS | 6368 | RSS: Main: 195416064 06:34:52 INFO - PROCESS | 6368 | 06:37:55 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57303/tests/dromaeo/cssquery-yui.html) 06:37:55 INFO - PROCESS | 6368 | RSS: Main: 194416640 06:37:55 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | Cycle 1(1): loaded http://localhost:57303/tests/dromaeo/cssquery-yui.html (next: http://localhost:57303/tests/dromaeo/cssquery-dojo.html) 06:40:58 INFO - PROCESS | 6368 | RSS: Main: 199970816 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | __start_tp_report 06:40:58 INFO - PROCESS | 6368 | _x_x_mozilla_page_load 06:40:58 INFO - PROCESS | 6368 | _x_x_mozilla_page_load_details 06:40:58 INFO - PROCESS | 6368 | |i|pagename|runs| 06:40:58 INFO - PROCESS | 6368 | |0;dojo.html;3609.079684680406;3626.383514802483;3631.9818400907993;3648.7628304160244;3665.5051568038325;5935.940640593592;5947.553933454992;5964.5526585506095;5973.5818492705475;6010.398960103998;5999.820005399834;6018.638881667103;6023.457888790008;6045.546584006206;6047.455728984391;5363.436839131884;5379.65032272901;5425.13197888338;5448.564114870821;5469.124940009599;5352.009878172531;5434.049041417736;5464.9453505465035;5465.398806131322;5475.917861232065;5379.515843574078;5416.51251387375;5422.15956526739;5422.53908417785;5436.374816896068;4231.492220933493;4639.373684552576;5470.507654311092;5480.671159730429;5548.58385621076;5362.088444964365;5423.322084739408;5455.099908515091;5455.345358556999;5473.781048758045;5714.000049991235;5820.097884827816;5949.970250148722;5961.046232602763;5982.102684597346;5604.859878503029;5667.206591077253;6280.1835761351185;6283.560150789446;6303.180586523768;5772.942270577324;6244.219472565929;6262.1546091278005;6407.967960160169;6409.551331406803;6085.574009819315;6115.788007244244;6150.231221097363;6150.661713605795;6157.568970172135;6509.446697030806;6531.706073226716;6544.869102617921;6554.7378104876225;6567.737290508326;6068.908966365508;6194.5973511721595;6268.279147897959;6269.498440124779;6272.843178920563;6339.334369891095;6364.077208804697;6378.2346118466085;6387.744490220432;6395.42441180296;6260.561760676709;6269.435750782361;6276.686165691697;6285.402886725754;6293.968530157412;6159.81520554384;6208.937910620836;6240.65676387794;6280.748770049238;6310.7475700971445;5083.74581270935;5095.694258344512;5118.181091025418;5122.769475373542;5123.436421993578;4614.653900957442;4622.121796858586;4624.237000894882;4630.467496237909;4656.674032817738;6053.606515576474;6082.665453400017;6134.069235337315;6194.38056194377;6204.441600255998;6229.937700623026;6312.495000400048;6370.936290637127;6371.617702937839;6407.871842563216;6143.723532441051;6204.3795620437595;6210.378962103844;6210.5652604317265;6219.098230756515;5505.394406615269;5580.497755202051;5634.802781902614;5639.407862174495;5702.6293290935955;6507.544471886922;6573.967130164318;6580.440662543641;6602.240742314695;6602.40578347951;6361.395667411589;6374.107624932606;6382.712777924911;6403.167588213502;6406.263279722892;6387.968060159669;6508.349165083454;6613.801585952429;6622.768203112868;6625.966870165618;4919.827806026772;6251.4061164189325;6286.339934307015;6289.874202516015;6300.401461861115;5620.053690339232;6259.2488901332135;6336.429721325103;6339.270983836917;6359.459445947146;6129.387061293835;6203.379662033941;6230.283517395557;6261.092141639346;6262.123302737529;5211.973940130427;6223.253209614694;6253.78111766086;6256.249250090018;6265.780697675559;6043.09353596964;6088.756449741961;6201.534884883742;6215.844603884758;6254.155688981929;6124.564025909317;6230.968845155927;6246.281677606951;6262.279837818709;6264.530160238091;6184.536159787944;6204.100405441276;6255.906161407492;6266.624002559861;6277.529185311028 06:40:58 INFO - PROCESS | 6368 | |1;ext.html;588.4497994375259;591.9763209471619;641.3234038089819;657.7138944559116;663.4360793325673;36326.45510317344;39079.804600977026;39080.60919390805;39086.41370379443;39142.412863806996;36365.81817090911;39836.60163398365;40741.981450463754;40843.79578102113;41442.7927860361;9069.319801014917;9731.610735570604;9745.31782775206;9780.168685661693;9783.266255030865;9516.762080947963;9774.364666296704;9778.706638800812;9792.265580081486;9835.508224588777;9749.853752193687;9828.115469607734;9832.213422926185;9838.360506567085;9839.655612053579;9742.659006934759;9760.023997600254;9806.264530160232;9822.361546499526;9829.707048138882;9690.709278721579;9786.314957952874;9789.804203915954;9800.852987205197;9813.165880900133;34850.47724284112;40933.1813363734;40998.79500602478;41000.38499422511;41228.587714122776;3180.3480286541435;3413.4709120086427;3443.6039855416698;3501.38725723;3942.8619998299923;27491;27977.580336294974;28622.284442888886;28984.855075724696;29251.85374073116;2738.3564862257354;2749.2714430675687;2752.4219913818124;2765.502209602271;2889.725476079769;339368;341902;341971;342948;416041;45137;48178;68821.31178688249;69396.6530167356;69653;46334.914928828286;47796.80507987328;47840;47862.04275914462;48175.5182448178;17307.91346043287;17399.826001740075;17409.303627854744;17460.73808892842;17464;13807.102538334975;13820.447182112805;14079.436822526985;14105.647358815906;14114.435422583187;14039.947003974743;14420.062695924731;15327.850411219204;15614.063156210665;15910.840891591168;6030.5778595497895;6114.205153330038;6334.651594162366;6454.6449945252525;6495.902561461582;979.9902000980042;995.1690338567378;1024.2318261304022;1095.802755504001;1152.5217034930577;26295.34261643436;26845.194644160707;30215.697843021728;30287.697123028487;31050.378992420025;1135.2961164078324;1135.7103938495632;1143.3140115930541;1226.9938650306663;1261.8548866880242;13201.019574847302;14931.552053438414;15364.539063828102;15640.765388519181;15711.842881571267;554825;558201;558384;559182;569677;63326.36673633205;63686.6815665928;64184;64199.037014443886;64210;1412.237391808412;1529.4417537598697;1547.473858887961;1578.5974576483154;1579.8104227492774;29940;30409.847950760104;30452.19123505976;30613.609019205884;30892;46485.76757116193;53486;53957.92084158216;54577.72711136419;54689;513531;519896;524968;525555;529546;35602;35948.82025589855;46951.29573056338;47581.28628070651;48669.5133048665;44635.77682111569;47262.29957858597;47538.524614754795;48002.03995920132;48295.75852120717;34332.82833585816;35059.298814024085;38891.833245002694;38937;39098;35461.82269088638;36557.26885462329;38402.807985959895;38795.6120438792;39611.80194099011;37960.430593540565;38456.423153653275;38501.6149838498;38609.613903861726;38783.41824872573;27659.446811063262;34628;34816.129596760285;35162.29675406529;35325.64674353327;22327.88360581932;22891.88554057219;26184.73815261823;26191.607125892744;26332.605010925236 06:40:58 INFO - PROCESS | 6368 | |2;jquery.html;372.50270888364014;379.5843551311314;381.0853950518755;384.06671787556263;386.31236399209405;20269.087891044903;21429.928503574796;21507.03218355174;22127.889360553196;22294.777052229474;20219;21673.67489487659;21699.3490195294;21839;22542.661860072112;5922.703864806764;5991.670458124801;6163.1896754086765;6212.254529456472;6218.564700470969;4446.266366049614;6444.323346048668;6682.966585167067;6701.832454188636;6792.966035169818;5701.372848986629;6613.503987200955;6614.50391220658;6615.569987950792;6625.602463852184;5836.095405212178;5856.209411729405;5877.735501902424;5882.264716910387;5904.261967254093;5447.945520544784;5836.854078648068;5853.502452291517;5885.411458854123;5900.203472531196;13845.030847840655;13936.442542298297;13947.930260348634;22099.889500552556;26188;2276.3512398966213;2345.7654234576407;2350.717913850332;2363.3855197648736;2561.6157576363694;9946.602135914554;10114.54484548197;10420.114290285335;13543.59369218925;14513.419463221458;1741.2425594866274;1755.543558674741;1765.3203516646183;1772.6100257943233;1784.1703607822426;113635;118916;120501;121555.3922230392;123706;9477.715668529818;11722.238054526428;11771.411429428494;11794.88205117955;11862.703432414259;14392.35234414454;14520.927395362956;14550.563483095524;14604.488842890449;14610;9040.367174297737;9131.863022054675;9235.21500672437;9248.676296329731;9268.25853931684;9385.624575016924;9440.386374885611;9459.668911588062;9488.240940724725;9596.952015240018;4567;4584.220682483986;4621.491635920046;4624.421947256593;4647.814087436533;1772.9202185901665;1858.8605854560692;1929.4308179087202;1930.9517262068562;1934.8935808530666;815.176671561727;888.8266787976282;958.5111593087576;964.6623681711485;997.8154041502345;16735.581610459834;19062.14220360087;21040.579188416144;21265.93670316478;21506.89246553757;977.2994988719577;991.7669347703284;1019.4953498018529;1022.320157095538;1025.8307379282335;11103;11552.76894462106;11575;11596.956273935386;11600.535978560933;563331.9167020775;681278;687916;708980;720951;123144.38427807804;125077.74922250661;127353;131641.0253846193;134731;1046.5238316565944;1078.0620859851979;1086.098538213297;1092.1644941619668;1092.918031147667;14929.402823887358;18394.81605183931;18642.906785465984;18790.342338018105;19213;53773.731131344095;54307.72846135744;55619.721901390236;55752.442475574724;56559.43440565542;80325;81078;81600.18399815926;83366;84080;7468.1785003648465;7472.327490525879;7763.378929685725;7894.092179399443;8398.286145677686;9440.244780417688;12405.503779849067;13040;13381.39783709716;13437.529686460926;9230.676926307548;11137.665870023913;11355.318680879174;11680.766384672428;11782.469788859351;7834.177411371952;11152.832707509231;11194.552217911192;11230.66308010761;11800.291982481078;9819.656312029045;10250.769907611135;11772.764544708887;11919.702007449883;12015.879841201477;8160.469569477965;8203.220694034057;8219.301359384519;8284.792880177803;8433.19884610961;8725.869111963453;9072.682456114268;10346.32748871321;11034.889651103707;11940.6268279149 06:40:58 INFO - PROCESS | 6368 | |3;mootools.html;1669.2571805546534;1678.6558755455133;2022.7168196452499;2072.181488312118;2074.7406574178217;8247.42268041236;9053.909460905388;9104;9258.120478554543;9286.885573731153;9212.907870921288;9254.259659227262;9369.859452108223;9389.577469013893;9459.621615135386;2562.269753120356;2587.521308557923;2593.15722390223;2596.3119773260005;2599.0773275487213;2509.6862892138483;2571.190075126339;2573.6525569048126;2575.652286941267;2580.4710034442987;2560.8463492190435;2565.191964531167;2609.517239310724;2626.3828000419885;2647.5102106110335;2496.575582151039;2525.4696513732047;2530.746925307473;2531.6202569614707;2540.326813394452;2529.7723204911463;2535.9112431064823;2542.9364265893314;2574.5365834149848;2575.22743177048;9284.675036373694;9342.01908799573;9354.859677104849;9365.812683746288;9374.343795934288;5664.575156863251;5854.063349864001;5880.059190529495;5897.14491398749;5948.37542058082;3697.852085916587;3803.0872590578338;3823.4264860270905;3824.7896365699876;3832.6358995895343;1073.4364458659188;1086.6957251969382;1088.1621151713216;1126.8929451702074;1132.6998345438383;12484.81272780909;12486;12551.372431378395;12601.369931503388;12683.556075537312;5026.246063090565;5076.0863044652315;5154.226865970059;5161.5870730341485;5257.8159764408065;10736.677899663022;10758;10839.566417343218;10849;10966.945165274283;5703.315602127771;5805.767769289266;5807.94192058074;5861.501772349398;5902.409759024149;4272.209641216323;4672.696274742131;5175.430702622709;5203.583713303003;5260.132078207053;4122.979385103115;4132.669386449077;4157.792110394529;4159.646430053479;4170.061736109351;1287.76820172368;1340.1356125299321;1370.6504841265414;1378.3521744779937;1385.1550554161954;1375.9243241621807;1382.5644921849585;1404.571605660263;1407.04321061677;1425.8146440962817;8430.114837941928;8623.913760862437;8632.266257368068;8632.395732298804;8638.352123590756;529.9057446373226;541.8834950485665;545.4627192215744;546.8222827581052;554.287740253772;6378.904316435257;6412.903806442907;6419.069234960904;6444.7744328948265;6447.6453795041725;10860.239783215256;11184.161187910939;11257.043151332065;11345.489452974636;11398.487068081957;10425.061744443037;10725.946370268099;11069.391183484824;11139.554417823196;11177.161712871568;7247.710091596383;8274.875876861852;8558.614862331086;8562.957185214158;8683.175098365646;8257.504549727035;8327.958360208402;8433.030201526657;8447.239748422671;8491.15088491146;8287.709930152416;9548.904510954802;9786.51067446639;9902.306838521523;9967.40195588238;9951.751206219902;10073.546690399096;10079.24405669563;10165.949170254102;10264.33281836708;8317.95841020791;8348.916510834813;8428.915710842813;8499.065102838558;8576.699815506427;8526.701565445179;8526.91473085286;8545;8555.786105347415;8576.785580360542;7591.506552074097;7828.84342313162;7833.5691536966015;7941.483803552751;7951.562664053533;7454.776356709307;7625.809354765954;7751.6511756972195;7764.495307804975;7808.063032436144;7881.527108373516;7958.602069896367;8017.63920623585;8056;8097.2307630774985;7177.605231712306;7179.210286868336;7191.280871912767;7247.637618119178;7267.236940121211;7300.96349518249;7305.926940730525;7359.889601656087;7371.668274927534;7386.372158366599 06:40:58 INFO - PROCESS | 6368 | |4;prototype.html;297.79245160872665;312.6888745698031;323.98866039688613;338.6072156298694;343.9776414533055;6870.141232345957;6971.686274117665;6973.302669733024;7004.5096843221;7035.71857125715;6828.863422731555;6843.65781710915;6887.862242755142;6896.586204827701;6898.862022759555;4802.063597598479;4913.852584422473;4996.525330093654;5014.899702005958;5019.422766381858;4947.158982972904;5002;5013.799448022093;5027.195648696209;5060.84817455477;4931.827386041489;4935.605151587883;4945.7774400152075;4966.801327946896;4980.900381992376;4949.901001979958;4962.627802914796;4972.8508144755715;4985.6260780441435;5043.924341134886;4282.164977829325;4311.78441077948;4318.5681431856565;4332.783360831977;4342.717723348004;6201.255849298068;6530.085787989685;6564;6581.407673309377;6603.042558828943;5803.100519419497;5869.270789083054;5872.177895094647;5889.587728858982;5895.911561326584;7316.926830731678;7355.963220183865;7356.595387253699;7356.595387253752;7362.3373896349585;4701.882452938704;4705.458872229703;4709.9764501177615;4712.929306060412;4736.313234580966;7298.233685463056;7611.353034992032;7675.5010924289745;7717.189695081992;7745.302922736981;3873.86441474547;4521.389612402284;4659.184642687584;4679.883002924954;4725.64557658177;3925.6270654287796;4759.50025247351;4762.476127625959;4789.95210047895;4827.927581086216;4908.410990681141;4977.278294647256;5630.817528319017;5775.624584402;5790.681512516852;5861.824145275648;7259.854802903912;7282.162551306562;7333.266673332624;7335.3031462012095;1434.3186986181688;1661.1694152923537;1663.2931004323357;1680.546252511815;1699.354245386745;1039.2309690828731;1060.2419270221828;1084.322298563398;1086.5273605981424;1092.5629748100823;6322.589031713016;6599.043138744855;6878.931210687829;6903.689333979983;6922.861542769117;7354;7561;7584.014078169803;7586.279303466272;7628.580428076509;6998.545094568837;7014.3345528698765;7063.717451301993;7064.540804847668;7072.8939065914055;4052.3313653246882;4069.348904175318;4072.3891416287793;4109.856155034559;4125.195586860534;8084.555349455836;8085.978505373657;8087.150849160754;8088.636011379502;8125.278031859275;7750.224977502205;7914.485558438683;7998.840023199504;8028.197180282042;8028.438009339407;8000.279974802295;8047.155048719917;8069.919300806917;8075.717349892843;8107.756767296991;7681.462297639112;7702.152763195932;7717.729879454417;7718.729844455417;7746.845063098819;7552.924470755442;7577.696892124473;7583.734569290048;7586.24137586237;7610.277023682741;6640.966795165993;7681.7695469136015;8016.7194148204535;8077;8093.473924194908;4660.906781864412;4783.904321913612;4785.377900872864;4794.017226468496;4815.253635686474;7550.282723141293;7598.734044308423;7602.277783610548;7614.771556853303;7672.8849067265155;6710.959801230817;7326.853462930605;7336.156342020736;7355.852882942419;7372.2627737227995;5966.343702192668;5980.880382392241;6478.3197764235965;7285.198628150793;7297.817554561178;7062.788116356517;7118.964405178148;7150.7497237596435;7165.534240274365;7181.676824542804;7280.635968201675;7317.304856038668;7319.670614822239;7330.157031941182;7341.6329183541675;6962.54743441695;7064.858702826017;7189.532680375759;7205.963970180325;7258.419326453765 06:40:58 INFO - PROCESS | 6368 | |5;yui.html;638.3552611862019;770.8573913825946;772.3473664753282;787.2105515919975;799.6041959230182;15301.387944482236;15390.384384624616;15396.076235425868;15535.145566993811;15655.060696358227;14401.27993600321;14487.637809054779;14511.419543218284;14607.415703371878;14676.853231467681;804.6137853830165;952.4190243951184;958.4249450329816;968.9660861869836;972.9659461918834;958.6117622362954;967.6081187119228;974.6247694637544;976.8192884316425;978.5449765858874;994.751312171957;994.9154321882648;1036.8963103689646;1038.1020417339023;1038.1072277841051;1012.8278192707257;1018.5111146649575;1028.681108856253;1029.5727273181622;1030.4487099401822;661.8974059020859;681.9624920629414;723.7647764476566;734.1557209209399;747.0922828763079;15018.399264029425;15095.924520377328;15311.464098756602;15324.157171355571;15368.615784605363;13335.799963000563;13383.53157639478;13403.061785675007;13476.663083422894;13646.113002654796;10399.94800025995;10450.111740502067;10455.52950117239;10461.947690261575;10609.84085238722;3623.058004918714;3626.546681664792;3630.3465376232266;3636.672699457035;3685.631436856293;85020.57489712512;86288;88047.55976220078;88322.23355532854;88427.11572884253;9574.04259574037;9869.555869985725;9899.406035637741;9913.256505761952;10080.949595251977;21742.91285435722;21788.891055544937;21830.23594174196;21876.90615469252;21878.781212187994;7730.884036739453;7843.254890785366;7844.921550784533;7910.16943220965;8010.5994700264755;4214.578542145761;4233;4277.935830962538;4289.120730250291;4336.154449882306;3811;3823.5220597425323;3858.9035274118373;3862.8841134766003;3874.6900247980093;692.0518889121935;698.3505340033818;702.3854127638316;729.5731996781942;731.108048181218;550.7218854478543;587.3685787778155;617.7961272779971;618.2889676871633;625.2309659119218;7036.043997743238;7212.891806622905;8246.340292776564;8538.188872057144;8631.482111073356;546.8714852009774;600.534585696089;617.8270084376381;623.4246595773237;629.7323637454064;3899.4930659014713;4038.818253178614;4088.1823635273063;4094.303968325392;4221.345691417835;91332.54333728288;94531.52734236285;102071.48964255131;104128;104153;86612.56693716491;86699;87227;87558.68661970076;87686.56156719176;75266.24733752702;75626;75748.24251757412;76025;76094;7934.603269836601;8096.433249672702;8182.263596276363;8270.875936860832;8299.709510167115;52550.737246313525;52706.73646631896;52804.73597631987;52918;52938.205926910356;68147;71625;73976.89034664376;74045.6297718508;75038;8433.95783021081;8601.612927418406;9693;10251.436171010666;10523.789524209626;9358.298127640319;11169.38568378747;11289.153313501356;11428.657140285804;11656.88343116558;10739.463026848782;10991.395473249047;10992.725181870517;11002.559897604006;11089.500972456097;10790.622328218475;11654.336658799208;11931.46308416106;12184.878151218374;12304.507819687113;11531.250468719507;11782.52869885195;11803.822942655695;11821.940890295493;11955.521779128738;8438.198371154731;9868.407895526292;10088.092071713581;10099.04059114383;10308.145083519676;9440.631108489368;9919.950400247953;10207.89792102099;10296.639617613348;10407.219458540489 06:40:58 INFO - PROCESS | 6368 | __end_tp_report 06:40:58 INFO - PROCESS | 6368 | __start_cc_report 06:40:58 INFO - PROCESS | 6368 | _x_x_mozilla_cycle_collect,358 06:40:58 INFO - PROCESS | 6368 | __end_cc_report 06:40:58 INFO - PROCESS | 6368 | __startTimestamp1465220458423__endTimestamp 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | ------- Summary: start ------- 06:40:58 INFO - PROCESS | 6368 | Number of tests: 6 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#0] dojo.html Cycles:165 Average:5906.91 Median:6194.38 stddev:634.92 (10.2%) stddev-sans-first:610.74 06:40:58 INFO - PROCESS | 6368 | Values: 3609.1 3626.4 3632.0 3648.8 3665.5 5935.9 5947.6 5964.6 5973.6 6010.4 5999.8 6018.6 6023.5 6045.5 6047.5 5363.4 5379.7 5425.1 5448.6 5469.1 5352.0 5434.0 5464.9 5465.4 5475.9 5379.5 5416.5 5422.2 5422.5 5436.4 4231.5 4639.4 5470.5 5480.7 5548.6 5362.1 5423.3 5455.1 5455.3 5473.8 5714.0 5820.1 5950.0 5961.0 5982.1 5604.9 5667.2 6280.2 6283.6 6303.2 5772.9 6244.2 6262.2 6408.0 6409.6 6085.6 6115.8 6150.2 6150.7 6157.6 6509.4 6531.7 6544.9 6554.7 6567.7 6068.9 6194.6 6268.3 6269.5 6272.8 6339.3 6364.1 6378.2 6387.7 6395.4 6260.6 6269.4 6276.7 6285.4 6294.0 6159.8 6208.9 6240.7 6280.7 6310.7 5083.7 5095.7 5118.2 5122.8 5123.4 4614.7 4622.1 4624.2 4630.5 4656.7 6053.6 6082.7 6134.1 6194.4 6204.4 6229.9 6312.5 6370.9 6371.6 6407.9 6143.7 6204.4 6210.4 6210.6 6219.1 5505.4 5580.5 5634.8 5639.4 5702.6 6507.5 6574.0 6580.4 6602.2 6602.4 6361.4 6374.1 6382.7 6403.2 6406.3 6388.0 6508.3 6613.8 6622.8 6626.0 4919.8 6251.4 6286.3 6289.9 6300.4 5620.1 6259.2 6336.4 6339.3 6359.5 6129.4 6203.4 6230.3 6261.1 6262.1 5212.0 6223.3 6253.8 6256.2 6265.8 6043.1 6088.8 6201.5 6215.8 6254.2 6124.6 6231.0 6246.3 6262.3 6264.5 6184.5 6204.1 6255.9 6266.6 6277.5 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#1] ext.html Cycles:180 Average:62740.91 Median:39083.51 stddev:129991.60 (332.6%) stddev-sans-first:130272.50 06:40:58 INFO - PROCESS | 6368 | Values: 588.4 592.0 641.3 657.7 663.4 36326.5 39079.8 39080.6 39086.4 39142.4 36365.8 39836.6 40742.0 40843.8 41442.8 9069.3 9731.6 9745.3 9780.2 9783.3 9516.8 9774.4 9778.7 9792.3 9835.5 9749.9 9828.1 9832.2 9838.4 9839.7 9742.7 9760.0 9806.3 9822.4 9829.7 9690.7 9786.3 9789.8 9800.9 9813.2 34850.5 40933.2 40998.8 41000.4 41228.6 3180.3 3413.5 3443.6 3501.4 3942.9 27491.0 27977.6 28622.3 28984.9 29251.9 2738.4 2749.3 2752.4 2765.5 2889.7 339368.0 341902.0 341971.0 342948.0 416041.0 45137.0 48178.0 68821.3 69396.7 69653.0 46334.9 47796.8 47840.0 47862.0 48175.5 17307.9 17399.8 17409.3 17460.7 17464.0 13807.1 13820.4 14079.4 14105.6 14114.4 14039.9 14420.1 15327.9 15614.1 15910.8 6030.6 6114.2 6334.7 6454.6 6495.9 980.0 995.2 1024.2 1095.8 1152.5 26295.3 26845.2 30215.7 30287.7 31050.4 1135.3 1135.7 1143.3 1227.0 1261.9 13201.0 14931.6 15364.5 15640.8 15711.8 554825.0 558201.0 558384.0 559182.0 569677.0 63326.4 63686.7 64184.0 64199.0 64210.0 1412.2 1529.4 1547.5 1578.6 1579.8 29940.0 30409.8 30452.2 30613.6 30892.0 46485.8 53486.0 53957.9 54577.7 54689.0 513531.0 519896.0 524968.0 525555.0 529546.0 35602.0 35948.8 46951.3 47581.3 48669.5 44635.8 47262.3 47538.5 48002.0 48295.8 34332.8 35059.3 38891.8 38937.0 39098.0 35461.8 36557.3 38402.8 38795.6 39611.8 37960.4 38456.4 38501.6 38609.6 38783.4 27659.4 34628.0 34816.1 35162.3 35325.6 22327.9 22891.9 26184.7 26191.6 26332.6 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#2] jquery.html Cycles:180 Average:37235.71 Median:2348.24 stddev:112103.53 (4773.9%) stddev-sans-first:112383.84 06:40:58 INFO - PROCESS | 6368 | Values: 372.5 379.6 381.1 384.1 386.3 20269.1 21429.9 21507.0 22127.9 22294.8 20219.0 21673.7 21699.3 21839.0 22542.7 5922.7 5991.7 6163.2 6212.3 6218.6 4446.3 6444.3 6683.0 6701.8 6793.0 5701.4 6613.5 6614.5 6615.6 6625.6 5836.1 5856.2 5877.7 5882.3 5904.3 5447.9 5836.9 5853.5 5885.4 5900.2 13845.0 13936.4 13947.9 22099.9 26188.0 2276.4 2345.8 2350.7 2363.4 2561.6 9946.6 10114.5 10420.1 13543.6 14513.4 1741.2 1755.5 1765.3 1772.6 1784.2 113635.0 118916.0 120501.0 121555.4 123706.0 9477.7 11722.2 11771.4 11794.9 11862.7 14392.4 14520.9 14550.6 14604.5 14610.0 9040.4 9131.9 9235.2 9248.7 9268.3 9385.6 9440.4 9459.7 9488.2 9597.0 4567.0 4584.2 4621.5 4624.4 4647.8 1772.9 1858.9 1929.4 1931.0 1934.9 815.2 888.8 958.5 964.7 997.8 16735.6 19062.1 21040.6 21265.9 21506.9 977.3 991.8 1019.5 1022.3 1025.8 11103.0 11552.8 11575.0 11597.0 11600.5 563331.9 681278.0 687916.0 708980.0 720951.0 123144.4 125077.7 127353.0 131641.0 134731.0 1046.5 1078.1 1086.1 1092.2 1092.9 14929.4 18394.8 18642.9 18790.3 19213.0 53773.7 54307.7 55619.7 55752.4 56559.4 80325.0 81078.0 81600.2 83366.0 84080.0 7468.2 7472.3 7763.4 7894.1 8398.3 9440.2 12405.5 13040.0 13381.4 13437.5 9230.7 11137.7 11355.3 11680.8 11782.5 7834.2 11152.8 11194.6 11230.7 11800.3 9819.7 10250.8 11772.8 11919.7 12015.9 8160.5 8203.2 8219.3 8284.8 8433.2 8725.9 9072.7 10346.3 11034.9 11940.6 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#3] mootools.html Cycles:180 Average:6341.54 Median:543.67 stddev:3347.53 (615.7%) stddev-sans-first:3338.50 06:40:58 INFO - PROCESS | 6368 | Values: 1669.3 1678.7 2022.7 2072.2 2074.7 8247.4 9053.9 9104.0 9258.1 9286.9 9212.9 9254.3 9369.9 9389.6 9459.6 2562.3 2587.5 2593.2 2596.3 2599.1 2509.7 2571.2 2573.7 2575.7 2580.5 2560.8 2565.2 2609.5 2626.4 2647.5 2496.6 2525.5 2530.7 2531.6 2540.3 2529.8 2535.9 2542.9 2574.5 2575.2 9284.7 9342.0 9354.9 9365.8 9374.3 5664.6 5854.1 5880.1 5897.1 5948.4 3697.9 3803.1 3823.4 3824.8 3832.6 1073.4 1086.7 1088.2 1126.9 1132.7 12484.8 12486.0 12551.4 12601.4 12683.6 5026.2 5076.1 5154.2 5161.6 5257.8 10736.7 10758.0 10839.6 10849.0 10966.9 5703.3 5805.8 5807.9 5861.5 5902.4 4272.2 4672.7 5175.4 5203.6 5260.1 4123.0 4132.7 4157.8 4159.6 4170.1 1287.8 1340.1 1370.7 1378.4 1385.2 1375.9 1382.6 1404.6 1407.0 1425.8 8430.1 8623.9 8632.3 8632.4 8638.4 529.9 541.9 545.5 546.8 554.3 6378.9 6412.9 6419.1 6444.8 6447.6 10860.2 11184.2 11257.0 11345.5 11398.5 10425.1 10725.9 11069.4 11139.6 11177.2 7247.7 8274.9 8558.6 8563.0 8683.2 8257.5 8328.0 8433.0 8447.2 8491.2 8287.7 9548.9 9786.5 9902.3 9967.4 9951.8 10073.5 10079.2 10165.9 10264.3 8318.0 8348.9 8428.9 8499.1 8576.7 8526.7 8526.9 8545.0 8555.8 8576.8 7591.5 7828.8 7833.6 7941.5 7951.6 7454.8 7625.8 7751.7 7764.5 7808.1 7881.5 7958.6 8017.6 8056.0 8097.2 7177.6 7179.2 7191.3 7247.6 7267.2 7301.0 7305.9 7359.9 7371.7 7386.4 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#4] prototype.html Cycles:180 Average:5970.27 Median:6874.54 stddev:1952.71 (28.4%) stddev-sans-first:1911.21 06:40:58 INFO - PROCESS | 6368 | Values: 297.8 312.7 324.0 338.6 344.0 6870.1 6971.7 6973.3 7004.5 7035.7 6828.9 6843.7 6887.9 6896.6 6898.9 4802.1 4913.9 4996.5 5014.9 5019.4 4947.2 5002.0 5013.8 5027.2 5060.8 4931.8 4935.6 4945.8 4966.8 4980.9 4949.9 4962.6 4972.9 4985.6 5043.9 4282.2 4311.8 4318.6 4332.8 4342.7 6201.3 6530.1 6564.0 6581.4 6603.0 5803.1 5869.3 5872.2 5889.6 5895.9 7316.9 7356.0 7356.6 7356.6 7362.3 4701.9 4705.5 4710.0 4712.9 4736.3 7298.2 7611.4 7675.5 7717.2 7745.3 3873.9 4521.4 4659.2 4679.9 4725.6 3925.6 4759.5 4762.5 4790.0 4827.9 4908.4 4977.3 5630.8 5775.6 5790.7 5861.8 7259.9 7282.2 7333.3 7335.3 1434.3 1661.2 1663.3 1680.5 1699.4 1039.2 1060.2 1084.3 1086.5 1092.6 6322.6 6599.0 6878.9 6903.7 6922.9 7354.0 7561.0 7584.0 7586.3 7628.6 6998.5 7014.3 7063.7 7064.5 7072.9 4052.3 4069.3 4072.4 4109.9 4125.2 8084.6 8086.0 8087.2 8088.6 8125.3 7750.2 7914.5 7998.8 8028.2 8028.4 8000.3 8047.2 8069.9 8075.7 8107.8 7681.5 7702.2 7717.7 7718.7 7746.8 7552.9 7577.7 7583.7 7586.2 7610.3 6641.0 7681.8 8016.7 8077.0 8093.5 4660.9 4783.9 4785.4 4794.0 4815.3 7550.3 7598.7 7602.3 7614.8 7672.9 6711.0 7326.9 7336.2 7355.9 7372.3 5966.3 5980.9 6478.3 7285.2 7297.8 7062.8 7119.0 7150.7 7165.5 7181.7 7280.6 7317.3 7319.7 7330.2 7341.6 6962.5 7064.9 7189.5 7206.0 7258.4 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - PROCESS | 6368 | [#5] yui.html Cycles:180 Average:19374.29 Median:52755.74 stddev:27956.97 (53.0%) stddev-sans-first:28000.00 06:40:58 INFO - PROCESS | 6368 | Values: 638.4 770.9 772.3 787.2 799.6 15301.4 15390.4 15396.1 15535.1 15655.1 14401.3 14487.6 14511.4 14607.4 14676.9 804.6 952.4 958.4 969.0 973.0 958.6 967.6 974.6 976.8 978.5 994.8 994.9 1036.9 1038.1 1038.1 1012.8 1018.5 1028.7 1029.6 1030.4 661.9 682.0 723.8 734.2 747.1 15018.4 15095.9 15311.5 15324.2 15368.6 13335.8 13383.5 13403.1 13476.7 13646.1 10399.9 10450.1 10455.5 10461.9 10609.8 3623.1 3626.5 3630.3 3636.7 3685.6 85020.6 86288.0 88047.6 88322.2 88427.1 9574.0 9869.6 9899.4 9913.3 10080.9 21742.9 21788.9 21830.2 21876.9 21878.8 7730.9 7843.3 7844.9 7910.2 8010.6 4214.6 4233.0 4277.9 4289.1 4336.2 3811.0 3823.5 3858.9 3862.9 3874.7 692.1 698.4 702.4 729.6 731.1 550.7 587.4 617.8 618.3 625.2 7036.0 7212.9 8246.3 8538.2 8631.5 546.9 600.5 617.8 623.4 629.7 3899.5 4038.8 4088.2 4094.3 4221.3 91332.5 94531.5 102071.5 104128.0 104153.0 86612.6 86699.0 87227.0 87558.7 87686.6 75266.2 75626.0 75748.2 76025.0 76094.0 7934.6 8096.4 8182.3 8270.9 8299.7 52550.7 52706.7 52804.7 52918.0 52938.2 68147.0 71625.0 73976.9 74045.6 75038.0 8434.0 8601.6 9693.0 10251.4 10523.8 9358.3 11169.4 11289.2 11428.7 11656.9 10739.5 10991.4 10992.7 11002.6 11089.5 10790.6 11654.3 11931.5 12184.9 12304.5 11531.3 11782.5 11803.8 11821.9 11955.5 8438.2 9868.4 10088.1 10099.0 10308.1 9440.6 9920.0 10207.9 10296.6 10407.2 06:40:58 INFO - PROCESS | 6368 | -------- Summary: end -------- 06:40:58 INFO - PROCESS | 6368 | 06:40:58 INFO - TEST-INFO | 6368: exit 0 06:40:58 INFO - TEST-OK | dromaeo_css | took 1109251ms 06:40:58 INFO - TEST-START | kraken 06:40:58 INFO - operating with platform_type : mac_ 06:40:58 INFO - Initialising browser for kraken test... 06:40:58 INFO - TEST-INFO | started process 6373 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmprU2Ddq/profile http://localhost:57303/getInfo.html) 06:41:01 INFO - PROCESS | 6373 | __metrics Screen width/height:1600/1200 06:41:01 INFO - PROCESS | 6373 | colorDepth:24 06:41:01 INFO - PROCESS | 6373 | Browser inner width/height: 1024/689 06:41:01 INFO - PROCESS | 6373 | __metrics 06:41:01 ERROR - PROCESS | 6373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:41:02 INFO - TEST-INFO | 6373: exit 0 06:41:02 INFO - Browser initialized. 06:41:02 INFO - Running cycle 1/1 for kraken test... 06:41:02 INFO - TEST-INFO | started process 6377 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmprU2Ddq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:14 INFO - PROCESS | 6377 | RSS: Main: 167960576 06:41:14 INFO - PROCESS | 6377 | 06:41:16 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57303/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:17 INFO - PROCESS | 6377 | RSS: Main: 179589120 06:41:17 INFO - PROCESS | 6377 | 06:41:20 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57303/tests/kraken/driver.html?testName=audio-dft) 06:41:20 INFO - PROCESS | 6377 | RSS: Main: 188628992 06:41:20 INFO - PROCESS | 6377 | 06:41:23 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57303/tests/kraken/driver.html?testName=audio-fft) 06:41:24 INFO - PROCESS | 6377 | RSS: Main: 192380928 06:41:24 INFO - PROCESS | 6377 | 06:41:26 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57303/tests/kraken/driver.html?testName=audio-oscillator) 06:41:27 INFO - PROCESS | 6377 | RSS: Main: 193015808 06:41:27 INFO - PROCESS | 6377 | 06:41:29 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:29 INFO - PROCESS | 6377 | RSS: Main: 194617344 06:41:29 INFO - PROCESS | 6377 | 06:41:32 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57303/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:33 INFO - PROCESS | 6377 | RSS: Main: 194400256 06:41:33 INFO - PROCESS | 6377 | 06:41:36 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57303/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:36 INFO - PROCESS | 6377 | RSS: Main: 194244608 06:41:36 INFO - PROCESS | 6377 | 06:41:39 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57303/tests/kraken/driver.html?testName=json-parse-financial) 06:41:40 INFO - PROCESS | 6377 | RSS: Main: 194478080 06:41:40 INFO - PROCESS | 6377 | 06:41:41 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:42 INFO - PROCESS | 6377 | RSS: Main: 194105344 06:41:42 INFO - PROCESS | 6377 | 06:41:44 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:45 INFO - PROCESS | 6377 | RSS: Main: 194101248 06:41:45 INFO - PROCESS | 6377 | 06:41:47 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:47 INFO - PROCESS | 6377 | RSS: Main: 194072576 06:41:47 INFO - PROCESS | 6377 | 06:41:50 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:50 INFO - PROCESS | 6377 | RSS: Main: 194248704 06:41:50 INFO - PROCESS | 6377 | 06:41:53 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:53 INFO - PROCESS | 6377 | RSS: Main: 194195456 06:41:53 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | Cycle 1(1): loaded http://localhost:57303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57303/tests/kraken/driver.html?testName=ai-astar) 06:41:55 INFO - PROCESS | 6377 | RSS: Main: 195862528 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | __start_tp_report 06:41:55 INFO - PROCESS | 6377 | _x_x_mozilla_page_load 06:41:55 INFO - PROCESS | 6377 | _x_x_mozilla_page_load_details 06:41:55 INFO - PROCESS | 6377 | |i|pagename|runs| 06:41:55 INFO - PROCESS | 6377 | |0;ai-astar;116;112;116;114;116;130;114;114;114;114 06:41:55 INFO - PROCESS | 6377 | |1;audio-beat-detection;146;122;153;148;118;139;146;184;173;104 06:41:55 INFO - PROCESS | 6377 | |2;audio-dft;191;201;230;278;206;196;201;196;197;195 06:41:55 INFO - PROCESS | 6377 | |3;audio-fft;75;81;74;110;74;54;53;67;116;67 06:41:55 INFO - PROCESS | 6377 | |4;audio-oscillator;87;86;122;78;81;82;121;78;78;121 06:41:55 INFO - PROCESS | 6377 | |5;imaging-gaussian-blur;87;86;91;78;134;129;134;86;89;87 06:41:55 INFO - PROCESS | 6377 | |6;imaging-darkroom;95;95;95;95;106;94;94;95;95;94 06:41:55 INFO - PROCESS | 6377 | |7;imaging-desaturate;90;134;143;142;91;92;119;105;144;144 06:41:55 INFO - PROCESS | 6377 | |8;json-parse-financial;57;58;59;67;60;65;87;89;62;59 06:41:55 INFO - PROCESS | 6377 | |9;json-stringify-tinderbox;66;70;72;59;93;105;59;84;72;68 06:41:55 INFO - PROCESS | 6377 | |10;stanford-crypto-aes;81;84;82;84;82;83;81;80;85;83 06:41:55 INFO - PROCESS | 6377 | |11;stanford-crypto-ccm;136;125;129;121;120;120;146;117;119;121 06:41:55 INFO - PROCESS | 6377 | |12;stanford-crypto-pbkdf2;136;136;135;132;174;108;157;133;127;165 06:41:55 INFO - PROCESS | 6377 | |13;stanford-crypto-sha256-iterative;65;67;67;67;67;67;68;64;67;65 06:41:55 INFO - PROCESS | 6377 | __end_tp_report 06:41:55 INFO - PROCESS | 6377 | __start_cc_report 06:41:55 INFO - PROCESS | 6377 | _x_x_mozilla_cycle_collect,909 06:41:55 INFO - PROCESS | 6377 | __end_cc_report 06:41:55 INFO - PROCESS | 6377 | __startTimestamp1465220515863__endTimestamp 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | ------- Summary: start ------- 06:41:55 INFO - PROCESS | 6377 | Number of tests: 14 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:5.08 (4.4%) stddev-sans-first:5.39 06:41:55 INFO - PROCESS | 6377 | Values: 116.0 112.0 116.0 114.0 116.0 130.0 114.0 114.0 114.0 114.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:147.00 stddev:24.33 (16.5%) stddev-sans-first:25.78 06:41:55 INFO - PROCESS | 6377 | Values: 146.0 122.0 153.0 148.0 118.0 139.0 146.0 184.0 173.0 104.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#2] audio-dft Cycles:10 Average:209.10 Median:201.00 stddev:26.54 (13.2%) stddev-sans-first:27.33 06:41:55 INFO - PROCESS | 6377 | Values: 191.0 201.0 230.0 278.0 206.0 196.0 201.0 196.0 197.0 195.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#3] audio-fft Cycles:10 Average:77.10 Median:70.50 stddev:20.96 (29.7%) stddev-sans-first:22.21 06:41:55 INFO - PROCESS | 6377 | Values: 75.0 81.0 74.0 110.0 74.0 54.0 53.0 67.0 116.0 67.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.50 stddev:19.53 (24.6%) stddev-sans-first:20.58 06:41:55 INFO - PROCESS | 6377 | Values: 87.0 86.0 122.0 78.0 81.0 82.0 121.0 78.0 78.0 121.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#5] imaging-gaussian-blur Cycles:10 Average:100.10 Median:86.50 stddev:22.53 (26.0%) stddev-sans-first:23.39 06:41:55 INFO - PROCESS | 6377 | Values: 87.0 86.0 91.0 78.0 134.0 129.0 134.0 86.0 89.0 87.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:95.00 stddev:3.61 (3.8%) stddev-sans-first:3.82 06:41:55 INFO - PROCESS | 6377 | Values: 95.0 95.0 95.0 95.0 106.0 94.0 94.0 95.0 95.0 94.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#7] imaging-desaturate Cycles:10 Average:120.40 Median:144.00 stddev:23.83 (16.5%) stddev-sans-first:22.59 06:41:55 INFO - PROCESS | 6377 | Values: 90.0 134.0 143.0 142.0 91.0 92.0 119.0 105.0 144.0 144.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:63.50 stddev:11.86 (18.7%) stddev-sans-first:12.09 06:41:55 INFO - PROCESS | 6377 | Values: 57.0 58.0 59.0 67.0 60.0 65.0 87.0 89.0 62.0 59.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:71.00 stddev:14.87 (20.9%) stddev-sans-first:15.43 06:41:55 INFO - PROCESS | 6377 | Values: 66.0 70.0 72.0 59.0 93.0 105.0 59.0 84.0 72.0 68.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.58 (1.9%) stddev-sans-first:1.58 06:41:55 INFO - PROCESS | 6377 | Values: 81.0 84.0 82.0 84.0 82.0 83.0 81.0 80.0 85.0 83.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:123.00 stddev:9.18 (7.5%) stddev-sans-first:8.90 06:41:55 INFO - PROCESS | 6377 | Values: 136.0 125.0 129.0 121.0 120.0 120.0 146.0 117.0 119.0 121.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:136.00 stddev:19.53 (14.4%) stddev-sans-first:20.65 06:41:55 INFO - PROCESS | 6377 | Values: 136.0 136.0 135.0 132.0 174.0 108.0 157.0 133.0 127.0 165.0 06:41:55 INFO - PROCESS | 6377 | 06:41:55 INFO - PROCESS | 6377 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 06:41:55 INFO - PROCESS | 6377 | Values: 65.0 67.0 67.0 67.0 67.0 67.0 68.0 64.0 67.0 65.0 06:41:55 INFO - PROCESS | 6377 | -------- Summary: end -------- 06:41:55 INFO - PROCESS | 6377 | 06:41:56 INFO - TEST-INFO | 6377: exit 0 06:41:56 INFO - TEST-OK | kraken | took 57670ms 06:41:56 INFO - SUITE-END | took 1166s 06:41:57 INFO - Completed test suite (00:19:27) 06:41:57 INFO - javascript benchmark 06:41:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3609.079684680406, 3626.383514802483, 3631.9818400907993, 3648.7628304160244, 3665.5051568038325, 5935.940640593592, 5947.553933454992, 5964.5526585506095, 5973.5818492705475, 6010.398960103998, 5999.820005399834, 6018.638881667103, 6023.457888790008, 6045.546584006206, 6047.455728984391, 5363.436839131884, 5379.65032272901, 5425.13197888338, 5448.564114870821, 5469.124940009599, 5352.009878172531, 5434.049041417736, 5464.9453505465035, 5465.398806131322, 5475.917861232065, 5379.515843574078, 5416.51251387375, 5422.15956526739, 5422.53908417785, 5436.374816896068, 4231.492220933493, 4639.373684552576, 5470.507654311092, 5480.671159730429, 5548.58385621076, 5362.088444964365, 5423.322084739408, 5455.099908515091, 5455.345358556999, 5473.781048758045, 5714.000049991235, 5820.097884827816, 5949.970250148722, 5961.046232602763, 5982.102684597346, 5604.859878503029, 5667.206591077253, 6280.1835761351185, 6283.560150789446, 6303.180586523768, 5772.942270577324, 6244.219472565929, 6262.1546091278005, 6407.967960160169, 6409.551331406803, 6085.574009819315, 6115.788007244244, 6150.231221097363, 6150.661713605795, 6157.568970172135, 6509.446697030806, 6531.706073226716, 6544.869102617921, 6554.7378104876225, 6567.737290508326, 6068.908966365508, 6194.5973511721595, 6268.279147897959, 6269.498440124779, 6272.843178920563, 6339.334369891095, 6364.077208804697, 6378.2346118466085, 6387.744490220432, 6395.42441180296, 6260.561760676709, 6269.435750782361, 6276.686165691697, 6285.402886725754, 6293.968530157412, 6159.81520554384, 6208.937910620836, 6240.65676387794, 6280.748770049238, 6310.7475700971445, 5083.74581270935, 5095.694258344512, 5118.181091025418, 5122.769475373542, 5123.436421993578, 4614.653900957442, 4622.121796858586, 4624.237000894882, 4630.467496237909, 4656.674032817738, 6053.606515576474, 6082.665453400017, 6134.069235337315, 6194.38056194377, 6204.441600255998, 6229.937700623026, 6312.495000400048, 6370.936290637127, 6371.617702937839, 6407.871842563216, 6143.723532441051, 6204.3795620437595, 6210.378962103844, 6210.5652604317265, 6219.098230756515, 5505.394406615269, 5580.497755202051, 5634.802781902614, 5639.407862174495, 5702.6293290935955, 6507.544471886922, 6573.967130164318, 6580.440662543641, 6602.240742314695, 6602.40578347951, 6361.395667411589, 6374.107624932606, 6382.712777924911, 6403.167588213502, 6406.263279722892, 6387.968060159669, 6508.349165083454, 6613.801585952429, 6622.768203112868, 6625.966870165618, 4919.827806026772, 6251.4061164189325, 6286.339934307015, 6289.874202516015, 6300.401461861115, 5620.053690339232, 6259.2488901332135, 6336.429721325103, 6339.270983836917, 6359.459445947146, 6129.387061293835, 6203.379662033941, 6230.283517395557, 6261.092141639346, 6262.123302737529, 5211.973940130427, 6223.253209614694, 6253.78111766086, 6256.249250090018, 6265.780697675559, 6043.09353596964, 6088.756449741961, 6201.534884883742, 6215.844603884758, 6254.155688981929, 6124.564025909317, 6230.968845155927, 6246.281677606951, 6262.279837818709, 6264.530160238091, 6184.536159787944, 6204.100405441276, 6255.906161407492, 6266.624002559861, 6277.529185311028], "unit": "score", "name": "dojo.html", "value": 5870.200896307651}, {"lowerIsBetter": false, "replicates": [588.4497994375259, 591.9763209471619, 641.3234038089819, 657.7138944559116, 663.4360793325673, 36326.45510317344, 39079.804600977026, 39080.60919390805, 39086.41370379443, 39142.412863806996, 36365.81817090911, 39836.60163398365, 40741.981450463754, 40843.79578102113, 41442.7927860361, 9069.319801014917, 9731.610735570604, 9745.31782775206, 9780.168685661693, 9783.266255030865, 9516.762080947963, 9774.364666296704, 9778.706638800812, 9792.265580081486, 9835.508224588777, 9749.853752193687, 9828.115469607734, 9832.213422926185, 9838.360506567085, 9839.655612053579, 9742.659006934759, 9760.023997600254, 9806.264530160232, 9822.361546499526, 9829.707048138882, 9690.709278721579, 9786.314957952874, 9789.804203915954, 9800.852987205197, 9813.165880900133, 34850.47724284112, 40933.1813363734, 40998.79500602478, 41000.38499422511, 41228.587714122776, 3180.3480286541435, 3413.4709120086427, 3443.6039855416698, 3501.38725723, 3942.8619998299923, 27491.0, 27977.580336294974, 28622.284442888886, 28984.855075724696, 29251.85374073116, 2738.3564862257354, 2749.2714430675687, 2752.4219913818124, 2765.502209602271, 2889.725476079769, 339368.0, 341902.0, 341971.0, 342948.0, 416041.0, 45137.0, 48178.0, 68821.31178688249, 69396.6530167356, 69653.0, 46334.914928828286, 47796.80507987328, 47840.0, 47862.04275914462, 48175.5182448178, 17307.91346043287, 17399.826001740075, 17409.303627854744, 17460.73808892842, 17464.0, 13807.102538334975, 13820.447182112805, 14079.436822526985, 14105.647358815906, 14114.435422583187, 14039.947003974743, 14420.062695924731, 15327.850411219204, 15614.063156210665, 15910.840891591168, 6030.5778595497895, 6114.205153330038, 6334.651594162366, 6454.6449945252525, 6495.902561461582, 979.9902000980042, 995.1690338567378, 1024.2318261304022, 1095.802755504001, 1152.5217034930577, 26295.34261643436, 26845.194644160707, 30215.697843021728, 30287.697123028487, 31050.378992420025, 1135.2961164078324, 1135.7103938495632, 1143.3140115930541, 1226.9938650306663, 1261.8548866880242, 13201.019574847302, 14931.552053438414, 15364.539063828102, 15640.765388519181, 15711.842881571267, 554825.0, 558201.0, 558384.0, 559182.0, 569677.0, 63326.36673633205, 63686.6815665928, 64184.0, 64199.037014443886, 64210.0, 1412.237391808412, 1529.4417537598697, 1547.473858887961, 1578.5974576483154, 1579.8104227492774, 29940.0, 30409.847950760104, 30452.19123505976, 30613.609019205884, 30892.0, 46485.76757116193, 53486.0, 53957.92084158216, 54577.72711136419, 54689.0, 513531.0, 519896.0, 524968.0, 525555.0, 529546.0, 35602.0, 35948.82025589855, 46951.29573056338, 47581.28628070651, 48669.5133048665, 44635.77682111569, 47262.29957858597, 47538.524614754795, 48002.03995920132, 48295.75852120717, 34332.82833585816, 35059.298814024085, 38891.833245002694, 38937.0, 39098.0, 35461.82269088638, 36557.26885462329, 38402.807985959895, 38795.6120438792, 39611.80194099011, 37960.430593540565, 38456.423153653275, 38501.6149838498, 38609.613903861726, 38783.41824872573, 27659.446811063262, 34628.0, 34816.129596760285, 35162.29675406529, 35325.64674353327, 22327.88360581932, 22891.88554057219, 26184.73815261823, 26191.607125892744, 26332.605010925236], "unit": "score", "name": "ext.html", "value": 19820.60818846524}, {"lowerIsBetter": false, "replicates": [372.50270888364014, 379.5843551311314, 381.0853950518755, 384.06671787556263, 386.31236399209405, 20269.087891044903, 21429.928503574796, 21507.03218355174, 22127.889360553196, 22294.777052229474, 20219.0, 21673.67489487659, 21699.3490195294, 21839.0, 22542.661860072112, 5922.703864806764, 5991.670458124801, 6163.1896754086765, 6212.254529456472, 6218.564700470969, 4446.266366049614, 6444.323346048668, 6682.966585167067, 6701.832454188636, 6792.966035169818, 5701.372848986629, 6613.503987200955, 6614.50391220658, 6615.569987950792, 6625.602463852184, 5836.095405212178, 5856.209411729405, 5877.735501902424, 5882.264716910387, 5904.261967254093, 5447.945520544784, 5836.854078648068, 5853.502452291517, 5885.411458854123, 5900.203472531196, 13845.030847840655, 13936.442542298297, 13947.930260348634, 22099.889500552556, 26188.0, 2276.3512398966213, 2345.7654234576407, 2350.717913850332, 2363.3855197648736, 2561.6157576363694, 9946.602135914554, 10114.54484548197, 10420.114290285335, 13543.59369218925, 14513.419463221458, 1741.2425594866274, 1755.543558674741, 1765.3203516646183, 1772.6100257943233, 1784.1703607822426, 113635.0, 118916.0, 120501.0, 121555.3922230392, 123706.0, 9477.715668529818, 11722.238054526428, 11771.411429428494, 11794.88205117955, 11862.703432414259, 14392.35234414454, 14520.927395362956, 14550.563483095524, 14604.488842890449, 14610.0, 9040.367174297737, 9131.863022054675, 9235.21500672437, 9248.676296329731, 9268.25853931684, 9385.624575016924, 9440.386374885611, 9459.668911588062, 9488.240940724725, 9596.952015240018, 4567.0, 4584.220682483986, 4621.491635920046, 4624.421947256593, 4647.814087436533, 1772.9202185901665, 1858.8605854560692, 1929.4308179087202, 1930.9517262068562, 1934.8935808530666, 815.176671561727, 888.8266787976282, 958.5111593087576, 964.6623681711485, 997.8154041502345, 16735.581610459834, 19062.14220360087, 21040.579188416144, 21265.93670316478, 21506.89246553757, 977.2994988719577, 991.7669347703284, 1019.4953498018529, 1022.320157095538, 1025.8307379282335, 11103.0, 11552.76894462106, 11575.0, 11596.956273935386, 11600.535978560933, 563331.9167020775, 681278.0, 687916.0, 708980.0, 720951.0, 123144.38427807804, 125077.74922250661, 127353.0, 131641.0253846193, 134731.0, 1046.5238316565944, 1078.0620859851979, 1086.098538213297, 1092.1644941619668, 1092.918031147667, 14929.402823887358, 18394.81605183931, 18642.906785465984, 18790.342338018105, 19213.0, 53773.731131344095, 54307.72846135744, 55619.721901390236, 55752.442475574724, 56559.43440565542, 80325.0, 81078.0, 81600.18399815926, 83366.0, 84080.0, 7468.1785003648465, 7472.327490525879, 7763.378929685725, 7894.092179399443, 8398.286145677686, 9440.244780417688, 12405.503779849067, 13040.0, 13381.39783709716, 13437.529686460926, 9230.676926307548, 11137.665870023913, 11355.318680879174, 11680.766384672428, 11782.469788859351, 7834.177411371952, 11152.832707509231, 11194.552217911192, 11230.66308010761, 11800.291982481078, 9819.656312029045, 10250.769907611135, 11772.764544708887, 11919.702007449883, 12015.879841201477, 8160.469569477965, 8203.220694034057, 8219.301359384519, 8284.792880177803, 8433.19884610961, 8725.869111963453, 9072.682456114268, 10346.32748871321, 11034.889651103707, 11940.6268279149], "unit": "score", "name": "jquery.html", "value": 9701.12328867755}, {"lowerIsBetter": false, "replicates": [1669.2571805546534, 1678.6558755455133, 2022.7168196452499, 2072.181488312118, 2074.7406574178217, 8247.42268041236, 9053.909460905388, 9104.0, 9258.120478554543, 9286.885573731153, 9212.907870921288, 9254.259659227262, 9369.859452108223, 9389.577469013893, 9459.621615135386, 2562.269753120356, 2587.521308557923, 2593.15722390223, 2596.3119773260005, 2599.0773275487213, 2509.6862892138483, 2571.190075126339, 2573.6525569048126, 2575.652286941267, 2580.4710034442987, 2560.8463492190435, 2565.191964531167, 2609.517239310724, 2626.3828000419885, 2647.5102106110335, 2496.575582151039, 2525.4696513732047, 2530.746925307473, 2531.6202569614707, 2540.326813394452, 2529.7723204911463, 2535.9112431064823, 2542.9364265893314, 2574.5365834149848, 2575.22743177048, 9284.675036373694, 9342.01908799573, 9354.859677104849, 9365.812683746288, 9374.343795934288, 5664.575156863251, 5854.063349864001, 5880.059190529495, 5897.14491398749, 5948.37542058082, 3697.852085916587, 3803.0872590578338, 3823.4264860270905, 3824.7896365699876, 3832.6358995895343, 1073.4364458659188, 1086.6957251969382, 1088.1621151713216, 1126.8929451702074, 1132.6998345438383, 12484.81272780909, 12486.0, 12551.372431378395, 12601.369931503388, 12683.556075537312, 5026.246063090565, 5076.0863044652315, 5154.226865970059, 5161.5870730341485, 5257.8159764408065, 10736.677899663022, 10758.0, 10839.566417343218, 10849.0, 10966.945165274283, 5703.315602127771, 5805.767769289266, 5807.94192058074, 5861.501772349398, 5902.409759024149, 4272.209641216323, 4672.696274742131, 5175.430702622709, 5203.583713303003, 5260.132078207053, 4122.979385103115, 4132.669386449077, 4157.792110394529, 4159.646430053479, 4170.061736109351, 1287.76820172368, 1340.1356125299321, 1370.6504841265414, 1378.3521744779937, 1385.1550554161954, 1375.9243241621807, 1382.5644921849585, 1404.571605660263, 1407.04321061677, 1425.8146440962817, 8430.114837941928, 8623.913760862437, 8632.266257368068, 8632.395732298804, 8638.352123590756, 529.9057446373226, 541.8834950485665, 545.4627192215744, 546.8222827581052, 554.287740253772, 6378.904316435257, 6412.903806442907, 6419.069234960904, 6444.7744328948265, 6447.6453795041725, 10860.239783215256, 11184.161187910939, 11257.043151332065, 11345.489452974636, 11398.487068081957, 10425.061744443037, 10725.946370268099, 11069.391183484824, 11139.554417823196, 11177.161712871568, 7247.710091596383, 8274.875876861852, 8558.614862331086, 8562.957185214158, 8683.175098365646, 8257.504549727035, 8327.958360208402, 8433.030201526657, 8447.239748422671, 8491.15088491146, 8287.709930152416, 9548.904510954802, 9786.51067446639, 9902.306838521523, 9967.40195588238, 9951.751206219902, 10073.546690399096, 10079.24405669563, 10165.949170254102, 10264.33281836708, 8317.95841020791, 8348.916510834813, 8428.915710842813, 8499.065102838558, 8576.699815506427, 8526.701565445179, 8526.91473085286, 8545.0, 8555.786105347415, 8576.785580360542, 7591.506552074097, 7828.84342313162, 7833.5691536966015, 7941.483803552751, 7951.562664053533, 7454.776356709307, 7625.809354765954, 7751.6511756972195, 7764.495307804975, 7808.063032436144, 7881.527108373516, 7958.602069896367, 8017.63920623585, 8056.0, 8097.2307630774985, 7177.605231712306, 7179.210286868336, 7191.280871912767, 7247.637618119178, 7267.236940121211, 7300.96349518249, 7305.926940730525, 7359.889601656087, 7371.668274927534, 7386.372158366599], "unit": "score", "name": "mootools.html", "value": 5094.9789306769935}, {"lowerIsBetter": false, "replicates": [297.79245160872665, 312.6888745698031, 323.98866039688613, 338.6072156298694, 343.9776414533055, 6870.141232345957, 6971.686274117665, 6973.302669733024, 7004.5096843221, 7035.71857125715, 6828.863422731555, 6843.65781710915, 6887.862242755142, 6896.586204827701, 6898.862022759555, 4802.063597598479, 4913.852584422473, 4996.525330093654, 5014.899702005958, 5019.422766381858, 4947.158982972904, 5002.0, 5013.799448022093, 5027.195648696209, 5060.84817455477, 4931.827386041489, 4935.605151587883, 4945.7774400152075, 4966.801327946896, 4980.900381992376, 4949.901001979958, 4962.627802914796, 4972.8508144755715, 4985.6260780441435, 5043.924341134886, 4282.164977829325, 4311.78441077948, 4318.5681431856565, 4332.783360831977, 4342.717723348004, 6201.255849298068, 6530.085787989685, 6564.0, 6581.407673309377, 6603.042558828943, 5803.100519419497, 5869.270789083054, 5872.177895094647, 5889.587728858982, 5895.911561326584, 7316.926830731678, 7355.963220183865, 7356.595387253699, 7356.595387253752, 7362.3373896349585, 4701.882452938704, 4705.458872229703, 4709.9764501177615, 4712.929306060412, 4736.313234580966, 7298.233685463056, 7611.353034992032, 7675.5010924289745, 7717.189695081992, 7745.302922736981, 3873.86441474547, 4521.389612402284, 4659.184642687584, 4679.883002924954, 4725.64557658177, 3925.6270654287796, 4759.50025247351, 4762.476127625959, 4789.95210047895, 4827.927581086216, 4908.410990681141, 4977.278294647256, 5630.817528319017, 5775.624584402, 5790.681512516852, 5861.824145275648, 7259.854802903912, 7282.162551306562, 7333.266673332624, 7335.3031462012095, 1434.3186986181688, 1661.1694152923537, 1663.2931004323357, 1680.546252511815, 1699.354245386745, 1039.2309690828731, 1060.2419270221828, 1084.322298563398, 1086.5273605981424, 1092.5629748100823, 6322.589031713016, 6599.043138744855, 6878.931210687829, 6903.689333979983, 6922.861542769117, 7354.0, 7561.0, 7584.014078169803, 7586.279303466272, 7628.580428076509, 6998.545094568837, 7014.3345528698765, 7063.717451301993, 7064.540804847668, 7072.8939065914055, 4052.3313653246882, 4069.348904175318, 4072.3891416287793, 4109.856155034559, 4125.195586860534, 8084.555349455836, 8085.978505373657, 8087.150849160754, 8088.636011379502, 8125.278031859275, 7750.224977502205, 7914.485558438683, 7998.840023199504, 8028.197180282042, 8028.438009339407, 8000.279974802295, 8047.155048719917, 8069.919300806917, 8075.717349892843, 8107.756767296991, 7681.462297639112, 7702.152763195932, 7717.729879454417, 7718.729844455417, 7746.845063098819, 7552.924470755442, 7577.696892124473, 7583.734569290048, 7586.24137586237, 7610.277023682741, 6640.966795165993, 7681.7695469136015, 8016.7194148204535, 8077.0, 8093.473924194908, 4660.906781864412, 4783.904321913612, 4785.377900872864, 4794.017226468496, 4815.253635686474, 7550.282723141293, 7598.734044308423, 7602.277783610548, 7614.771556853303, 7672.8849067265155, 6710.959801230817, 7326.853462930605, 7336.156342020736, 7355.852882942419, 7372.2627737227995, 5966.343702192668, 5980.880382392241, 6478.3197764235965, 7285.198628150793, 7297.817554561178, 7062.788116356517, 7118.964405178148, 7150.7497237596435, 7165.534240274365, 7181.676824542804, 7280.635968201675, 7317.304856038668, 7319.670614822239, 7330.157031941182, 7341.6329183541675, 6962.54743441695, 7064.858702826017, 7189.532680375759, 7205.963970180325, 7258.419326453765], "unit": "score", "name": "prototype.html", "value": 5307.185893671954}, {"lowerIsBetter": false, "replicates": [638.3552611862019, 770.8573913825946, 772.3473664753282, 787.2105515919975, 799.6041959230182, 15301.387944482236, 15390.384384624616, 15396.076235425868, 15535.145566993811, 15655.060696358227, 14401.27993600321, 14487.637809054779, 14511.419543218284, 14607.415703371878, 14676.853231467681, 804.6137853830165, 952.4190243951184, 958.4249450329816, 968.9660861869836, 972.9659461918834, 958.6117622362954, 967.6081187119228, 974.6247694637544, 976.8192884316425, 978.5449765858874, 994.751312171957, 994.9154321882648, 1036.8963103689646, 1038.1020417339023, 1038.1072277841051, 1012.8278192707257, 1018.5111146649575, 1028.681108856253, 1029.5727273181622, 1030.4487099401822, 661.8974059020859, 681.9624920629414, 723.7647764476566, 734.1557209209399, 747.0922828763079, 15018.399264029425, 15095.924520377328, 15311.464098756602, 15324.157171355571, 15368.615784605363, 13335.799963000563, 13383.53157639478, 13403.061785675007, 13476.663083422894, 13646.113002654796, 10399.94800025995, 10450.111740502067, 10455.52950117239, 10461.947690261575, 10609.84085238722, 3623.058004918714, 3626.546681664792, 3630.3465376232266, 3636.672699457035, 3685.631436856293, 85020.57489712512, 86288.0, 88047.55976220078, 88322.23355532854, 88427.11572884253, 9574.04259574037, 9869.555869985725, 9899.406035637741, 9913.256505761952, 10080.949595251977, 21742.91285435722, 21788.891055544937, 21830.23594174196, 21876.90615469252, 21878.781212187994, 7730.884036739453, 7843.254890785366, 7844.921550784533, 7910.16943220965, 8010.5994700264755, 4214.578542145761, 4233.0, 4277.935830962538, 4289.120730250291, 4336.154449882306, 3811.0, 3823.5220597425323, 3858.9035274118373, 3862.8841134766003, 3874.6900247980093, 692.0518889121935, 698.3505340033818, 702.3854127638316, 729.5731996781942, 731.108048181218, 550.7218854478543, 587.3685787778155, 617.7961272779971, 618.2889676871633, 625.2309659119218, 7036.043997743238, 7212.891806622905, 8246.340292776564, 8538.188872057144, 8631.482111073356, 546.8714852009774, 600.534585696089, 617.8270084376381, 623.4246595773237, 629.7323637454064, 3899.4930659014713, 4038.818253178614, 4088.1823635273063, 4094.303968325392, 4221.345691417835, 91332.54333728288, 94531.52734236285, 102071.48964255131, 104128.0, 104153.0, 86612.56693716491, 86699.0, 87227.0, 87558.68661970076, 87686.56156719176, 75266.24733752702, 75626.0, 75748.24251757412, 76025.0, 76094.0, 7934.603269836601, 8096.433249672702, 8182.263596276363, 8270.875936860832, 8299.709510167115, 52550.737246313525, 52706.73646631896, 52804.73597631987, 52918.0, 52938.205926910356, 68147.0, 71625.0, 73976.89034664376, 74045.6297718508, 75038.0, 8433.95783021081, 8601.612927418406, 9693.0, 10251.436171010666, 10523.789524209626, 9358.298127640319, 11169.38568378747, 11289.153313501356, 11428.657140285804, 11656.88343116558, 10739.463026848782, 10991.395473249047, 10992.725181870517, 11002.559897604006, 11089.500972456097, 10790.622328218475, 11654.336658799208, 11931.46308416106, 12184.878151218374, 12304.507819687113, 11531.250468719507, 11782.52869885195, 11803.822942655695, 11821.940890295493, 11955.521779128738, 8438.198371154731, 9868.407895526292, 10088.092071713581, 10099.04059114383, 10308.145083519676, 9440.631108489368, 9919.950400247953, 10207.89792102099, 10296.639617613348, 10407.219458540489], "unit": "score", "name": "yui.html", "value": 7152.190583380917}], "name": "dromaeo_css", "value": 7759.702345391349}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 116.0, 114.0, 116.0, 130.0, 114.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 153.0, 148.0, 118.0, 139.0, 146.0, 184.0, 173.0, 104.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [191.0, 201.0, 230.0, 278.0, 206.0, 196.0, 201.0, 196.0, 197.0, 195.0], "unit": "score", "name": "audio-dft", "value": 209.1}, {"lowerIsBetter": true, "replicates": [75.0, 81.0, 74.0, 110.0, 74.0, 54.0, 53.0, 67.0, 116.0, 67.0], "unit": "score", "name": "audio-fft", "value": 77.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 122.0, 78.0, 81.0, 82.0, 121.0, 78.0, 78.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 91.0, 78.0, 134.0, 129.0, 134.0, 86.0, 89.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 106.0, 94.0, 94.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.8}, {"lowerIsBetter": true, "replicates": [90.0, 134.0, 143.0, 142.0, 91.0, 92.0, 119.0, 105.0, 144.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 120.4}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 59.0, 67.0, 60.0, 65.0, 87.0, 89.0, 62.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 72.0, 59.0, 93.0, 105.0, 59.0, 84.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.8}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 82.0, 84.0, 82.0, 83.0, 81.0, 80.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [136.0, 125.0, 129.0, 121.0, 120.0, 120.0, 146.0, 117.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 135.0, 132.0, 174.0, 108.0, 157.0, 133.0, 127.0, 165.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 64.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1510.9}]} 06:41:57 INFO - Return code: 0 06:41:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:57 ERROR - # TBPL SUCCESS # 06:41:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:41:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:41:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:41:57 INFO - 2016-06-06 06:41:57.173 screenresolution[6382:108292] starting screenresolution argv=screenresolution get 06:41:57 INFO - 2016-06-06 06:41:57.175 screenresolution[6382:108292] Display 0: 1600x1200x32@60 06:41:57 INFO - 2016-06-06 06:41:57.181 screenresolution[6383:108295] starting screenresolution argv=screenresolution list 06:41:57 INFO - Available Modes on Display 0 06:41:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:41:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:41:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:41:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:41:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:41:57 INFO - Intel Iris: 06:41:57 INFO - Chipset Model: Intel Iris 06:41:57 INFO - Type: GPU 06:41:57 INFO - Bus: Built-In 06:41:57 INFO - VRAM (Dynamic, Max): 1536 MB 06:41:57 INFO - Vendor: Intel (0x8086) 06:41:57 INFO - Device ID: 0x0a2e 06:41:57 INFO - Revision ID: 0x0009 06:41:57 INFO - Displays: 06:41:57 INFO - Display: 06:41:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:41:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:41:57 INFO - Display Serial Number: 1600x1200 60 06:41:57 INFO - Main Display: Yes 06:41:57 INFO - Mirror: Off 06:41:57 INFO - Online: Yes 06:41:57 INFO - Rotation: Supported 06:41:57 INFO - Return code: 0 06:41:57 INFO - Running post-action listener: _resource_record_post_action 06:41:57 INFO - Running post-run listener: _resource_record_post_run 06:41:58 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 1601024; Write bytes: 511233536; Read time: 21; Write time: 1592 06:41:58 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197411328; Write bytes: 197903872; Read time: 17978; Write time: 410 06:41:58 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 1601024; Write bytes: 303368192; Read time: 21; Write time: 1147 06:41:58 INFO - Running post-run listener: _upload_blobber_files 06:41:58 INFO - Blob upload gear active. 06:41:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:58 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 06:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:41:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:00 INFO - (blobuploader) - INFO - Done attempting. 06:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:01 INFO - (blobuploader) - INFO - Done attempting. 06:42:01 INFO - (blobuploader) - INFO - Iteration through files over. 06:42:01 INFO - Return code: 0 06:42:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:42:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:42:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7fc13bef5740f8a1598fe6225d6954b5671297e51c1f219e2fc14481898cb6562b92013811eda4559a30442609044d5a4f11062ade4debe7c80bee9dd3bd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4ae7240b31cc2e4c6faf8d2f939f4be2317f37ede4abe6c6de37fea5bd5e414e06c5f5a5b24f8dc8b98257c82d98434b2a2651869193af7fbe2e660c4a2a067"} 06:42:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:42:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:42:01 INFO - Contents: 06:42:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7fc13bef5740f8a1598fe6225d6954b5671297e51c1f219e2fc14481898cb6562b92013811eda4559a30442609044d5a4f11062ade4debe7c80bee9dd3bd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4ae7240b31cc2e4c6faf8d2f939f4be2317f37ede4abe6c6de37fea5bd5e414e06c5f5a5b24f8dc8b98257c82d98434b2a2651869193af7fbe2e660c4a2a067"} 06:42:01 INFO - Running post-run listener: copy_logs_to_upload_dir 06:42:01 INFO - Copying logs to upload dir... 06:42:01 INFO - mkdir: /builds/slave/test/build/upload/logs 06:42:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.805253 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-06 06:42:01.177580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:01.181435) ========= 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.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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/Mozilla-Beta/sha512/8c7fc13bef5740f8a1598fe6225d6954b5671297e51c1f219e2fc14481898cb6562b92013811eda4559a30442609044d5a4f11062ade4debe7c80bee9dd3bd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4ae7240b31cc2e4c6faf8d2f939f4be2317f37ede4abe6c6de37fea5bd5e414e06c5f5a5b24f8dc8b98257c82d98434b2a2651869193af7fbe2e660c4a2a067"} build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7fc13bef5740f8a1598fe6225d6954b5671297e51c1f219e2fc14481898cb6562b92013811eda4559a30442609044d5a4f11062ade4debe7c80bee9dd3bd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4ae7240b31cc2e4c6faf8d2f939f4be2317f37ede4abe6c6de37fea5bd5e414e06c5f5a5b24f8dc8b98257c82d98434b2a2651869193af7fbe2e660c4a2a067"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:01.212450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:01.212772) ========= 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.iHOBRPHMn5/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.cONjP72EhZ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:01.261980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:01.262306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:01.262702) ========= ========= Total master_lag: 0.19 =========