builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0074 starttime: 1465219273.78 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.779673) ========= 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.785070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.785369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.838977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:13.839242) ========= 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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.27M=0.001s 2016-06-06 06:21:14 (9.27 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.459978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.460293) ========= 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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.028838 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.508368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:14.508679) ========= 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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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,582 truncating revision to first 12 chars 2016-06-06 06:21:14,582 Setting DEBUG logging. 2016-06-06 06:21:14,582 attempt 1/10 2016-06-06 06:21:14,582 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,259 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.941740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.470604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.470909) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.471314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.471579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:15.488677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-06 06:21:15.488956) ========= /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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-0074', 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:17 INFO - Running post-action listener: _resource_record_post_action 06:21:17 INFO - ##### 06:21:17 INFO - ##### Running read-buildbot-config step. 06:21:17 INFO - ##### 06:21:17 INFO - Running pre-action listener: _resource_record_pre_action 06:21:17 INFO - Running main action method: read_buildbot_config 06:21:17 INFO - Using buildbot properties: 06:21:17 INFO - { 06:21:17 INFO - "project": "", 06:21:17 INFO - "product": "firefox", 06:21:17 INFO - "script_repo_revision": "production", 06:21:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 06:21:17 INFO - "repository": "", 06:21:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 06:21:17 INFO - "buildid": "20160602140837", 06:21:17 INFO - "pgo_build": "False", 06:21:17 INFO - "basedir": "/builds/slave/test", 06:21:17 INFO - "buildnumber": 16, 06:21:17 INFO - "slavename": "t-yosemite-r7-0074", 06:21:17 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:21:17 INFO - "platform": "yosemite_r7", 06:21:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:21:17 INFO - "branch": "mozilla-beta", 06:21:17 INFO - "repo_path": "releases/mozilla-beta", 06:21:17 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:21:17 INFO - "stage_platform": "macosx64", 06:21:17 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:21:17 INFO - "slavebuilddir": "test" 06:21:17 INFO - } 06:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:21:17 INFO - Running post-action listener: _resource_record_post_action 06:21:17 INFO - ##### 06:21:17 INFO - ##### Running download-and-extract step. 06:21:17 INFO - ##### 06:21:17 INFO - Running pre-action listener: _resource_record_pre_action 06:21:17 INFO - Running main action method: download_and_extract 06:21:17 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:21:17 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:18 INFO - Downloaded 1241 bytes. 06:21:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:21:18 INFO - Using the following test package requirements: 06:21:18 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:18 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:21:18 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:21:18 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:21:18 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:21:18 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:18 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:21:18 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:21:18 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:21:18 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:21:18 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:21:18 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:21:18 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:18 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:18 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:18 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:18 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:18 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:19 INFO - Downloaded 17816944 bytes. 06:21:19 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:19 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:22 INFO - Return code: 0 06:21:22 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:22 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:22 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:22 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:22 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:22 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:22 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:29 INFO - Downloaded 17816944 bytes. 06:21:29 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:29 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:33 INFO - Return code: 0 06:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 10845194 bytes. 06:21:34 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:34 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:34 INFO - Return code: 0 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 - 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:34 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:34 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:34 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:34 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:45 INFO - Downloaded 88466458 bytes. 06:21:45 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:45 INFO - mkdir: /builds/slave/test/properties 06:21:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:45 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:45 INFO - Contents: 06:21:45 INFO - build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:21:47 INFO - Running post-action listener: _resource_record_post_action 06:21:47 INFO - Running post-action listener: set_extra_try_arguments 06:21:47 INFO - ##### 06:21:47 INFO - ##### Running populate-webroot step. 06:21:47 INFO - ##### 06:21:47 INFO - Running pre-action listener: _resource_record_pre_action 06:21:47 INFO - Running main action method: populate_webroot 06:21:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:47 INFO - '--tppagecycles', 06:21:47 INFO - '7'], 06:21:47 INFO - 'tests': ['tsvgm']}}, 06:21:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:21:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:21:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'tests': ['damp', 'tps']}, 06:21:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['damp', 'tps']}, 06:21:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:21:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:47 INFO - 'other': {'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'other_l64': {'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'other_nol64': {'tests': ['a11yr', 06:21:47 INFO - 'ts_paint', 06:21:47 INFO - 'tpaint', 06:21:47 INFO - 'sessionrestore', 06:21:47 INFO - 'sessionrestore_no_auto_restore', 06:21:47 INFO - 'tabpaint']}, 06:21:47 INFO - 'svgr': {'tests': ['tsvgx', 06:21:47 INFO - 'tsvgr_opacity', 06:21:47 INFO - 'tart', 06:21:47 INFO - 'tscrollx', 06:21:47 INFO - 'cart']}, 06:21:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['tsvgx', 06:21:47 INFO - 'tsvgr_opacity', 06:21:47 INFO - 'tart', 06:21:47 INFO - 'tscrollx', 06:21:47 INFO - 'cart']}, 06:21:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'tests': ['tp5o']}, 06:21:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'talos_options': ['--e10s'], 06:21:47 INFO - 'tests': ['tp5o']}, 06:21:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'talos_options': ['--xperf_path', 06:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:47 INFO - 'tests': ['tp5n']}, 06:21:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:47 INFO - 'talos_options': ['--e10s', 06:21:47 INFO - '--xperf_path', 06:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:47 INFO - 'tests': ['tp5n']}}, 06:21:47 INFO - 'talos.zip': {'path': '', 06:21:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:47 INFO - Running post-action listener: _resource_record_post_action 06:21:47 INFO - ##### 06:21:47 INFO - ##### Running create-virtualenv step. 06:21:47 INFO - ##### 06:21:47 INFO - Running pre-action listener: _resource_record_pre_action 06:21:47 INFO - Running main action method: create_virtualenv 06:21:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:47 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:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:47 INFO - Using real prefix '/tools/python27' 06:21:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:50 INFO - Installing pip.................done. 06:21:50 INFO - Return code: 0 06:21:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:50 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:50 INFO - 'HOME': '/Users/cltbld', 06:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:50 INFO - 'LOGNAME': 'cltbld', 06:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:50 INFO - 'MOZ_NO_REMOTE': '1', 06:21:50 INFO - 'NO_EM_RESTART': '1', 06:21:50 INFO - 'PAGER': '/bin/cat', 06:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:50 INFO - 'PWD': '/builds/slave/test', 06:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:50 INFO - 'SHELL': '/bin/bash', 06:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:21:50 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:50 INFO - 'USER': 'cltbld', 06:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:50 INFO - 'XPC_FLAGS': '0x0', 06:21:50 INFO - 'XPC_SERVICE_NAME': '0', 06:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:51 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:51 INFO - Cleaning up... 06:21:51 INFO - Return code: 0 06:21:51 INFO - Installing psutil>=0.7.1 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', '--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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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', '--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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 06:21:51 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:51 INFO - Downloading/unpacking psutil>=0.7.1 06:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:54 INFO - Installing collected packages: psutil 06:21:54 INFO - Running setup.py install for psutil 06:21:54 INFO - building 'psutil._psutil_osx' extension 06:21:54 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:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:21:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:21:55 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:55 INFO - building 'psutil._psutil_posix' extension 06:21:55 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:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:21:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:21:55 INFO - ^ 06:21:55 INFO - 1 warning generated. 06:21:55 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:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:56 INFO - Successfully installed psutil 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:56 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:56 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:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:56 INFO - 'HOME': '/Users/cltbld', 06:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:56 INFO - 'LOGNAME': 'cltbld', 06:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:56 INFO - 'MOZ_NO_REMOTE': '1', 06:21:56 INFO - 'NO_EM_RESTART': '1', 06:21:56 INFO - 'PAGER': '/bin/cat', 06:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:56 INFO - 'PWD': '/builds/slave/test', 06:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:56 INFO - 'SHELL': '/bin/bash', 06:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:21:56 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:56 INFO - 'USER': 'cltbld', 06:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:56 INFO - 'XPC_FLAGS': '0x0', 06:21:56 INFO - 'XPC_SERVICE_NAME': '0', 06:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:58 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:58 INFO - Installing collected packages: mozsystemmonitor 06:21:58 INFO - Running setup.py install for mozsystemmonitor 06:21:58 INFO - Successfully installed mozsystemmonitor 06:21:58 INFO - Cleaning up... 06:21:59 INFO - Return code: 0 06:21:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:59 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:59 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:59 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:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:59 INFO - 'HOME': '/Users/cltbld', 06:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:59 INFO - 'LOGNAME': 'cltbld', 06:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:59 INFO - 'MOZ_NO_REMOTE': '1', 06:21:59 INFO - 'NO_EM_RESTART': '1', 06:21:59 INFO - 'PAGER': '/bin/cat', 06:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:59 INFO - 'PWD': '/builds/slave/test', 06:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:59 INFO - 'SHELL': '/bin/bash', 06:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:21:59 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:59 INFO - 'USER': 'cltbld', 06:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:59 INFO - 'XPC_FLAGS': '0x0', 06:21:59 INFO - 'XPC_SERVICE_NAME': '0', 06:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:59 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:59 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:59 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:59 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:59 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:59 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 - Downloading blobuploader-1.2.4.tar.gz 06:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:22:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:22:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Downloading docopt-0.6.1.tar.gz 06:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:22:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:22:03 INFO - Running setup.py install for blobuploader 06:22:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:22:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:22:03 INFO - Running setup.py install for requests 06:22:03 INFO - Running setup.py install for docopt 06:22:03 INFO - Successfully installed blobuploader requests docopt 06:22:03 INFO - Cleaning up... 06:22:03 INFO - Return code: 0 06:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:03 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:03 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:22:03 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:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:03 INFO - 'HOME': '/Users/cltbld', 06:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:03 INFO - 'LOGNAME': 'cltbld', 06:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:03 INFO - 'MOZ_NO_REMOTE': '1', 06:22:03 INFO - 'NO_EM_RESTART': '1', 06:22:03 INFO - 'PAGER': '/bin/cat', 06:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:03 INFO - 'PWD': '/builds/slave/test', 06:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:03 INFO - 'SHELL': '/bin/bash', 06:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:03 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:03 INFO - 'USER': 'cltbld', 06:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:03 INFO - 'XPC_FLAGS': '0x0', 06:22:03 INFO - 'XPC_SERVICE_NAME': '0', 06:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Foje_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-uHIvoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-rEKcCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-yF6zvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GYBPlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7rCAcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-aOXjHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IZ_19A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:04 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-JQMAPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-QjMcWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-J1NM41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-BzR1di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-wlCr1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-x84Vsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4GdUum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-04ofWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-W9puTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:22:05 INFO - Running setup.py install for manifestparser 06:22:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:22:06 INFO - Running setup.py install for mozcrash 06:22:06 INFO - Running setup.py install for mozdebug 06:22:06 INFO - Running setup.py install for mozdevice 06:22:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:22:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:22:06 INFO - Running setup.py install for mozfile 06:22:06 INFO - Running setup.py install for mozhttpd 06:22:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:22:06 INFO - Running setup.py install for mozinfo 06:22:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:22:06 INFO - Running setup.py install for mozInstall 06:22:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Running setup.py install for mozleak 06:22:07 INFO - Running setup.py install for mozlog 06:22:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Running setup.py install for moznetwork 06:22:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Running setup.py install for mozprocess 06:22:07 INFO - Running setup.py install for mozprofile 06:22:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:22:07 INFO - Running setup.py install for mozrunner 06:22:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:22:08 INFO - Running setup.py install for mozscreenshot 06:22:08 INFO - Running setup.py install for moztest 06:22:08 INFO - Running setup.py install for mozversion 06:22:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:22:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:22:08 INFO - Cleaning up... 06:22:08 INFO - Return code: 0 06:22:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:08 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:08 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:22:08 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:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:08 INFO - 'HOME': '/Users/cltbld', 06:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:08 INFO - 'LOGNAME': 'cltbld', 06:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:08 INFO - 'MOZ_NO_REMOTE': '1', 06:22:08 INFO - 'NO_EM_RESTART': '1', 06:22:08 INFO - 'PAGER': '/bin/cat', 06:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:08 INFO - 'PWD': '/builds/slave/test', 06:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:08 INFO - 'SHELL': '/bin/bash', 06:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:08 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:08 INFO - 'USER': 'cltbld', 06:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:08 INFO - 'XPC_FLAGS': '0x0', 06:22:08 INFO - 'XPC_SERVICE_NAME': '0', 06:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:08 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Wv7hQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:08 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-5kLWNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:08 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-iCNWrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-tn0j_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-USYZQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-A281rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IL5tl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-KuR0ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-2J9bAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-cwt2da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-NiYODy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:09 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-n_KVpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:09 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:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:10 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-hwG1zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:10 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-iUdOVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:10 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-EwQ4zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:10 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-3Aj3da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:10 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8QdPqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:22:10 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:10 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:10 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:10 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:10 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:10 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:12 INFO - Downloading blessings-1.6.tar.gz 06:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:22:13 INFO - Installing collected packages: blessings 06:22:13 INFO - Running setup.py install for blessings 06:22:13 INFO - Successfully installed blessings 06:22:13 INFO - Cleaning up... 06:22:13 INFO - Return code: 0 06:22:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:13 INFO - Reading from file tmpfile_stdout 06:22:13 INFO - Current package versions: 06:22:13 INFO - blessings == 1.6 06:22:13 INFO - blobuploader == 1.2.4 06:22:13 INFO - docopt == 0.6.1 06:22:13 INFO - manifestparser == 1.1 06:22:13 INFO - mozInstall == 1.12 06:22:13 INFO - mozcrash == 0.17 06:22:13 INFO - mozdebug == 0.1 06:22:13 INFO - mozdevice == 0.48 06:22:13 INFO - mozfile == 1.2 06:22:13 INFO - mozhttpd == 0.7 06:22:13 INFO - mozinfo == 0.9 06:22:13 INFO - mozleak == 0.1 06:22:13 INFO - mozlog == 3.1 06:22:13 INFO - moznetwork == 0.27 06:22:13 INFO - mozprocess == 0.22 06:22:13 INFO - mozprofile == 0.28 06:22:13 INFO - mozrunner == 6.11 06:22:13 INFO - mozscreenshot == 0.1 06:22:13 INFO - mozsystemmonitor == 0.0 06:22:13 INFO - moztest == 0.7 06:22:13 INFO - mozversion == 1.4 06:22:13 INFO - psutil == 3.1.1 06:22:13 INFO - requests == 1.2.3 06:22:13 INFO - wsgiref == 0.1.2 06:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:13 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:13 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:22:13 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:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:13 INFO - 'HOME': '/Users/cltbld', 06:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:13 INFO - 'LOGNAME': 'cltbld', 06:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:13 INFO - 'MOZ_NO_REMOTE': '1', 06:22:13 INFO - 'NO_EM_RESTART': '1', 06:22:13 INFO - 'PAGER': '/bin/cat', 06:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:13 INFO - 'PWD': '/builds/slave/test', 06:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:13 INFO - 'SHELL': '/bin/bash', 06:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:13 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:13 INFO - 'USER': 'cltbld', 06:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:13 INFO - 'XPC_FLAGS': '0x0', 06:22:13 INFO - 'XPC_SERVICE_NAME': '0', 06:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 INFO - Cleaning up... 06:22:13 INFO - Return code: 0 06:22:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:22:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:13 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:13 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:22:13 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:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:13 INFO - 'HOME': '/Users/cltbld', 06:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:13 INFO - 'LOGNAME': 'cltbld', 06:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:13 INFO - 'MOZ_NO_REMOTE': '1', 06:22:13 INFO - 'NO_EM_RESTART': '1', 06:22:13 INFO - 'PAGER': '/bin/cat', 06:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:13 INFO - 'PWD': '/builds/slave/test', 06:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:13 INFO - 'SHELL': '/bin/bash', 06:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:13 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:13 INFO - 'USER': 'cltbld', 06:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:13 INFO - 'XPC_FLAGS': '0x0', 06:22:13 INFO - 'XPC_SERVICE_NAME': '0', 06:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:14 INFO - Downloading/unpacking jsonschema 06:22:14 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:14 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:14 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:14 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:14 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:14 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:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:17 INFO - warning: no files found matching '*.txt' 06:22:17 INFO - no previously-included directories found matching 'build' 06:22:17 INFO - no previously-included directories found matching 'dist' 06:22:17 INFO - no previously-included directories found matching '.git*' 06:22:17 INFO - Installing collected packages: jsonschema, functools32 06:22:17 INFO - Running setup.py install for functools32 06:22:17 INFO - warning: no files found matching '*.txt' 06:22:17 INFO - no previously-included directories found matching 'build' 06:22:17 INFO - no previously-included directories found matching 'dist' 06:22:17 INFO - no previously-included directories found matching '.git*' 06:22:17 INFO - Successfully installed jsonschema functools32 06:22:17 INFO - Cleaning up... 06:22:17 INFO - Return code: 0 06:22:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:22: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:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:17 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 0x108214a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963d97810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, '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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:17 INFO - 'HOME': '/Users/cltbld', 06:22:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:17 INFO - 'LOGNAME': 'cltbld', 06:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:17 INFO - 'MOZ_NO_REMOTE': '1', 06:22:17 INFO - 'NO_EM_RESTART': '1', 06:22:17 INFO - 'PAGER': '/bin/cat', 06:22:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:17 INFO - 'PWD': '/builds/slave/test', 06:22:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:17 INFO - 'SHELL': '/bin/bash', 06:22:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:17 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:17 INFO - 'USER': 'cltbld', 06:22:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:17 INFO - 'XPC_FLAGS': '0x0', 06:22:17 INFO - 'XPC_SERVICE_NAME': '0', 06:22:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:17 INFO - Downloading/unpacking flake8 06:22:17 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:17 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:17 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:17 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:17 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:17 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:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:22:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:22:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:22:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:22:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:22:20 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:20 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:20 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:20 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:20 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:20 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:21 INFO - no previously-included directories found matching 'docs/_build' 06:22:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:22:21 INFO - Running setup.py install for pep8 06:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:21 INFO - no previously-included directories found matching 'docs/_build' 06:22:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:22:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:22:21 INFO - Cleaning up... 06:22:21 INFO - Return code: 0 06:22:21 INFO - Running post-action listener: _resource_record_post_action 06:22:21 INFO - Running post-action listener: _start_resource_monitoring 06:22:21 INFO - Starting resource monitoring. 06:22:21 INFO - ##### 06:22:21 INFO - ##### Running install step. 06:22:21 INFO - ##### 06:22:21 INFO - Running pre-action listener: _resource_record_pre_action 06:22:21 INFO - Running main action method: install 06:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:21 INFO - Reading from file tmpfile_stdout 06:22:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:22 INFO - Reading from file tmpfile_stdout 06:22:22 INFO - Output received: 06:22:22 INFO - Usage: mozinstall [options] installer 06:22:22 INFO - Options: 06:22:22 INFO - -h, --help show this help message and exit 06:22:22 INFO - -d DEST, --destination=DEST 06:22:22 INFO - Directory to install application into. [default: 06:22:22 INFO - "/builds/slave/test"] 06:22:22 INFO - --app=APP Application being installed. [default: firefox] 06:22:22 INFO - mkdir: /builds/slave/test/build/application 06:22:22 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:22 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:44 INFO - Reading from file tmpfile_stdout 06:22:44 INFO - Output received: 06:22:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:22:44 INFO - Running post-action listener: _resource_record_post_action 06:22:44 INFO - ##### 06:22:44 INFO - ##### Running run-tests step. 06:22:44 INFO - ##### 06:22:44 INFO - Running pre-action listener: _resource_record_pre_action 06:22:44 INFO - Running main action method: run_tests 06:22:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:22:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:22:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:22:44 INFO - 2016-06-06 06:22:44.881 screenresolution[1646:8178] starting screenresolution argv=screenresolution get 06:22:44 INFO - 2016-06-06 06:22:44.883 screenresolution[1646:8178] Display 0: 1600x1200x32@60 06:22:44 INFO - 2016-06-06 06:22:44.889 screenresolution[1647:8180] starting screenresolution argv=screenresolution list 06:22:44 INFO - Available Modes on Display 0 06:22:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:22:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:22:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:22:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:22:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:22:45 INFO - Intel Iris: 06:22:45 INFO - Chipset Model: Intel Iris 06:22:45 INFO - Type: GPU 06:22:45 INFO - Bus: Built-In 06:22:45 INFO - VRAM (Dynamic, Max): 1536 MB 06:22:45 INFO - Vendor: Intel (0x8086) 06:22:45 INFO - Device ID: 0x0a2e 06:22:45 INFO - Revision ID: 0x0009 06:22:45 INFO - Displays: 06:22:45 INFO - Display: 06:22:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:22:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:22:45 INFO - Display Serial Number: 1600x1200 60 06:22:45 INFO - Main Display: Yes 06:22:45 INFO - Mirror: Off 06:22:45 INFO - Online: Yes 06:22:45 INFO - Rotation: Supported 06:22:45 INFO - Return code: 0 06:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:45 INFO - Python 2.7.3 06:22:45 INFO - Return code: 0 06:22:45 INFO - grabbing minidump binary from tooltool 06:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:45 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 0x1080b8d30>, '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 0x107f1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:45 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:45 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:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:45 INFO - Return code: 0 06:22:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:22:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:22:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:46 INFO - Return code: 0 06:22:46 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-0074', '--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:46 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-0074 --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:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrGA86eoqL/Render', 06:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:46 INFO - 'HOME': '/Users/cltbld', 06:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:46 INFO - 'LOGNAME': 'cltbld', 06:22:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:46 INFO - 'MOZ_NO_REMOTE': '1', 06:22:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:46 INFO - 'NO_EM_RESTART': '1', 06:22:46 INFO - 'PAGER': '/bin/cat', 06:22:46 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:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:46 INFO - 'PWD': '/builds/slave/test', 06:22:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:46 INFO - 'SHELL': '/bin/bash', 06:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q0KDZF1YvD/Listeners', 06:22:46 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 06:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:46 INFO - 'USER': 'cltbld', 06:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:46 INFO - 'XPC_FLAGS': '0x0', 06:22:46 INFO - 'XPC_SERVICE_NAME': '0', 06:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:46 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-0074', '--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:46 INFO - mozversion application_buildid: 20160602140837 06:22:46 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:46 INFO - mozversion application_display_name: Firefox 06:22:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:46 INFO - mozversion application_name: Firefox 06:22:46 INFO - mozversion application_remotingname: firefox 06:22:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:46 INFO - mozversion application_vendor: Mozilla 06:22:46 INFO - mozversion application_version: 47.0 06:22:46 INFO - mozversion platform_buildid: 20160602140837 06:22:46 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:46 INFO - mozversion platform_version: 47.0 06:22:46 INFO - using testdate: 1465219366 06:22:46 INFO - actual date: 1465219366 06:22:46 INFO - starting webserver on 'localhost:49272' 06:22:46 INFO - SUITE-START | Running 2 tests 06:22:46 INFO - TEST-START | dromaeo_css 06:22:46 INFO - operating with platform_type : mac_ 06:22:46 INFO - Initialising browser for dromaeo_css test... 06:22:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpgeH05Q/profile http://localhost:49272/getInfo.html) 06:22:49 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 06:22:49 INFO - PROCESS | 1665 | colorDepth:24 06:22:49 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 06:22:49 INFO - PROCESS | 1665 | __metrics 06:22:49 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:22:49 INFO - TEST-INFO | 1665: exit 0 06:22:49 INFO - Browser initialized. 06:22:49 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:49 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpgeH05Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:01 INFO - PROCESS | 1670 | RSS: Main: 167653376 06:23:01 INFO - PROCESS | 1670 | 06:23:51 INFO - PROCESS | 1670 | 1465219431414 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:26:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 06:26:02 INFO - PROCESS | 1670 | RSS: Main: 184475648 06:26:02 INFO - PROCESS | 1670 | 06:29:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 06:29:05 INFO - PROCESS | 1670 | RSS: Main: 194560000 06:29:05 INFO - PROCESS | 1670 | 06:32:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 06:32:07 INFO - PROCESS | 1670 | RSS: Main: 196194304 06:32:07 INFO - PROCESS | 1670 | 06:35:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 06:35:10 INFO - PROCESS | 1670 | RSS: Main: 199708672 06:35:10 INFO - PROCESS | 1670 | 06:38:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 06:38:13 INFO - PROCESS | 1670 | RSS: Main: 198926336 06:38:13 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 06:41:15 INFO - PROCESS | 1670 | RSS: Main: 204406784 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | __start_tp_report 06:41:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 06:41:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 06:41:15 INFO - PROCESS | 1670 | |i|pagename|runs| 06:41:15 INFO - PROCESS | 1670 | |0;dojo.html;3665.9450108248375;3692.926141477169;3713.9628603713973;3735.1595890924546;3752.1370084880477;6008.909866352008;6039.879202415949;6042.486388656964;6073.453389194971;6086.786962456309;4954.801807927687;6001.399860014008;6002.339742628318;6022.909656355158;6050.939490605093;5343.251944727732;5365.892682146355;5371.838844834661;5437.564994800427;5492.340919089715;5362.088444964365;5409.26974858393;5424.864378390533;5460.890782184354;5509.256250406204;4892.5596696297325;5218.347706536683;5468.234447177399;5485.533729632986;5487.807926722566;4528.980979279685;5297.682139071668;5427.1316589345515;5437.918431223535;5502.889942201154;5282.128448805943;5282.181261904372;5332.893342133174;5350.117230656937;5373.194020896858;5699.430056994309;5742.856428589277;5773.1051686988585;5855.941440585582;5863.58954873159;6179.19670442844;6214.285357183937;6248.96875515624;6251.812445626639;6263.843403914893;6268.15379923709;6319.968400158015;6321.209848768904;6341.143945567335;6356;6080.665563394055;6081.847953801146;6118.510519158456;6134.570580059398;6138.386161383915;6197.597156184834;6213.2233470816145;6287.591306565058;6460.612363258219;6503.187101612299;5265.52610265078;6209.96895015522;6211.627302361872;6232.719527621268;6259.217597800275;6341.587796793194;6352.809415717536;6354.6822658867795;6369.363063693593;6389.488840892717;6148.907766383508;6192.164057852222;6197.411245931629;6257.8748425031245;6262.09199666055;6218.160548326008;6225.470834978987;6236.6258024518675;6250;6258.186435763321;5015.949840501621;5016.749162541932;5054.646174767731;5054.721990290569;5079.695218286841;4444.933326000112;4468.106378724268;4482.887927801831;4593.816247350069;4632.119897219518;5661.631993920382;6092.969535152296;6105.786297479655;6132.601380910227;6135.110408990671;6265.467435267962;6313.936860631335;6374.203224596926;6386.010168423902;6387.776427825097;5957.851053723692;6085.756569737249;6133.080037994337;6136.05958347471;6181.041938499539;4605.631549476034;5596.4123767003875;5598.748056337475;5601.047821870292;5603.991281569357;6616.404523592803;6616.768413105518;6622.337766223532;6638.6680665966505;6644.036614690843;6180.103884936569;6325.841853953688;6385.744570217325;6413.935860641333;6424.582402143846;6630.171228596426;6632.104665870239;6646.534742567974;6648.0360347750275;6654.168228971379;6175.6912154393;6272.341404152681;6279.811605651837;6283.842903927255;6290.874182516232;6242.843928901813;6246.812595622138;6277.15258440123;6312.337204593635;6337.556371054166;5121.641485096007;5192.896142077213;6078.5441091919165;6148.631082135086;6249.593776404519;5033.421156567042;5985;6163.8150855474405;6219.004959206505;6227.252729672468;5955.940440595712;6129.785457508966;6171.938280617136;6215.316315205233;6236.906446403217;6112.698207300172;6215.875682486416;6238.095476156022;6246.593971391845;6250.562460627712;5306.893862122659;6122.550631083031;6166.013437849922;6230.096635987847;6254 06:41:15 INFO - PROCESS | 1670 | |1;ext.html;473.78442808522124;534.0467265930315;566.8752874367639;658.019550869205;693.9521322802567;38575.614243857555;39516.60483395165;39636.801815990955;39677.40483892744;39741.80129099354;41886.7905660472;42143.78928105355;42380;42529.72410827672;42597.7870110649;9565.856512152322;9764.51177441125;9815.165710914582;9825.263105267099;9857.95071024644;9600.423974561514;9826.263030272758;9863.60545578176;9880.407175569453;9891.307608467374;9810.166135878459;9834.852477212848;9862.60549578016;9869.210463162966;9898.703038908845;9819.90180098197;9875;9890.20878329732;9903.25725570585;9914.454704991258;9773.267004974656;9861.35901166429;9882.851757223576;9887.209023278121;9921.950390248076;41085.589144108475;41305.38041929373;41318.793406032775;41560.58439415597;41615.583844161476;2981.6571094324213;3312.3044160726276;3399.2351720862607;3454.9309013819834;3461.7230621550216;29115.272118197;29450.558241626393;29858;29956.251093722614;30392.696073039428;2310.514791893704;2835.503786837316;2835.773138148943;2906.607607972918;2945.5728919306794;442939;444050.7797460992;447320;448702.75648622203;449930;49036;71038.93441598381;71813.64093179605;71896.64051679813;73187;48281.55155345345;48305.75847120812;48394.79013024632;48673.26990095151;48679;16876.746848797276;16877.91561042187;16977.320907163576;17213.913930430266;17323.960562366046;13486.393112309774;13567.05030647865;13591.252481113435;13664.795028074586;13678.726425471436;15456.149911754961;15734;15856.762148567781;15937.601559960862;15975.680486390207;6390.904136437957;6652.234992975869;6659.600423974577;6685.465162786965;6691.631960242234;888.493558671564;918.5407296351824;1044.8432735089798;1121.1479275750326;1180.8582970043649;26551.336216594354;27327.726722732918;30586.541201881988;31256.84371578173;31350.52974205389;1069.5187165775433;1126.2318160487955;1208.915375923677;1245.9626211213679;1328.6611913962072;12279.815802762965;13754.587362379145;15554.922225389028;15685.764713529306;15861.841381586037;669997;670173;678324;679013;679355;64542;65847.01229481562;66682.66658666676;66855.99716004264;66934.99597506042;1557.532740177942;1580.936762529486;1590.6739118480452;1601.8878678492626;1611.3393508661393;29854.10437686873;30016.84991575028;30096.097117086523;30594;30687.079387618407;54057;54251;54496.72751636217;54531.90936181175;54766.17850732162;520183;520323;520432;523897;525315;34860.30279394347;35958.460623091196;36075.819620901726;36439;36537.634623654485;48665.270020950426;49043;49352.50647493479;49779;50190.2471462921;39172.80413597914;39916.800415997735;40184.59815401809;40350.59649403468;40429.12880308985;39544.604553954094;39768.602313977644;40093.59906400899;40411.79794101128;40690;33432;38227.235455291295;38287.23425531529;39424.802875985435;40162.19675606413;27654.3086422833;31596.684033160294;32298.677013229568;33608;34308.31383372368;25837.870810645825;25858.612120817827;25915.870420647778;25924;26374.472510550066 06:41:15 INFO - PROCESS | 1670 | |2;jquery.html;368.5448471138144;373.482726423903;375.6243756243756;379.68106790296144;382.7225261685278;20419.387418377435;21182.940852957367;21568.676469852944;22405.43986400341;22407.775922240773;12203.877961220385;12675.112742108056;20687.275945341917;21217.833019183978;21318.147274109055;5276.155815069599;5481.780728770845;5484.478974497416;5492.176173573956;5493.862653433656;3455.2225749206355;4865.781039853215;5936.079907614305;5993.130996005577;6106;5958.7616495340135;6052.001419765756;6056.969715151418;6059.454649081582;6104.084387341912;6319.210098737658;6459.35406459355;6497.870042599146;6526.249481309663;6534.54258201926;5312.007997001125;5690.630109042899;5709.628874123168;5754.223179870705;5770.79802206925;13497.662558436019;13634.93182534091;13816.378262978089;13886.861131388658;13901.374438150307;2108.146200788683;2118.9894050529647;2144.9892750536305;2288.5766133265233;2316.513532158249;9817.607295708234;10094.747631309203;10250;10254.53854576546;10382.688519344432;1656.2298531182937;1723.500184946364;1734.254270663614;1746.3451205797826;1755.2540170427517;80582;104873.47563262211;109754.9999999992;112016;114213.28680069723;11641.777613350645;11768.293902365886;11805;11810.350430726392;11834.875686809739;12628;13965.86034139666;14517.854821451861;14543.78184327236;14586.708265834624;8987.41581797181;9155.359124861328;9220.031896650755;9230.123138301851;9280.489573073412;7604.8479030419085;9312.022237665084;9349.953250233706;9372.1565059145;9435.452427844444;4571;4585.724856508554;4621.260598304255;4622.745748983838;4659.6505262105475;1774.4321817018688;1840.8862638103753;1882.5481884347932;1938.9709154362695;1945.7762357329088;382.2736800079815;871.3551971541141;940.2243149401771;949.520492151459;1062.7787923240464;9262.490563019099;10735.302205356784;11484.540618375338;11556.191066625424;11609.013233875216;430.984915527955;870.525563567857;888.9955550222207;978.83849164887;1036.9222308326905;10468.68593942183;10791.568337266579;10829.566817327377;10842.891571084188;10859.78280434387;257018;257365;413739;691810;694738;48330;73000;74086.62956685181;119307;125796;1011.8464949957055;1051.7055224537141;1081.221520505235;1081.4430568257353;1084.6366467233408;16089.919550402174;18386.264549417872;18475.722864156778;18720.53198670044;18769.1553880073;34699.47950780791;43220.78389608032;44282.564458955065;48660.5133948656;48666.270005949234;65968.34031659622;68987;69638.65180674064;74040.62979685067;74370.62814685891;7879.527228366316;8039.316658084128;8262.958685206535;8466.492010479391;8514.531700756517;12139.75720485603;12203.816942745689;13443.731125377633;13454.058215924792;13733;9581.520923953914;9629.807403852024;11124.332540047622;11489.965903068764;12017.81973270419;8314.376421768513;11475.540978361107;11500.597479088527;11597.362145082101;11828.172027958304;11707.239029463057;11786.528538858349;11871.465784039567;12015.639530814089;12138.635840924786;8324.833503329779;8394.580270986304;8398.328133749163;8430;8527.18991695788;8820.91179088201;11171.776564468828;11309.71725706864;11852.76294474123;11976.341301228516 06:41:15 INFO - PROCESS | 1670 | |3;mootools.html;1637.0096091864423;1646.4072933743853;1954.482062253503;2041.550858811062;2049.282751037138;7378.667959941802;8259.42184047117;8993;9146.039665835084;9147.313951453643;8878.822423551524;8974.50640214788;9002.639894404232;9083.818323633523;9110;2545.363659085229;2546.961795573068;2552.5660637691544;2560.4879024195143;2576.0468626608085;2504.799616030722;2542.275451496324;2545.2873195505194;2555.3228394475477;2575.587905935051;2499.7750202481775;2508.2224510401834;2513.246026192144;2531.405119796846;2558.7441255874355;2500.862452565108;2514.283429222672;2517.244826552027;2569.974300256992;2572.241188849275;2533.7592928671747;2547.1212431711215;2557.386227305452;2559.5008973250224;2580.5871060630398;9186.908130918671;9187.540622968825;9258.21305189053;9268.536573171383;9288.11762882532;5722.799702010409;5806.941930580725;5848.356680765112;5868.119782032687;5874.265716785402;3700;3781.0358358618378;3811.085339518523;3839.712021598363;3846.365349717293;1058.8623478947763;1088.031651829872;1088.8965548272902;1123.230587047875;1124.8650161980615;12442.377881105998;12507.37463126849;12543.811842822364;12581.37093145339;12585.811212831815;5038.722870242172;5051.570616497639;5117.744112794346;5119.820806271762;5125.256837758504;10426.843597346045;10455.21585881062;10480.842787358195;10546.314489558154;10640.521176547074;5749.453801888814;5775.27809023872;5787.652740835563;5815.360310365856;5834.358220595731;4683.367745354401;5098.337216161875;5204.375474943031;5209.0363282792805;5279.287296215039;3984.322665146932;4100.36444351126;4147.585241475828;4148.357004664282;4159;1110.4114819145866;1249.119370843553;1373.3751143230006;1388.1046724862408;1389.0276806235674;1183.9408029598658;1233.4018001269378;1296.4619682831708;1377.8139951106673;1419.6167034900518;7200.811866042044;8047.195280471906;8461.56153453902;8476.110008449024;8517.659293628185;1101.969658369411;1353.4992052940474;1367.282176857158;1367.7743172376645;1379.5792283353474;6407.711652975628;6421.903671444932;6444.291127975919;6517.837054073591;6523.771667991692;10801.351918884891;10953.397563134104;11098.944505277423;11214.887851121384;11238.325700458;10619.94690026545;10954.178436617285;10967.50646220922;10969.506372213269;11213.887861121448;8550.871736923827;8589.656413743505;8694.043655197924;8733.301335893113;8751.256143227769;8042.276195142465;8217.644088725532;8281.585920704061;8349.457285276438;8353.37349698763;9430.62277508892;9713.56288966984;9774.12032917041;9959.601615935282;10069.244806639384;9696.078872507383;9871.01289871007;9937.453440060866;9938.354006989523;10091;7627.694892204249;7634.923650763421;7705.653245604073;7742.070951485858;7774.727884524014;8314.708985185489;8386.580670966548;8408.789780255298;8414.537200454033;8447.535385553854;7408.62956852166;7422.146453157956;7510.436717246119;7663.233676632292;7687.577183254974;7390.334869861738;7468.2158373372185;7471.589062601609;7574.166841647525;7575.053118360205;7845.9215407845195;7923.088844782924;7924.286814186751;7965.964424624762;7967.840643186988;7113.253108423748;7150.821229469097;7179.856402871809;7220.602866842374;7238.131424228915;6288.811335659938;7416.0729908761405;7463.738769143054;7479.70081196746;7492.850142997 06:41:15 INFO - PROCESS | 1670 | |4;prototype.html;286.93975759568406;336.8938784282951;339.23164033464207;343.62544826139504;343.79028792436617;6907.792766217009;6984.336488033635;7001.894971575418;7021.227664956863;7083.964580177105;5590.888182236363;6892.104026476563;6936.861262774742;7006.474514411414;7051.89422158668;4331.198728235271;4702.365180700596;4989.800407983676;5093.949060509403;5185.299984502081;5164.715940623264;5184.53339199472;5190.584753219752;5197.766100525486;5201.791928322863;4775.856724298276;5118.564921981636;5124.461931497195;5130.538251557359;5132.948670513303;5133.922991155136;5135.871603209912;5136.203888397305;5139.640225184238;5157.020166168453;4408.515063343029;4412.338149277602;4414.117176564668;4416.668749843775;4417.823287068513;6526.347365263483;6688.531802773759;6713.127293451869;6738.764143255012;6796.490263230228;6014.699265036731;6061.454469097758;6072.544559158081;6075.779836686564;6130.8773824523705;7426.183119856812;7427.591482468462;7430.145533263636;7431.331180193754;7455.589942553157;4946.1344264753525;4951;4952.207646776498;4954.355933728628;4963.602911767086;6323.715432805535;7566.659500322444;7907.802304942365;7911.327537159348;7917.2874441300555;5035.018171456531;5042.546170844642;5051.1413059779925;5053.84838454847;5065.772040258197;4118.629323360912;5150.40770311419;5167.018266529348;5169.224616307584;5176.922346164811;6060.212172417558;6062.787802426894;6074.878502430015;6076.3316035236085;6093.299270583851;6744.22441419243;7204.675789589481;7484.176740558534;7502.774916752506;7515.248475152441;1638.0908595729247;1762.4448298785842;1789.5436663650946;1791.3819732192374;1791.8387345139;1064.2816099133054;1075.1184029096066;1081.9783604328027;1085.1644233939821;1086.0551320351344;6802.455803535705;6822.692978815965;6834.4874134440115;6866.588004719732;6961.199462061826;6758;6964;7564.621768911533;7595.354394876497;7683.0780306363595;4996.975619997892;7043.225245223021;7067.43460523157;7101.254368291358;7141.178764442052;4081.918361632751;4130.256553820341;4136.4415803866095;4140.751554906716;4150.833966641361;8218.83562328762;8220.095789463154;8232.464889782264;8251.711190108317;8257.463264887763;6965.024896514492;7690.384769218449;7816.648250828726;8015.639296231683;8108.270255677017;8138.470999385021;8168.387370947203;8241.917580824234;8250.504969701957;8250.834983300301;7205.279472052753;7217.819554511179;7917.485363451357;7937.801554961172;7943.324817390587;7695.730649427243;7698;7700.306972372513;7702.075750909927;7714.9614251930625;7885.369170466463;8134.495118403114;8150.75547733569;8254.380921430797;8268.958655206685;4812.422509298906;4831.275308703723;4885.071836351224;4888.828890988798;4894.898647804215;6473.287938326875;7611.847763044819;7790.8831367530665;7820.357724877612;7826.295633393022;7467.887981680387;7498.925010749823;7510.62446877643;7519.210482899217;7541.396688264816;7238.674259658223;7438.962805185939;7451.7391891285715;7456.366208872307;7467.775966721007;5918.73365698536;7247.601381923834;7374.926250737424;7390.187079421367;7434.107907051189;7508.399328053852;7512;7517.548947063194;7526.360259378014;7537.8115547111765;6321.399467050623;7169.928300716926;7352.96323518379;7355.154157271768;7385.446091543048 06:41:15 INFO - PROCESS | 1670 | |5;yui.html;717.3579646216637;777.3509119884899;792.116789779396;792.4730054513749;798.7164556582413;15274.69450610987;15396;15587.84412155878;15610.375584976602;15631.843681563181;14309.069910455813;14367.712645747079;14368.71262574748;14375.928120359384;14433;793.5635400529685;797.9800504987393;823.3454403749004;828.6975254032295;959.2853324273409;959.721680712596;969.1084202533686;972.0813830929774;974.2595627323215;978.1050338939897;1017.3539802225566;1041.8489319048733;1043.5356266461429;1047.7328281288299;1048.397171626314;1017.8218811707959;1022.0750221049962;1031.128696251666;1033.0341131042424;1033.2767063055853;754.1252147508864;771.4329967473902;771.4599780153859;772.9304362607336;776.0687175389498;15701.92149039259;15734;15768.68462630741;15806.841931580651;15822.841771582252;11019.338839669645;13487.190768553919;13741.793873091912;13756.724865502634;13768.02908625989;10352.534135963824;10472.947635261775;10502.002309780559;10583.788324233548;10816.459177041117;2930.970690293091;3595.694365978895;3602.7297952653657;3630.310241054218;3686.1706116123923;85795.28409431776;86298.56850715706;87159.12840871574;88924.55537722334;89082.55458722729;9957.452340121363;9969.950150249348;9993.250506212064;10136.746581335525;10244.64143754965;18110.185041673158;21885.562288754136;21944.670829937564;22055;22100;7741.380689544823;7826.726064587712;7884.605769711607;7924.405669574805;8011.879821802678;4279.679024073144;4305.5048669402795;4361.5856493633055;4369.453818272716;4484.0583477469445;3803.733738638324;3804.9809750951067;3824.043989002749;3832.693384529287;3833.0225792422752;548.3071513357534;615.0896672924008;620.9316975132732;622.3341025103097;622.6202016769766;547.261197383537;581.3721181124375;585.2187329914611;611.0742225528328;620.9257983688244;8593.44142630727;8633.136686331316;8686.826263474695;8688.478691278544;8762.225868716236;610.9327973922865;618.0512912679017;625.9467945224707;632.7405763636887;635.2630948100182;4013.8795836124964;4027.234825383168;4048.8987775305854;4055.2903241932545;4105.097686952664;100581.99418005873;101461;102191.48904255431;106742;109356.45321773499;79165;80943;81399.59300203461;84099.15900841035;85940;76542.61728691321;77261;77664.61167694125;79370.60314698389;79374.80937785938;7680.231976802275;8712.172343627346;8858.741021039594;8933.865992010255;9131.589078491617;41781.79109104435;48313.03373932432;51625.48374516207;53274.4672553285;54969.72515137399;73302;74560.62719686367;74821.62589187238;75741;75947;11262.718432039264;11517.53929842797;11561.595344162914;11669.416529173677;11708.180427370002;12058.457369418573;12077.51689932393;12235.449404776627;12373.13388062827;13009.284489352798;11719.76560468803;11789.70525736829;11862.703432414259;12242.95934845548;12307.69230769238;11724.472398742248;11768.764624707286;11791.882081179421;11923;12325.383730813603;11409;11473.139514536277;11556.653300401002;11607.709807254887;12144.33206173669;9925.602975880884;9953.292480888027;10036;10085.142762865238;10255.384676919408;9709.417434953926;9943.403395796275;9951.353162044445;9963.551640176354;10104.292699510963 06:41:15 INFO - PROCESS | 1670 | __end_tp_report 06:41:15 INFO - PROCESS | 1670 | __start_cc_report 06:41:15 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,355 06:41:15 INFO - PROCESS | 1670 | __end_cc_report 06:41:15 INFO - PROCESS | 1670 | __startTimestamp1465220475569__endTimestamp 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | ------- Summary: start ------- 06:41:15 INFO - PROCESS | 1670 | Number of tests: 6 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5865.51 Median:6135.11 stddev:643.12 (10.5%) stddev-sans-first:621.52 06:41:15 INFO - PROCESS | 1670 | Values: 3665.9 3692.9 3714.0 3735.2 3752.1 6008.9 6039.9 6042.5 6073.5 6086.8 4954.8 6001.4 6002.3 6022.9 6050.9 5343.3 5365.9 5371.8 5437.6 5492.3 5362.1 5409.3 5424.9 5460.9 5509.3 4892.6 5218.3 5468.2 5485.5 5487.8 4529.0 5297.7 5427.1 5437.9 5502.9 5282.1 5282.2 5332.9 5350.1 5373.2 5699.4 5742.9 5773.1 5855.9 5863.6 6179.2 6214.3 6249.0 6251.8 6263.8 6268.2 6320.0 6321.2 6341.1 6356.0 6080.7 6081.8 6118.5 6134.6 6138.4 6197.6 6213.2 6287.6 6460.6 6503.2 5265.5 6210.0 6211.6 6232.7 6259.2 6341.6 6352.8 6354.7 6369.4 6389.5 6148.9 6192.2 6197.4 6257.9 6262.1 6218.2 6225.5 6236.6 6250.0 6258.2 5015.9 5016.7 5054.6 5054.7 5079.7 4444.9 4468.1 4482.9 4593.8 4632.1 5661.6 6093.0 6105.8 6132.6 6135.1 6265.5 6313.9 6374.2 6386.0 6387.8 5957.9 6085.8 6133.1 6136.1 6181.0 4605.6 5596.4 5598.7 5601.0 5604.0 6616.4 6616.8 6622.3 6638.7 6644.0 6180.1 6325.8 6385.7 6413.9 6424.6 6630.2 6632.1 6646.5 6648.0 6654.2 6175.7 6272.3 6279.8 6283.8 6290.9 6242.8 6246.8 6277.2 6312.3 6337.6 5121.6 5192.9 6078.5 6148.6 6249.6 5033.4 5985.0 6163.8 6219.0 6227.3 5955.9 6129.8 6171.9 6215.3 6236.9 6112.7 6215.9 6238.1 6246.6 6250.6 5306.9 6122.6 6166.0 6230.1 6254.0 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:68933.58 Median:40420.46 stddev:148612.88 (367.7%) stddev-sans-first:148940.89 06:41:15 INFO - PROCESS | 1670 | Values: 473.8 534.0 566.9 658.0 694.0 38575.6 39516.6 39636.8 39677.4 39741.8 41886.8 42143.8 42380.0 42529.7 42597.8 9565.9 9764.5 9815.2 9825.3 9858.0 9600.4 9826.3 9863.6 9880.4 9891.3 9810.2 9834.9 9862.6 9869.2 9898.7 9819.9 9875.0 9890.2 9903.3 9914.5 9773.3 9861.4 9882.9 9887.2 9922.0 41085.6 41305.4 41318.8 41560.6 41615.6 2981.7 3312.3 3399.2 3454.9 3461.7 29115.3 29450.6 29858.0 29956.3 30392.7 2310.5 2835.5 2835.8 2906.6 2945.6 442939.0 444050.8 447320.0 448702.8 449930.0 49036.0 71038.9 71813.6 71896.6 73187.0 48281.6 48305.8 48394.8 48673.3 48679.0 16876.7 16877.9 16977.3 17213.9 17324.0 13486.4 13567.1 13591.3 13664.8 13678.7 15456.1 15734.0 15856.8 15937.6 15975.7 6390.9 6652.2 6659.6 6685.5 6691.6 888.5 918.5 1044.8 1121.1 1180.9 26551.3 27327.7 30586.5 31256.8 31350.5 1069.5 1126.2 1208.9 1246.0 1328.7 12279.8 13754.6 15554.9 15685.8 15861.8 669997.0 670173.0 678324.0 679013.0 679355.0 64542.0 65847.0 66682.7 66856.0 66935.0 1557.5 1580.9 1590.7 1601.9 1611.3 29854.1 30016.8 30096.1 30594.0 30687.1 54057.0 54251.0 54496.7 54531.9 54766.2 520183.0 520323.0 520432.0 523897.0 525315.0 34860.3 35958.5 36075.8 36439.0 36537.6 48665.3 49043.0 49352.5 49779.0 50190.2 39172.8 39916.8 40184.6 40350.6 40429.1 39544.6 39768.6 40093.6 40411.8 40690.0 33432.0 38227.2 38287.2 39424.8 40162.2 27654.3 31596.7 32298.7 33608.0 34308.3 25837.9 25858.6 25915.9 25924.0 26374.5 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:28706.51 Median:2302.55 stddev:84076.95 (3651.5%) stddev-sans-first:84285.88 06:41:15 INFO - PROCESS | 1670 | Values: 368.5 373.5 375.6 379.7 382.7 20419.4 21182.9 21568.7 22405.4 22407.8 12203.9 12675.1 20687.3 21217.8 21318.1 5276.2 5481.8 5484.5 5492.2 5493.9 3455.2 4865.8 5936.1 5993.1 6106.0 5958.8 6052.0 6057.0 6059.5 6104.1 6319.2 6459.4 6497.9 6526.2 6534.5 5312.0 5690.6 5709.6 5754.2 5770.8 13497.7 13634.9 13816.4 13886.9 13901.4 2108.1 2119.0 2145.0 2288.6 2316.5 9817.6 10094.7 10250.0 10254.5 10382.7 1656.2 1723.5 1734.3 1746.3 1755.3 80582.0 104873.5 109755.0 112016.0 114213.3 11641.8 11768.3 11805.0 11810.4 11834.9 12628.0 13965.9 14517.9 14543.8 14586.7 8987.4 9155.4 9220.0 9230.1 9280.5 7604.8 9312.0 9350.0 9372.2 9435.5 4571.0 4585.7 4621.3 4622.7 4659.7 1774.4 1840.9 1882.5 1939.0 1945.8 382.3 871.4 940.2 949.5 1062.8 9262.5 10735.3 11484.5 11556.2 11609.0 431.0 870.5 889.0 978.8 1036.9 10468.7 10791.6 10829.6 10842.9 10859.8 257018.0 257365.0 413739.0 691810.0 694738.0 48330.0 73000.0 74086.6 119307.0 125796.0 1011.8 1051.7 1081.2 1081.4 1084.6 16089.9 18386.3 18475.7 18720.5 18769.2 34699.5 43220.8 44282.6 48660.5 48666.3 65968.3 68987.0 69638.7 74040.6 74370.6 7879.5 8039.3 8263.0 8466.5 8514.5 12139.8 12203.8 13443.7 13454.1 13733.0 9581.5 9629.8 11124.3 11490.0 12017.8 8314.4 11475.5 11500.6 11597.4 11828.2 11707.2 11786.5 11871.5 12015.6 12138.6 8324.8 8394.6 8398.3 8430.0 8527.2 8820.9 11171.8 11309.7 11852.8 11976.3 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6273.72 Median:5244.16 stddev:3264.10 (62.2%) stddev-sans-first:3254.65 06:41:15 INFO - PROCESS | 1670 | Values: 1637.0 1646.4 1954.5 2041.6 2049.3 7378.7 8259.4 8993.0 9146.0 9147.3 8878.8 8974.5 9002.6 9083.8 9110.0 2545.4 2547.0 2552.6 2560.5 2576.0 2504.8 2542.3 2545.3 2555.3 2575.6 2499.8 2508.2 2513.2 2531.4 2558.7 2500.9 2514.3 2517.2 2570.0 2572.2 2533.8 2547.1 2557.4 2559.5 2580.6 9186.9 9187.5 9258.2 9268.5 9288.1 5722.8 5806.9 5848.4 5868.1 5874.3 3700.0 3781.0 3811.1 3839.7 3846.4 1058.9 1088.0 1088.9 1123.2 1124.9 12442.4 12507.4 12543.8 12581.4 12585.8 5038.7 5051.6 5117.7 5119.8 5125.3 10426.8 10455.2 10480.8 10546.3 10640.5 5749.5 5775.3 5787.7 5815.4 5834.4 4683.4 5098.3 5204.4 5209.0 5279.3 3984.3 4100.4 4147.6 4148.4 4159.0 1110.4 1249.1 1373.4 1388.1 1389.0 1183.9 1233.4 1296.5 1377.8 1419.6 7200.8 8047.2 8461.6 8476.1 8517.7 1102.0 1353.5 1367.3 1367.8 1379.6 6407.7 6421.9 6444.3 6517.8 6523.8 10801.4 10953.4 11098.9 11214.9 11238.3 10619.9 10954.2 10967.5 10969.5 11213.9 8550.9 8589.7 8694.0 8733.3 8751.3 8042.3 8217.6 8281.6 8349.5 8353.4 9430.6 9713.6 9774.1 9959.6 10069.2 9696.1 9871.0 9937.5 9938.4 10091.0 7627.7 7634.9 7705.7 7742.1 7774.7 8314.7 8386.6 8408.8 8414.5 8447.5 7408.6 7422.1 7510.4 7663.2 7687.6 7390.3 7468.2 7471.6 7574.2 7575.1 7845.9 7923.1 7924.3 7966.0 7967.8 7113.3 7150.8 7179.9 7220.6 7238.1 6288.8 7416.1 7463.7 7479.7 7492.9 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:6088.32 Median:6850.54 stddev:1951.26 (28.5%) stddev-sans-first:1907.53 06:41:15 INFO - PROCESS | 1670 | Values: 286.9 336.9 339.2 343.6 343.8 6907.8 6984.3 7001.9 7021.2 7084.0 5590.9 6892.1 6936.9 7006.5 7051.9 4331.2 4702.4 4989.8 5093.9 5185.3 5164.7 5184.5 5190.6 5197.8 5201.8 4775.9 5118.6 5124.5 5130.5 5132.9 5133.9 5135.9 5136.2 5139.6 5157.0 4408.5 4412.3 4414.1 4416.7 4417.8 6526.3 6688.5 6713.1 6738.8 6796.5 6014.7 6061.5 6072.5 6075.8 6130.9 7426.2 7427.6 7430.1 7431.3 7455.6 4946.1 4951.0 4952.2 4954.4 4963.6 6323.7 7566.7 7907.8 7911.3 7917.3 5035.0 5042.5 5051.1 5053.8 5065.8 4118.6 5150.4 5167.0 5169.2 5176.9 6060.2 6062.8 6074.9 6076.3 6093.3 6744.2 7204.7 7484.2 7502.8 7515.2 1638.1 1762.4 1789.5 1791.4 1791.8 1064.3 1075.1 1082.0 1085.2 1086.1 6802.5 6822.7 6834.5 6866.6 6961.2 6758.0 6964.0 7564.6 7595.4 7683.1 4997.0 7043.2 7067.4 7101.3 7141.2 4081.9 4130.3 4136.4 4140.8 4150.8 8218.8 8220.1 8232.5 8251.7 8257.5 6965.0 7690.4 7816.6 8015.6 8108.3 8138.5 8168.4 8241.9 8250.5 8250.8 7205.3 7217.8 7917.5 7937.8 7943.3 7695.7 7698.0 7700.3 7702.1 7715.0 7885.4 8134.5 8150.8 8254.4 8269.0 4812.4 4831.3 4885.1 4888.8 4894.9 6473.3 7611.8 7790.9 7820.4 7826.3 7467.9 7498.9 7510.6 7519.2 7541.4 7238.7 7439.0 7451.7 7456.4 7467.8 5918.7 7247.6 7374.9 7390.2 7434.1 7508.4 7512.0 7517.5 7526.4 7537.8 6321.4 7169.9 7353.0 7355.2 7385.4 06:41:15 INFO - PROCESS | 1670 | 06:41:15 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:19581.69 Median:22943.44 stddev:28170.54 (122.8%) stddev-sans-first:28213.95 06:41:15 INFO - PROCESS | 1670 | Values: 717.4 777.4 792.1 792.5 798.7 15274.7 15396.0 15587.8 15610.4 15631.8 14309.1 14367.7 14368.7 14375.9 14433.0 793.6 798.0 823.3 828.7 959.3 959.7 969.1 972.1 974.3 978.1 1017.4 1041.8 1043.5 1047.7 1048.4 1017.8 1022.1 1031.1 1033.0 1033.3 754.1 771.4 771.5 772.9 776.1 15701.9 15734.0 15768.7 15806.8 15822.8 11019.3 13487.2 13741.8 13756.7 13768.0 10352.5 10472.9 10502.0 10583.8 10816.5 2931.0 3595.7 3602.7 3630.3 3686.2 85795.3 86298.6 87159.1 88924.6 89082.6 9957.5 9970.0 9993.3 10136.7 10244.6 18110.2 21885.6 21944.7 22055.0 22100.0 7741.4 7826.7 7884.6 7924.4 8011.9 4279.7 4305.5 4361.6 4369.5 4484.1 3803.7 3805.0 3824.0 3832.7 3833.0 548.3 615.1 620.9 622.3 622.6 547.3 581.4 585.2 611.1 620.9 8593.4 8633.1 8686.8 8688.5 8762.2 610.9 618.1 625.9 632.7 635.3 4013.9 4027.2 4048.9 4055.3 4105.1 100582.0 101461.0 102191.5 106742.0 109356.5 79165.0 80943.0 81399.6 84099.2 85940.0 76542.6 77261.0 77664.6 79370.6 79374.8 7680.2 8712.2 8858.7 8933.9 9131.6 41781.8 48313.0 51625.5 53274.5 54969.7 73302.0 74560.6 74821.6 75741.0 75947.0 11262.7 11517.5 11561.6 11669.4 11708.2 12058.5 12077.5 12235.4 12373.1 13009.3 11719.8 11789.7 11862.7 12243.0 12307.7 11724.5 11768.8 11791.9 11923.0 12325.4 11409.0 11473.1 11556.7 11607.7 12144.3 9925.6 9953.3 10036.0 10085.1 10255.4 9709.4 9943.4 9951.4 9963.6 10104.3 06:41:15 INFO - PROCESS | 1670 | -------- Summary: end -------- 06:41:15 INFO - PROCESS | 1670 | 06:41:16 INFO - TEST-INFO | 1670: exit 0 06:41:16 INFO - TEST-OK | dromaeo_css | took 1109432ms 06:41:16 INFO - TEST-START | kraken 06:41:16 INFO - operating with platform_type : mac_ 06:41:16 INFO - Initialising browser for kraken test... 06:41:16 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpDetIPF/profile http://localhost:49272/getInfo.html) 06:41:18 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 06:41:18 INFO - PROCESS | 1678 | colorDepth:24 06:41:18 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 06:41:18 INFO - PROCESS | 1678 | __metrics 06:41:18 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:41:19 INFO - TEST-INFO | 1678: exit 0 06:41:19 INFO - Browser initialized. 06:41:19 INFO - Running cycle 1/1 for kraken test... 06:41:19 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpDetIPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:31 INFO - PROCESS | 1682 | RSS: Main: 168153088 06:41:31 INFO - PROCESS | 1682 | 06:41:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:34 INFO - PROCESS | 1682 | RSS: Main: 179720192 06:41:34 INFO - PROCESS | 1682 | 06:41:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 06:41:37 INFO - PROCESS | 1682 | RSS: Main: 188825600 06:41:37 INFO - PROCESS | 1682 | 06:41:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 06:41:41 INFO - PROCESS | 1682 | RSS: Main: 191234048 06:41:41 INFO - PROCESS | 1682 | 06:41:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 06:41:44 INFO - PROCESS | 1682 | RSS: Main: 192245760 06:41:44 INFO - PROCESS | 1682 | 06:41:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:46 INFO - PROCESS | 1682 | RSS: Main: 192774144 06:41:46 INFO - PROCESS | 1682 | 06:41:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:50 INFO - PROCESS | 1682 | RSS: Main: 193228800 06:41:50 INFO - PROCESS | 1682 | 06:41:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:53 INFO - PROCESS | 1682 | RSS: Main: 194306048 06:41:53 INFO - PROCESS | 1682 | 06:41:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 06:41:57 INFO - PROCESS | 1682 | RSS: Main: 194420736 06:41:57 INFO - PROCESS | 1682 | 06:41:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:59 INFO - PROCESS | 1682 | RSS: Main: 194162688 06:41:59 INFO - PROCESS | 1682 | 06:42:01 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:42:01 INFO - PROCESS | 1682 | RSS: Main: 194170880 06:42:01 INFO - PROCESS | 1682 | 06:42:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:42:04 INFO - PROCESS | 1682 | RSS: Main: 194158592 06:42:04 INFO - PROCESS | 1682 | 06:42:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:42:07 INFO - PROCESS | 1682 | RSS: Main: 194252800 06:42:07 INFO - PROCESS | 1682 | 06:42:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:42:10 INFO - PROCESS | 1682 | RSS: Main: 194351104 06:42:10 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 06:42:12 INFO - PROCESS | 1682 | RSS: Main: 196165632 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | __start_tp_report 06:42:12 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 06:42:12 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 06:42:12 INFO - PROCESS | 1682 | |i|pagename|runs| 06:42:12 INFO - PROCESS | 1682 | |0;ai-astar;116;111;117;115;116;129;117;115;115;137 06:42:12 INFO - PROCESS | 1682 | |1;audio-beat-detection;153;121;154;141;132;178;174;145;187;120 06:42:12 INFO - PROCESS | 1682 | |2;audio-dft;271;273;195;229;280;201;197;195;200;194 06:42:12 INFO - PROCESS | 1682 | |3;audio-fft;67;90;66;107;57;59;59;63;120;47 06:42:12 INFO - PROCESS | 1682 | |4;audio-oscillator;86;85;120;78;82;79;121;81;81;120 06:42:12 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;92;89;92;89;92;88;93;90;93;89 06:42:12 INFO - PROCESS | 1682 | |6;imaging-darkroom;96;97;96;97;97;95;96;97;96;96 06:42:12 INFO - PROCESS | 1682 | |7;imaging-desaturate;136;150;95;92;90;93;98;91;90;88 06:42:12 INFO - PROCESS | 1682 | |8;json-parse-financial;56;57;62;68;81;91;87;89;69;59 06:42:12 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;65;71;64;87;65;65;65;65;66;68 06:42:12 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;83;85;89;98;111;109;82;81;81;86 06:42:12 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;122;131;130;142;132;136;120;143;118;106 06:42:12 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;138;134;156;123;126;133;170;172;155;143 06:42:12 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;69;66;69;66;70;64;68;87;99;77 06:42:12 INFO - PROCESS | 1682 | __end_tp_report 06:42:12 INFO - PROCESS | 1682 | __start_cc_report 06:42:12 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,918 06:42:12 INFO - PROCESS | 1682 | __end_cc_report 06:42:12 INFO - PROCESS | 1682 | __startTimestamp1465220532848__endTimestamp 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | ------- Summary: start ------- 06:42:12 INFO - PROCESS | 1682 | Number of tests: 14 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:118.80 Median:116.50 stddev:7.90 (6.8%) stddev-sans-first:8.31 06:42:12 INFO - PROCESS | 1682 | Values: 116.0 111.0 117.0 115.0 116.0 129.0 117.0 115.0 115.0 137.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:153.50 stddev:23.39 (15.2%) stddev-sans-first:24.79 06:42:12 INFO - PROCESS | 1682 | Values: 153.0 121.0 154.0 141.0 132.0 178.0 174.0 145.0 187.0 120.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:223.50 Median:215.00 stddev:36.79 (17.1%) stddev-sans-first:34.78 06:42:12 INFO - PROCESS | 1682 | Values: 271.0 273.0 195.0 229.0 280.0 201.0 197.0 195.0 200.0 194.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:73.50 Median:61.00 stddev:23.95 (39.3%) stddev-sans-first:25.28 06:42:12 INFO - PROCESS | 1682 | Values: 67.0 90.0 66.0 107.0 57.0 59.0 59.0 63.0 120.0 47.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:81.00 stddev:18.81 (23.2%) stddev-sans-first:19.76 06:42:12 INFO - PROCESS | 1682 | Values: 86.0 85.0 120.0 78.0 82.0 79.0 121.0 81.0 81.0 120.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:92.00 stddev:1.89 (2.1%) stddev-sans-first:1.94 06:42:12 INFO - PROCESS | 1682 | Values: 92.0 89.0 92.0 89.0 92.0 88.0 93.0 90.0 93.0 89.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:42:12 INFO - PROCESS | 1682 | Values: 96.0 97.0 96.0 97.0 97.0 95.0 96.0 97.0 96.0 96.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:102.30 Median:91.50 stddev:21.88 (23.9%) stddev-sans-first:19.52 06:42:12 INFO - PROCESS | 1682 | Values: 136.0 150.0 95.0 92.0 90.0 93.0 98.0 91.0 90.0 88.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:75.00 stddev:13.87 (18.5%) stddev-sans-first:13.46 06:42:12 INFO - PROCESS | 1682 | Values: 56.0 57.0 62.0 68.0 81.0 91.0 87.0 89.0 69.0 59.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:65.50 stddev:6.95 (10.6%) stddev-sans-first:7.28 06:42:12 INFO - PROCESS | 1682 | Values: 65.0 71.0 64.0 87.0 65.0 65.0 65.0 65.0 66.0 68.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:84.00 stddev:11.45 (13.6%) stddev-sans-first:11.82 06:42:12 INFO - PROCESS | 1682 | Values: 83.0 85.0 89.0 98.0 111.0 109.0 82.0 81.0 81.0 86.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:131.50 stddev:11.54 (8.8%) stddev-sans-first:12.03 06:42:12 INFO - PROCESS | 1682 | Values: 122.0 131.0 130.0 142.0 132.0 136.0 120.0 143.0 118.0 106.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:149.00 stddev:17.44 (11.7%) stddev-sans-first:18.32 06:42:12 INFO - PROCESS | 1682 | Values: 138.0 134.0 156.0 123.0 126.0 133.0 170.0 172.0 155.0 143.0 06:42:12 INFO - PROCESS | 1682 | 06:42:12 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:69.50 stddev:11.21 (16.1%) stddev-sans-first:11.77 06:42:12 INFO - PROCESS | 1682 | Values: 69.0 66.0 69.0 66.0 70.0 64.0 68.0 87.0 99.0 77.0 06:42:12 INFO - PROCESS | 1682 | -------- Summary: end -------- 06:42:12 INFO - PROCESS | 1682 | 06:42:13 INFO - TEST-INFO | 1682: exit 0 06:42:13 INFO - TEST-OK | kraken | took 57483ms 06:42:13 INFO - SUITE-END | took 1166s 06:42:14 INFO - Completed test suite (00:19:27) 06:42:14 INFO - javascript benchmark 06:42:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3665.9450108248375, 3692.926141477169, 3713.9628603713973, 3735.1595890924546, 3752.1370084880477, 6008.909866352008, 6039.879202415949, 6042.486388656964, 6073.453389194971, 6086.786962456309, 4954.801807927687, 6001.399860014008, 6002.339742628318, 6022.909656355158, 6050.939490605093, 5343.251944727732, 5365.892682146355, 5371.838844834661, 5437.564994800427, 5492.340919089715, 5362.088444964365, 5409.26974858393, 5424.864378390533, 5460.890782184354, 5509.256250406204, 4892.5596696297325, 5218.347706536683, 5468.234447177399, 5485.533729632986, 5487.807926722566, 4528.980979279685, 5297.682139071668, 5427.1316589345515, 5437.918431223535, 5502.889942201154, 5282.128448805943, 5282.181261904372, 5332.893342133174, 5350.117230656937, 5373.194020896858, 5699.430056994309, 5742.856428589277, 5773.1051686988585, 5855.941440585582, 5863.58954873159, 6179.19670442844, 6214.285357183937, 6248.96875515624, 6251.812445626639, 6263.843403914893, 6268.15379923709, 6319.968400158015, 6321.209848768904, 6341.143945567335, 6356.0, 6080.665563394055, 6081.847953801146, 6118.510519158456, 6134.570580059398, 6138.386161383915, 6197.597156184834, 6213.2233470816145, 6287.591306565058, 6460.612363258219, 6503.187101612299, 5265.52610265078, 6209.96895015522, 6211.627302361872, 6232.719527621268, 6259.217597800275, 6341.587796793194, 6352.809415717536, 6354.6822658867795, 6369.363063693593, 6389.488840892717, 6148.907766383508, 6192.164057852222, 6197.411245931629, 6257.8748425031245, 6262.09199666055, 6218.160548326008, 6225.470834978987, 6236.6258024518675, 6250.0, 6258.186435763321, 5015.949840501621, 5016.749162541932, 5054.646174767731, 5054.721990290569, 5079.695218286841, 4444.933326000112, 4468.106378724268, 4482.887927801831, 4593.816247350069, 4632.119897219518, 5661.631993920382, 6092.969535152296, 6105.786297479655, 6132.601380910227, 6135.110408990671, 6265.467435267962, 6313.936860631335, 6374.203224596926, 6386.010168423902, 6387.776427825097, 5957.851053723692, 6085.756569737249, 6133.080037994337, 6136.05958347471, 6181.041938499539, 4605.631549476034, 5596.4123767003875, 5598.748056337475, 5601.047821870292, 5603.991281569357, 6616.404523592803, 6616.768413105518, 6622.337766223532, 6638.6680665966505, 6644.036614690843, 6180.103884936569, 6325.841853953688, 6385.744570217325, 6413.935860641333, 6424.582402143846, 6630.171228596426, 6632.104665870239, 6646.534742567974, 6648.0360347750275, 6654.168228971379, 6175.6912154393, 6272.341404152681, 6279.811605651837, 6283.842903927255, 6290.874182516232, 6242.843928901813, 6246.812595622138, 6277.15258440123, 6312.337204593635, 6337.556371054166, 5121.641485096007, 5192.896142077213, 6078.5441091919165, 6148.631082135086, 6249.593776404519, 5033.421156567042, 5985.0, 6163.8150855474405, 6219.004959206505, 6227.252729672468, 5955.940440595712, 6129.785457508966, 6171.938280617136, 6215.316315205233, 6236.906446403217, 6112.698207300172, 6215.875682486416, 6238.095476156022, 6246.593971391845, 6250.562460627712, 5306.893862122659, 6122.550631083031, 6166.013437849922, 6230.096635987847, 6254.0], "unit": "score", "name": "dojo.html", "value": 5829.199720384274}, {"lowerIsBetter": false, "replicates": [473.78442808522124, 534.0467265930315, 566.8752874367639, 658.019550869205, 693.9521322802567, 38575.614243857555, 39516.60483395165, 39636.801815990955, 39677.40483892744, 39741.80129099354, 41886.7905660472, 42143.78928105355, 42380.0, 42529.72410827672, 42597.7870110649, 9565.856512152322, 9764.51177441125, 9815.165710914582, 9825.263105267099, 9857.95071024644, 9600.423974561514, 9826.263030272758, 9863.60545578176, 9880.407175569453, 9891.307608467374, 9810.166135878459, 9834.852477212848, 9862.60549578016, 9869.210463162966, 9898.703038908845, 9819.90180098197, 9875.0, 9890.20878329732, 9903.25725570585, 9914.454704991258, 9773.267004974656, 9861.35901166429, 9882.851757223576, 9887.209023278121, 9921.950390248076, 41085.589144108475, 41305.38041929373, 41318.793406032775, 41560.58439415597, 41615.583844161476, 2981.6571094324213, 3312.3044160726276, 3399.2351720862607, 3454.9309013819834, 3461.7230621550216, 29115.272118197, 29450.558241626393, 29858.0, 29956.251093722614, 30392.696073039428, 2310.514791893704, 2835.503786837316, 2835.773138148943, 2906.607607972918, 2945.5728919306794, 442939.0, 444050.7797460992, 447320.0, 448702.75648622203, 449930.0, 49036.0, 71038.93441598381, 71813.64093179605, 71896.64051679813, 73187.0, 48281.55155345345, 48305.75847120812, 48394.79013024632, 48673.26990095151, 48679.0, 16876.746848797276, 16877.91561042187, 16977.320907163576, 17213.913930430266, 17323.960562366046, 13486.393112309774, 13567.05030647865, 13591.252481113435, 13664.795028074586, 13678.726425471436, 15456.149911754961, 15734.0, 15856.762148567781, 15937.601559960862, 15975.680486390207, 6390.904136437957, 6652.234992975869, 6659.600423974577, 6685.465162786965, 6691.631960242234, 888.493558671564, 918.5407296351824, 1044.8432735089798, 1121.1479275750326, 1180.8582970043649, 26551.336216594354, 27327.726722732918, 30586.541201881988, 31256.84371578173, 31350.52974205389, 1069.5187165775433, 1126.2318160487955, 1208.915375923677, 1245.9626211213679, 1328.6611913962072, 12279.815802762965, 13754.587362379145, 15554.922225389028, 15685.764713529306, 15861.841381586037, 669997.0, 670173.0, 678324.0, 679013.0, 679355.0, 64542.0, 65847.01229481562, 66682.66658666676, 66855.99716004264, 66934.99597506042, 1557.532740177942, 1580.936762529486, 1590.6739118480452, 1601.8878678492626, 1611.3393508661393, 29854.10437686873, 30016.84991575028, 30096.097117086523, 30594.0, 30687.079387618407, 54057.0, 54251.0, 54496.72751636217, 54531.90936181175, 54766.17850732162, 520183.0, 520323.0, 520432.0, 523897.0, 525315.0, 34860.30279394347, 35958.460623091196, 36075.819620901726, 36439.0, 36537.634623654485, 48665.270020950426, 49043.0, 49352.50647493479, 49779.0, 50190.2471462921, 39172.80413597914, 39916.800415997735, 40184.59815401809, 40350.59649403468, 40429.12880308985, 39544.604553954094, 39768.602313977644, 40093.59906400899, 40411.79794101128, 40690.0, 33432.0, 38227.235455291295, 38287.23425531529, 39424.802875985435, 40162.19675606413, 27654.3086422833, 31596.684033160294, 32298.677013229568, 33608.0, 34308.31383372368, 25837.870810645825, 25858.612120817827, 25915.870420647778, 25924.0, 26374.472510550066], "unit": "score", "name": "ext.html", "value": 20235.015777122382}, {"lowerIsBetter": false, "replicates": [368.5448471138144, 373.482726423903, 375.6243756243756, 379.68106790296144, 382.7225261685278, 20419.387418377435, 21182.940852957367, 21568.676469852944, 22405.43986400341, 22407.775922240773, 12203.877961220385, 12675.112742108056, 20687.275945341917, 21217.833019183978, 21318.147274109055, 5276.155815069599, 5481.780728770845, 5484.478974497416, 5492.176173573956, 5493.862653433656, 3455.2225749206355, 4865.781039853215, 5936.079907614305, 5993.130996005577, 6106.0, 5958.7616495340135, 6052.001419765756, 6056.969715151418, 6059.454649081582, 6104.084387341912, 6319.210098737658, 6459.35406459355, 6497.870042599146, 6526.249481309663, 6534.54258201926, 5312.007997001125, 5690.630109042899, 5709.628874123168, 5754.223179870705, 5770.79802206925, 13497.662558436019, 13634.93182534091, 13816.378262978089, 13886.861131388658, 13901.374438150307, 2108.146200788683, 2118.9894050529647, 2144.9892750536305, 2288.5766133265233, 2316.513532158249, 9817.607295708234, 10094.747631309203, 10250.0, 10254.53854576546, 10382.688519344432, 1656.2298531182937, 1723.500184946364, 1734.254270663614, 1746.3451205797826, 1755.2540170427517, 80582.0, 104873.47563262211, 109754.9999999992, 112016.0, 114213.28680069723, 11641.777613350645, 11768.293902365886, 11805.0, 11810.350430726392, 11834.875686809739, 12628.0, 13965.86034139666, 14517.854821451861, 14543.78184327236, 14586.708265834624, 8987.41581797181, 9155.359124861328, 9220.031896650755, 9230.123138301851, 9280.489573073412, 7604.8479030419085, 9312.022237665084, 9349.953250233706, 9372.1565059145, 9435.452427844444, 4571.0, 4585.724856508554, 4621.260598304255, 4622.745748983838, 4659.6505262105475, 1774.4321817018688, 1840.8862638103753, 1882.5481884347932, 1938.9709154362695, 1945.7762357329088, 382.2736800079815, 871.3551971541141, 940.2243149401771, 949.520492151459, 1062.7787923240464, 9262.490563019099, 10735.302205356784, 11484.540618375338, 11556.191066625424, 11609.013233875216, 430.984915527955, 870.525563567857, 888.9955550222207, 978.83849164887, 1036.9222308326905, 10468.68593942183, 10791.568337266579, 10829.566817327377, 10842.891571084188, 10859.78280434387, 257018.0, 257365.0, 413739.0, 691810.0, 694738.0, 48330.0, 73000.0, 74086.62956685181, 119307.0, 125796.0, 1011.8464949957055, 1051.7055224537141, 1081.221520505235, 1081.4430568257353, 1084.6366467233408, 16089.919550402174, 18386.264549417872, 18475.722864156778, 18720.53198670044, 18769.1553880073, 34699.47950780791, 43220.78389608032, 44282.564458955065, 48660.5133948656, 48666.270005949234, 65968.34031659622, 68987.0, 69638.65180674064, 74040.62979685067, 74370.62814685891, 7879.527228366316, 8039.316658084128, 8262.958685206535, 8466.492010479391, 8514.531700756517, 12139.75720485603, 12203.816942745689, 13443.731125377633, 13454.058215924792, 13733.0, 9581.520923953914, 9629.807403852024, 11124.332540047622, 11489.965903068764, 12017.81973270419, 8314.376421768513, 11475.540978361107, 11500.597479088527, 11597.362145082101, 11828.172027958304, 11707.239029463057, 11786.528538858349, 11871.465784039567, 12015.639530814089, 12138.635840924786, 8324.833503329779, 8394.580270986304, 8398.328133749163, 8430.0, 8527.18991695788, 8820.91179088201, 11171.776564468828, 11309.71725706864, 11852.76294474123, 11976.341301228516], "unit": "score", "name": "jquery.html", "value": 8926.33592315026}, {"lowerIsBetter": false, "replicates": [1637.0096091864423, 1646.4072933743853, 1954.482062253503, 2041.550858811062, 2049.282751037138, 7378.667959941802, 8259.42184047117, 8993.0, 9146.039665835084, 9147.313951453643, 8878.822423551524, 8974.50640214788, 9002.639894404232, 9083.818323633523, 9110.0, 2545.363659085229, 2546.961795573068, 2552.5660637691544, 2560.4879024195143, 2576.0468626608085, 2504.799616030722, 2542.275451496324, 2545.2873195505194, 2555.3228394475477, 2575.587905935051, 2499.7750202481775, 2508.2224510401834, 2513.246026192144, 2531.405119796846, 2558.7441255874355, 2500.862452565108, 2514.283429222672, 2517.244826552027, 2569.974300256992, 2572.241188849275, 2533.7592928671747, 2547.1212431711215, 2557.386227305452, 2559.5008973250224, 2580.5871060630398, 9186.908130918671, 9187.540622968825, 9258.21305189053, 9268.536573171383, 9288.11762882532, 5722.799702010409, 5806.941930580725, 5848.356680765112, 5868.119782032687, 5874.265716785402, 3700.0, 3781.0358358618378, 3811.085339518523, 3839.712021598363, 3846.365349717293, 1058.8623478947763, 1088.031651829872, 1088.8965548272902, 1123.230587047875, 1124.8650161980615, 12442.377881105998, 12507.37463126849, 12543.811842822364, 12581.37093145339, 12585.811212831815, 5038.722870242172, 5051.570616497639, 5117.744112794346, 5119.820806271762, 5125.256837758504, 10426.843597346045, 10455.21585881062, 10480.842787358195, 10546.314489558154, 10640.521176547074, 5749.453801888814, 5775.27809023872, 5787.652740835563, 5815.360310365856, 5834.358220595731, 4683.367745354401, 5098.337216161875, 5204.375474943031, 5209.0363282792805, 5279.287296215039, 3984.322665146932, 4100.36444351126, 4147.585241475828, 4148.357004664282, 4159.0, 1110.4114819145866, 1249.119370843553, 1373.3751143230006, 1388.1046724862408, 1389.0276806235674, 1183.9408029598658, 1233.4018001269378, 1296.4619682831708, 1377.8139951106673, 1419.6167034900518, 7200.811866042044, 8047.195280471906, 8461.56153453902, 8476.110008449024, 8517.659293628185, 1101.969658369411, 1353.4992052940474, 1367.282176857158, 1367.7743172376645, 1379.5792283353474, 6407.711652975628, 6421.903671444932, 6444.291127975919, 6517.837054073591, 6523.771667991692, 10801.351918884891, 10953.397563134104, 11098.944505277423, 11214.887851121384, 11238.325700458, 10619.94690026545, 10954.178436617285, 10967.50646220922, 10969.506372213269, 11213.887861121448, 8550.871736923827, 8589.656413743505, 8694.043655197924, 8733.301335893113, 8751.256143227769, 8042.276195142465, 8217.644088725532, 8281.585920704061, 8349.457285276438, 8353.37349698763, 9430.62277508892, 9713.56288966984, 9774.12032917041, 9959.601615935282, 10069.244806639384, 9696.078872507383, 9871.01289871007, 9937.453440060866, 9938.354006989523, 10091.0, 7627.694892204249, 7634.923650763421, 7705.653245604073, 7742.070951485858, 7774.727884524014, 8314.708985185489, 8386.580670966548, 8408.789780255298, 8414.537200454033, 8447.535385553854, 7408.62956852166, 7422.146453157956, 7510.436717246119, 7663.233676632292, 7687.577183254974, 7390.334869861738, 7468.2158373372185, 7471.589062601609, 7574.166841647525, 7575.053118360205, 7845.9215407845195, 7923.088844782924, 7924.286814186751, 7965.964424624762, 7967.840643186988, 7113.253108423748, 7150.821229469097, 7179.856402871809, 7220.602866842374, 7238.131424228915, 6288.811335659938, 7416.0729908761405, 7463.738769143054, 7479.70081196746, 7492.850142997], "unit": "score", "name": "mootools.html", "value": 5147.173698832548}, {"lowerIsBetter": false, "replicates": [286.93975759568406, 336.8938784282951, 339.23164033464207, 343.62544826139504, 343.79028792436617, 6907.792766217009, 6984.336488033635, 7001.894971575418, 7021.227664956863, 7083.964580177105, 5590.888182236363, 6892.104026476563, 6936.861262774742, 7006.474514411414, 7051.89422158668, 4331.198728235271, 4702.365180700596, 4989.800407983676, 5093.949060509403, 5185.299984502081, 5164.715940623264, 5184.53339199472, 5190.584753219752, 5197.766100525486, 5201.791928322863, 4775.856724298276, 5118.564921981636, 5124.461931497195, 5130.538251557359, 5132.948670513303, 5133.922991155136, 5135.871603209912, 5136.203888397305, 5139.640225184238, 5157.020166168453, 4408.515063343029, 4412.338149277602, 4414.117176564668, 4416.668749843775, 4417.823287068513, 6526.347365263483, 6688.531802773759, 6713.127293451869, 6738.764143255012, 6796.490263230228, 6014.699265036731, 6061.454469097758, 6072.544559158081, 6075.779836686564, 6130.8773824523705, 7426.183119856812, 7427.591482468462, 7430.145533263636, 7431.331180193754, 7455.589942553157, 4946.1344264753525, 4951.0, 4952.207646776498, 4954.355933728628, 4963.602911767086, 6323.715432805535, 7566.659500322444, 7907.802304942365, 7911.327537159348, 7917.2874441300555, 5035.018171456531, 5042.546170844642, 5051.1413059779925, 5053.84838454847, 5065.772040258197, 4118.629323360912, 5150.40770311419, 5167.018266529348, 5169.224616307584, 5176.922346164811, 6060.212172417558, 6062.787802426894, 6074.878502430015, 6076.3316035236085, 6093.299270583851, 6744.22441419243, 7204.675789589481, 7484.176740558534, 7502.774916752506, 7515.248475152441, 1638.0908595729247, 1762.4448298785842, 1789.5436663650946, 1791.3819732192374, 1791.8387345139, 1064.2816099133054, 1075.1184029096066, 1081.9783604328027, 1085.1644233939821, 1086.0551320351344, 6802.455803535705, 6822.692978815965, 6834.4874134440115, 6866.588004719732, 6961.199462061826, 6758.0, 6964.0, 7564.621768911533, 7595.354394876497, 7683.0780306363595, 4996.975619997892, 7043.225245223021, 7067.43460523157, 7101.254368291358, 7141.178764442052, 4081.918361632751, 4130.256553820341, 4136.4415803866095, 4140.751554906716, 4150.833966641361, 8218.83562328762, 8220.095789463154, 8232.464889782264, 8251.711190108317, 8257.463264887763, 6965.024896514492, 7690.384769218449, 7816.648250828726, 8015.639296231683, 8108.270255677017, 8138.470999385021, 8168.387370947203, 8241.917580824234, 8250.504969701957, 8250.834983300301, 7205.279472052753, 7217.819554511179, 7917.485363451357, 7937.801554961172, 7943.324817390587, 7695.730649427243, 7698.0, 7700.306972372513, 7702.075750909927, 7714.9614251930625, 7885.369170466463, 8134.495118403114, 8150.75547733569, 8254.380921430797, 8268.958655206685, 4812.422509298906, 4831.275308703723, 4885.071836351224, 4888.828890988798, 4894.898647804215, 6473.287938326875, 7611.847763044819, 7790.8831367530665, 7820.357724877612, 7826.295633393022, 7467.887981680387, 7498.925010749823, 7510.62446877643, 7519.210482899217, 7541.396688264816, 7238.674259658223, 7438.962805185939, 7451.7391891285715, 7456.366208872307, 7467.775966721007, 5918.73365698536, 7247.601381923834, 7374.926250737424, 7390.187079421367, 7434.107907051189, 7508.399328053852, 7512.0, 7517.548947063194, 7526.360259378014, 7537.8115547111765, 6321.399467050623, 7169.928300716926, 7352.96323518379, 7355.154157271768, 7385.446091543048], "unit": "score", "name": "prototype.html", "value": 5428.813909206813}, {"lowerIsBetter": false, "replicates": [717.3579646216637, 777.3509119884899, 792.116789779396, 792.4730054513749, 798.7164556582413, 15274.69450610987, 15396.0, 15587.84412155878, 15610.375584976602, 15631.843681563181, 14309.069910455813, 14367.712645747079, 14368.71262574748, 14375.928120359384, 14433.0, 793.5635400529685, 797.9800504987393, 823.3454403749004, 828.6975254032295, 959.2853324273409, 959.721680712596, 969.1084202533686, 972.0813830929774, 974.2595627323215, 978.1050338939897, 1017.3539802225566, 1041.8489319048733, 1043.5356266461429, 1047.7328281288299, 1048.397171626314, 1017.8218811707959, 1022.0750221049962, 1031.128696251666, 1033.0341131042424, 1033.2767063055853, 754.1252147508864, 771.4329967473902, 771.4599780153859, 772.9304362607336, 776.0687175389498, 15701.92149039259, 15734.0, 15768.68462630741, 15806.841931580651, 15822.841771582252, 11019.338839669645, 13487.190768553919, 13741.793873091912, 13756.724865502634, 13768.02908625989, 10352.534135963824, 10472.947635261775, 10502.002309780559, 10583.788324233548, 10816.459177041117, 2930.970690293091, 3595.694365978895, 3602.7297952653657, 3630.310241054218, 3686.1706116123923, 85795.28409431776, 86298.56850715706, 87159.12840871574, 88924.55537722334, 89082.55458722729, 9957.452340121363, 9969.950150249348, 9993.250506212064, 10136.746581335525, 10244.64143754965, 18110.185041673158, 21885.562288754136, 21944.670829937564, 22055.0, 22100.0, 7741.380689544823, 7826.726064587712, 7884.605769711607, 7924.405669574805, 8011.879821802678, 4279.679024073144, 4305.5048669402795, 4361.5856493633055, 4369.453818272716, 4484.0583477469445, 3803.733738638324, 3804.9809750951067, 3824.043989002749, 3832.693384529287, 3833.0225792422752, 548.3071513357534, 615.0896672924008, 620.9316975132732, 622.3341025103097, 622.6202016769766, 547.261197383537, 581.3721181124375, 585.2187329914611, 611.0742225528328, 620.9257983688244, 8593.44142630727, 8633.136686331316, 8686.826263474695, 8688.478691278544, 8762.225868716236, 610.9327973922865, 618.0512912679017, 625.9467945224707, 632.7405763636887, 635.2630948100182, 4013.8795836124964, 4027.234825383168, 4048.8987775305854, 4055.2903241932545, 4105.097686952664, 100581.99418005873, 101461.0, 102191.48904255431, 106742.0, 109356.45321773499, 79165.0, 80943.0, 81399.59300203461, 84099.15900841035, 85940.0, 76542.61728691321, 77261.0, 77664.61167694125, 79370.60314698389, 79374.80937785938, 7680.231976802275, 8712.172343627346, 8858.741021039594, 8933.865992010255, 9131.589078491617, 41781.79109104435, 48313.03373932432, 51625.48374516207, 53274.4672553285, 54969.72515137399, 73302.0, 74560.62719686367, 74821.62589187238, 75741.0, 75947.0, 11262.718432039264, 11517.53929842797, 11561.595344162914, 11669.416529173677, 11708.180427370002, 12058.457369418573, 12077.51689932393, 12235.449404776627, 12373.13388062827, 13009.284489352798, 11719.76560468803, 11789.70525736829, 11862.703432414259, 12242.95934845548, 12307.69230769238, 11724.472398742248, 11768.764624707286, 11791.882081179421, 11923.0, 12325.383730813603, 11409.0, 11473.139514536277, 11556.653300401002, 11607.709807254887, 12144.33206173669, 9925.602975880884, 9953.292480888027, 10036.0, 10085.142762865238, 10255.384676919408, 9709.417434953926, 9943.403395796275, 9951.353162044445, 9963.551640176354, 10104.292699510963], "unit": "score", "name": "yui.html", "value": 7236.528415210003}], "name": "dromaeo_css", "value": 7727.462837276724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 117.0, 115.0, 116.0, 129.0, 117.0, 115.0, 115.0, 137.0], "unit": "score", "name": "ai-astar", "value": 118.8}, {"lowerIsBetter": true, "replicates": [153.0, 121.0, 154.0, 141.0, 132.0, 178.0, 174.0, 145.0, 187.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [271.0, 273.0, 195.0, 229.0, 280.0, 201.0, 197.0, 195.0, 200.0, 194.0], "unit": "score", "name": "audio-dft", "value": 223.5}, {"lowerIsBetter": true, "replicates": [67.0, 90.0, 66.0, 107.0, 57.0, 59.0, 59.0, 63.0, 120.0, 47.0], "unit": "score", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 120.0, 78.0, 82.0, 79.0, 121.0, 81.0, 81.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 93.3}, {"lowerIsBetter": true, "replicates": [92.0, 89.0, 92.0, 89.0, 92.0, 88.0, 93.0, 90.0, 93.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 96.3}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 95.0, 92.0, 90.0, 93.0, 98.0, 91.0, 90.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 102.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 62.0, 68.0, 81.0, 91.0, 87.0, 89.0, 69.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [65.0, 71.0, 64.0, 87.0, 65.0, 65.0, 65.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 89.0, 98.0, 111.0, 109.0, 82.0, 81.0, 81.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.5}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 130.0, 142.0, 132.0, 136.0, 120.0, 143.0, 118.0, 106.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [138.0, 134.0, 156.0, 123.0, 126.0, 133.0, 170.0, 172.0, 155.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 69.0, 66.0, 70.0, 64.0, 68.0, 87.0, 99.0, 77.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.5}], "name": "kraken", "value": 1525.8999999999999}]} 06:42:14 INFO - Return code: 0 06:42:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:42:14 ERROR - # TBPL SUCCESS # 06:42:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:42:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:42:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:42:14 INFO - 2016-06-06 06:42:14.161 screenresolution[1687:11051] starting screenresolution argv=screenresolution get 06:42:14 INFO - 2016-06-06 06:42:14.164 screenresolution[1687:11051] Display 0: 1600x1200x32@60 06:42:14 INFO - 2016-06-06 06:42:14.170 screenresolution[1688:11054] starting screenresolution argv=screenresolution list 06:42:14 INFO - Available Modes on Display 0 06:42:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:42:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:42:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:42:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:42:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:42:14 INFO - Intel Iris: 06:42:14 INFO - Chipset Model: Intel Iris 06:42:14 INFO - Type: GPU 06:42:14 INFO - Bus: Built-In 06:42:14 INFO - VRAM (Dynamic, Max): 1536 MB 06:42:14 INFO - Vendor: Intel (0x8086) 06:42:14 INFO - Device ID: 0x0a2e 06:42:14 INFO - Revision ID: 0x0009 06:42:14 INFO - Displays: 06:42:14 INFO - Display: 06:42:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:42:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:42:14 INFO - Display Serial Number: 1600x1200 60 06:42:14 INFO - Main Display: Yes 06:42:14 INFO - Mirror: Off 06:42:14 INFO - Online: Yes 06:42:14 INFO - Rotation: Supported 06:42:14 INFO - Return code: 0 06:42:14 INFO - Running post-action listener: _resource_record_post_action 06:42:14 INFO - Running post-run listener: _resource_record_post_run 06:42:15 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 32640512; Write bytes: 513340416; Read time: 328; Write time: 1580 06:42:15 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 204980736; Write bytes: 197349376; Read time: 19207; Write time: 368 06:42:15 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30854656; Write bytes: 306242560; Read time: 305; Write time: 1179 06:42:15 INFO - Running post-run listener: _upload_blobber_files 06:42:15 INFO - Blob upload gear active. 06:42:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:42:15 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:42:15 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:42:15 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:42:15 INFO - (blobuploader) - INFO - Open directory for files ... 06:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:42:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:16 INFO - (blobuploader) - INFO - Done attempting. 06:42:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:42:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:42:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:17 INFO - (blobuploader) - INFO - Done attempting. 06:42:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:42:17 INFO - Return code: 0 06:42:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:42:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:42:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e151f492547d5fcf3ee9e9aea5fe0d25751156f0fa06b3e5eeb93029fa0963a7e10ac8ba1ab0b9d4f2ad150898078c58dea2af32ef9062fc61fc46f971a783d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d97711ca8be980bfa48ff76cc8787ddbbc723d3ded8107008838ef744855c098141c508dd52bcc89184ecdefd5d82fc0184008fedbd472241cf9175fda30390a"} 06:42:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:42:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:42:17 INFO - Contents: 06:42:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e151f492547d5fcf3ee9e9aea5fe0d25751156f0fa06b3e5eeb93029fa0963a7e10ac8ba1ab0b9d4f2ad150898078c58dea2af32ef9062fc61fc46f971a783d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d97711ca8be980bfa48ff76cc8787ddbbc723d3ded8107008838ef744855c098141c508dd52bcc89184ecdefd5d82fc0184008fedbd472241cf9175fda30390a"} 06:42:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:42:17 INFO - Copying logs to upload dir... 06:42:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:42:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.045575 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-06 06:42:17.584981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:17.588924) ========= 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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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/9e151f492547d5fcf3ee9e9aea5fe0d25751156f0fa06b3e5eeb93029fa0963a7e10ac8ba1ab0b9d4f2ad150898078c58dea2af32ef9062fc61fc46f971a783d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d97711ca8be980bfa48ff76cc8787ddbbc723d3ded8107008838ef744855c098141c508dd52bcc89184ecdefd5d82fc0184008fedbd472241cf9175fda30390a"} 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.011395 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/9e151f492547d5fcf3ee9e9aea5fe0d25751156f0fa06b3e5eeb93029fa0963a7e10ac8ba1ab0b9d4f2ad150898078c58dea2af32ef9062fc61fc46f971a783d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d97711ca8be980bfa48ff76cc8787ddbbc723d3ded8107008838ef744855c098141c508dd52bcc89184ecdefd5d82fc0184008fedbd472241cf9175fda30390a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:17.626429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:17.626759) ========= 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.TrGA86eoqL/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.Q0KDZF1YvD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005049 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:17.675604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:17.675910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:17.676395) ========= ========= Total master_lag: 0.18 =========