builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0117 starttime: 1461329304.1 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.100190) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.100679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.100962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.141111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.141524) ========= 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.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-04-22 05:48:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-04-22 05:48:24 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132742 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.311844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.312168) ========= 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.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.026624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.364906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:24.365408) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-04-22 05:48:24,439 truncating revision to first 12 chars 2016-04-22 05:48:24,439 Setting DEBUG logging. 2016-04-22 05:48:24,439 attempt 1/10 2016-04-22 05:48:24,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:48:25,164 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:25.355181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:25.355536) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:25.355981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:25.356283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:25.371882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-22 05:48:25.372236) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:48:25 INFO - MultiFileLogger online at 20160422 05:48:25 in /builds/slave/test 05:48:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:48:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:25 INFO - {'append_to_log': False, 05:48:25 INFO - 'base_work_dir': '/builds/slave/test', 05:48:25 INFO - 'blob_upload_branch': 'Fx-Team', 05:48:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:25 INFO - 'branch': 'Fx-Team', 05:48:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:25 INFO - 'config_files': ('talos/mac_config.py',), 05:48:25 INFO - 'default_actions': ('clobber', 05:48:25 INFO - 'read-buildbot-config', 05:48:25 INFO - 'download-and-extract', 05:48:25 INFO - 'populate-webroot', 05:48:25 INFO - 'create-virtualenv', 05:48:25 INFO - 'install', 05:48:25 INFO - 'run-tests'), 05:48:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:25 INFO - 'download_minidump_stackwalk': True, 05:48:25 INFO - 'download_symbols': 'ondemand', 05:48:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:25 INFO - 'installer_path': 'installer.exe', 05:48:25 INFO - 'log_level': 'info', 05:48:25 INFO - 'log_name': 'talos', 05:48:25 INFO - 'log_to_console': True, 05:48:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:48:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:48:25 INFO - 'opt_config_files': (), 05:48:25 INFO - 'pip_index': False, 05:48:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:25 INFO - 'cmd': ('bash', 05:48:25 INFO - '-c', 05:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:25 INFO - 'enabled': True, 05:48:25 INFO - 'halt_on_failure': False, 05:48:25 INFO - 'name': 'check_screen_resolution'},), 05:48:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:25 INFO - 'cmd': ('bash', 05:48:25 INFO - '-c', 05:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:25 INFO - 'enabled': True, 05:48:25 INFO - 'halt_on_failure': False, 05:48:25 INFO - 'name': 'check_screen_resolution'},), 05:48:25 INFO - 'run_cmd_checks_enabled': True, 05:48:25 INFO - 'sps_profile': False, 05:48:25 INFO - 'sps_profile_interval': 0, 05:48:25 INFO - 'suite': 'dromaeojs-e10s', 05:48:25 INFO - 'system_bits': '32', 05:48:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:25 INFO - 'title': 't-yosemite-r7-0117', 05:48:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:25 INFO - 'use_talos_json': True, 05:48:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:25 INFO - 'work_dir': 'build'} 05:48:25 INFO - ##### 05:48:25 INFO - ##### Running clobber step. 05:48:25 INFO - ##### 05:48:25 INFO - Running pre-action listener: _resource_record_pre_action 05:48:25 INFO - Running main action method: clobber 05:48:25 INFO - rmtree: /builds/slave/test/build 05:48:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:27 INFO - Running post-action listener: _resource_record_post_action 05:48:27 INFO - ##### 05:48:27 INFO - ##### Running read-buildbot-config step. 05:48:27 INFO - ##### 05:48:27 INFO - Running pre-action listener: _resource_record_pre_action 05:48:27 INFO - Running main action method: read_buildbot_config 05:48:27 INFO - Using buildbot properties: 05:48:27 INFO - { 05:48:27 INFO - "project": "", 05:48:27 INFO - "product": "firefox", 05:48:27 INFO - "script_repo_revision": "production", 05:48:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:48:27 INFO - "repository": "", 05:48:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:48:27 INFO - "buildid": "20160419230832", 05:48:27 INFO - "pgo_build": "False", 05:48:27 INFO - "basedir": "/builds/slave/test", 05:48:27 INFO - "buildnumber": 713, 05:48:27 INFO - "slavename": "t-yosemite-r7-0117", 05:48:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:48:27 INFO - "platform": "yosemite_r7", 05:48:27 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:48:27 INFO - "branch": "fx-team", 05:48:27 INFO - "repo_path": "integration/fx-team", 05:48:27 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 05:48:27 INFO - "stage_platform": "macosx64", 05:48:27 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 05:48:27 INFO - "slavebuilddir": "test" 05:48:27 INFO - } 05:48:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:48:27 INFO - Running post-action listener: _resource_record_post_action 05:48:27 INFO - ##### 05:48:27 INFO - ##### Running download-and-extract step. 05:48:27 INFO - ##### 05:48:27 INFO - Running pre-action listener: _resource_record_pre_action 05:48:27 INFO - Running main action method: download_and_extract 05:48:27 INFO - mkdir: /builds/slave/test/build/tests 05:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:27 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:48:29 INFO - Downloaded 1199 bytes. 05:48:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:29 INFO - Using the following test package requirements: 05:48:29 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:48:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:48:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:48:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'jsshell-mac.zip'], 05:48:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:48:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:48:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:48:29 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:48:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:48:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:48:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:48:29 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')]} 05:48:29 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:48:30 INFO - Downloaded 18095480 bytes. 05:48:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:48:33 INFO - Return code: 0 05:48:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:48: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')]} 05:48:33 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:48:35 INFO - Downloaded 18095480 bytes. 05:48:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:48:38 INFO - Return code: 0 05:48:38 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')]} 05:48:38 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:48:39 INFO - Downloaded 10845952 bytes. 05:48:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:48:40 INFO - Return code: 0 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:40 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:48:43 INFO - Downloaded 110044454 bytes. 05:48:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:43 INFO - mkdir: /builds/slave/test/properties 05:48:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:43 INFO - Contents: 05:48:43 INFO - build_url:https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:44 INFO - Running post-action listener: _resource_record_post_action 05:48:44 INFO - Running post-action listener: set_extra_try_arguments 05:48:44 INFO - ##### 05:48:44 INFO - ##### Running populate-webroot step. 05:48:44 INFO - ##### 05:48:44 INFO - Running pre-action listener: _resource_record_pre_action 05:48:44 INFO - Running main action method: populate_webroot 05:48:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:44 INFO - '--tppagecycles', 05:48:44 INFO - '7'], 05:48:44 INFO - 'tests': ['tsvgm']}}, 05:48:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['damp', 'tps']}, 05:48:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'tests': ['damp', 'tps']}, 05:48:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['dromaeo_dom']}, 05:48:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['a11yr', 05:48:44 INFO - 'ts_paint', 05:48:44 INFO - 'tpaint', 05:48:44 INFO - 'sessionrestore', 05:48:44 INFO - 'sessionrestore_no_auto_restore', 05:48:44 INFO - 'tabpaint']}, 05:48:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['tsvgx', 05:48:44 INFO - 'tsvgr_opacity', 05:48:44 INFO - 'tart', 05:48:44 INFO - 'tscrollx', 05:48:44 INFO - 'cart']}, 05:48:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:44 INFO - 'tsvgr_opacity', 05:48:44 INFO - 'tart', 05:48:44 INFO - 'tscrollx', 05:48:44 INFO - 'cart']}, 05:48:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'talos_options': ['--disable-e10s'], 05:48:44 INFO - 'tests': ['tp5o']}, 05:48:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'tests': ['tp5o']}, 05:48:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'talos_options': ['--disable-e10s', 05:48:44 INFO - '--xperf_path', 05:48:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:44 INFO - 'tests': ['tp5n']}, 05:48:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:44 INFO - 'talos_options': ['--xperf_path', 05:48:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:44 INFO - 'tests': ['tp5n']}}, 05:48:44 INFO - 'talos.zip': {'path': '', 05:48:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:44 INFO - Running post-action listener: _resource_record_post_action 05:48:44 INFO - ##### 05:48:44 INFO - ##### Running create-virtualenv step. 05:48:44 INFO - ##### 05:48:44 INFO - Running pre-action listener: _resource_record_pre_action 05:48:44 INFO - Running main action method: create_virtualenv 05:48:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:44 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 05:48:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:45 INFO - Using real prefix '/tools/python27' 05:48:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:48 INFO - Installing pip.................done. 05:48:48 INFO - Return code: 0 05:48:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:48 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')]} 05:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:48 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')]} 05:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:48 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:48:48 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 05:48:48 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 05:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:48 INFO - 'HOME': '/Users/cltbld', 05:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:48 INFO - 'LOGNAME': 'cltbld', 05:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:48 INFO - 'MOZ_NO_REMOTE': '1', 05:48:48 INFO - 'NO_EM_RESTART': '1', 05:48:48 INFO - 'PAGER': '/bin/cat', 05:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:48 INFO - 'PWD': '/builds/slave/test', 05:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:48 INFO - 'SHELL': '/bin/bash', 05:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:48:48 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:48 INFO - 'USER': 'cltbld', 05:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:48 INFO - 'XPC_FLAGS': '0x0', 05:48:48 INFO - 'XPC_SERVICE_NAME': '0', 05:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:49 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 05:48:49 INFO - Cleaning up... 05:48:49 INFO - Return code: 0 05:48:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:49 INFO - 'HOME': '/Users/cltbld', 05:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:49 INFO - 'LOGNAME': 'cltbld', 05:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:49 INFO - 'MOZ_NO_REMOTE': '1', 05:48:49 INFO - 'NO_EM_RESTART': '1', 05:48:49 INFO - 'PAGER': '/bin/cat', 05:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:49 INFO - 'PWD': '/builds/slave/test', 05:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:49 INFO - 'SHELL': '/bin/bash', 05:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:48:49 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:49 INFO - 'USER': 'cltbld', 05:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:49 INFO - 'XPC_FLAGS': '0x0', 05:48:49 INFO - 'XPC_SERVICE_NAME': '0', 05:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:49 INFO - Downloading/unpacking psutil>=0.7.1 05:48:49 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 05:48:49 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 05:48:49 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 05:48:49 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 05:48:49 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 05:48:49 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 05:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:52 INFO - Installing collected packages: psutil 05:48:52 INFO - Running setup.py install for psutil 05:48:52 INFO - building 'psutil._psutil_osx' extension 05:48:52 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 05:48:53 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 05:48:53 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 05:48:53 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 05:48:53 INFO - building 'psutil._psutil_posix' extension 05:48:53 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 05:48:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:48:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:48:53 INFO - ^ 05:48:53 INFO - 1 warning generated. 05:48:53 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 05:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:53 INFO - Successfully installed psutil 05:48:53 INFO - Cleaning up... 05:48:53 INFO - Return code: 0 05:48:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:48:53 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')]} 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 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')]} 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:48:53 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 05:48:53 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 05:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:53 INFO - 'HOME': '/Users/cltbld', 05:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:53 INFO - 'LOGNAME': 'cltbld', 05:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:53 INFO - 'MOZ_NO_REMOTE': '1', 05:48:53 INFO - 'NO_EM_RESTART': '1', 05:48:53 INFO - 'PAGER': '/bin/cat', 05:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:53 INFO - 'PWD': '/builds/slave/test', 05:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:53 INFO - 'SHELL': '/bin/bash', 05:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:48:53 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:53 INFO - 'USER': 'cltbld', 05:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:53 INFO - 'XPC_FLAGS': '0x0', 05:48:53 INFO - 'XPC_SERVICE_NAME': '0', 05:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:48:56 INFO - Installing collected packages: mozsystemmonitor 05:48:56 INFO - Running setup.py install for mozsystemmonitor 05:48:56 INFO - Successfully installed mozsystemmonitor 05:48:56 INFO - Cleaning up... 05:48:56 INFO - Return code: 0 05:48:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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', '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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48: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 blobuploader==1.2.4 05:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:56 INFO - 'HOME': '/Users/cltbld', 05:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:56 INFO - 'LOGNAME': 'cltbld', 05:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:56 INFO - 'MOZ_NO_REMOTE': '1', 05:48:56 INFO - 'NO_EM_RESTART': '1', 05:48:56 INFO - 'PAGER': '/bin/cat', 05:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:56 INFO - 'PWD': '/builds/slave/test', 05:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:56 INFO - 'SHELL': '/bin/bash', 05:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:48:56 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:56 INFO - 'USER': 'cltbld', 05:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:56 INFO - 'XPC_FLAGS': '0x0', 05:48:56 INFO - 'XPC_SERVICE_NAME': '0', 05:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:49:00 INFO - Downloading docopt-0.6.1.tar.gz 05:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:00 INFO - Running setup.py install for blobuploader 05:49:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:00 INFO - Running setup.py install for requests 05:49:01 INFO - Running setup.py install for docopt 05:49:01 INFO - Successfully installed blobuploader requests docopt 05:49:01 INFO - Cleaning up... 05:49:01 INFO - Return code: 0 05:49:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:01 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')]} 05:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:01 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')]} 05:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:01 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:49:01 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 05:49:01 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 05:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:01 INFO - 'HOME': '/Users/cltbld', 05:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:01 INFO - 'LOGNAME': 'cltbld', 05:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:01 INFO - 'MOZ_NO_REMOTE': '1', 05:49:01 INFO - 'NO_EM_RESTART': '1', 05:49:01 INFO - 'PAGER': '/bin/cat', 05:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:01 INFO - 'PWD': '/builds/slave/test', 05:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:01 INFO - 'SHELL': '/bin/bash', 05:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:01 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:01 INFO - 'USER': 'cltbld', 05:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:01 INFO - 'XPC_FLAGS': '0x0', 05:49:01 INFO - 'XPC_SERVICE_NAME': '0', 05:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:01 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-g5ha2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:01 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-8EIupn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:01 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-vxc74w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:01 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-1CEHFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:01 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-O9IPOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-MwlM9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-6mfmZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-0dT6tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Fz2ZlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-sWLtTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-SgvEh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-NZFdv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Is1Ws0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:02 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-0wkyn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:03 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-2DKJON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:03 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-urjfHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:03 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-8mLKue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:03 INFO - Running setup.py install for manifestparser 05:49:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:03 INFO - Running setup.py install for mozcrash 05:49:03 INFO - Running setup.py install for mozdebug 05:49:03 INFO - Running setup.py install for mozdevice 05:49:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:03 INFO - Running setup.py install for mozfile 05:49:04 INFO - Running setup.py install for mozhttpd 05:49:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Running setup.py install for mozinfo 05:49:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Running setup.py install for mozInstall 05:49:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Running setup.py install for mozleak 05:49:04 INFO - Running setup.py install for mozlog 05:49:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Running setup.py install for moznetwork 05:49:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:04 INFO - Running setup.py install for mozprocess 05:49:05 INFO - Running setup.py install for mozprofile 05:49:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Running setup.py install for mozrunner 05:49:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Running setup.py install for mozscreenshot 05:49:05 INFO - Running setup.py install for moztest 05:49:05 INFO - Running setup.py install for mozversion 05:49:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:05 INFO - Cleaning up... 05:49:05 INFO - Return code: 0 05:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:05 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')]} 05:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:05 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')]} 05:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:05 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:49:05 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 05:49:05 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 05:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:05 INFO - 'HOME': '/Users/cltbld', 05:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:05 INFO - 'LOGNAME': 'cltbld', 05:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:05 INFO - 'MOZ_NO_REMOTE': '1', 05:49:05 INFO - 'NO_EM_RESTART': '1', 05:49:05 INFO - 'PAGER': '/bin/cat', 05:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:05 INFO - 'PWD': '/builds/slave/test', 05:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:05 INFO - 'SHELL': '/bin/bash', 05:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:05 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:05 INFO - 'USER': 'cltbld', 05:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:05 INFO - 'XPC_FLAGS': '0x0', 05:49:05 INFO - 'XPC_SERVICE_NAME': '0', 05:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-bKzcOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-saqPx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-zq5v7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Q4Mf7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-tpxW4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-IefK_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-j58EWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Qgaj5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:06 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)) 05:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:06 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Z6olYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-CHPo1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-rQIhHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9zNpLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-egrx9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-BgEaVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-tvzlLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-2T5piv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:07 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)) 05:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:07 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-u0ZXEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:07 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)) 05:49:07 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)) 05:49:07 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)) 05:49:07 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)) 05:49:07 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)) 05:49:07 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)) 05:49:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:07 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 05:49:07 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 05:49:07 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 05:49:07 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 05:49:07 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 05:49:07 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 05:49:10 INFO - Downloading blessings-1.6.tar.gz 05:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:10 INFO - Installing collected packages: blessings 05:49:10 INFO - Running setup.py install for blessings 05:49:10 INFO - Successfully installed blessings 05:49:10 INFO - Cleaning up... 05:49:10 INFO - Return code: 0 05:49:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:10 INFO - Reading from file tmpfile_stdout 05:49:10 INFO - Current package versions: 05:49:10 INFO - blessings == 1.6 05:49:10 INFO - blobuploader == 1.2.4 05:49:10 INFO - docopt == 0.6.1 05:49:10 INFO - manifestparser == 1.1 05:49:10 INFO - mozInstall == 1.12 05:49:10 INFO - mozcrash == 0.17 05:49:10 INFO - mozdebug == 0.1 05:49:10 INFO - mozdevice == 0.48 05:49:10 INFO - mozfile == 1.2 05:49:10 INFO - mozhttpd == 0.7 05:49:10 INFO - mozinfo == 0.9 05:49:10 INFO - mozleak == 0.1 05:49:10 INFO - mozlog == 3.1 05:49:10 INFO - moznetwork == 0.27 05:49:10 INFO - mozprocess == 0.22 05:49:10 INFO - mozprofile == 0.28 05:49:10 INFO - mozrunner == 6.11 05:49:10 INFO - mozscreenshot == 0.1 05:49:10 INFO - mozsystemmonitor == 0.0 05:49:10 INFO - moztest == 0.7 05:49:10 INFO - mozversion == 1.4 05:49:10 INFO - psutil == 3.1.1 05:49:10 INFO - requests == 1.2.3 05:49:10 INFO - wsgiref == 0.1.2 05:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:49:10 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 05:49:10 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 05:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:10 INFO - 'HOME': '/Users/cltbld', 05:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:10 INFO - 'LOGNAME': 'cltbld', 05:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:10 INFO - 'MOZ_NO_REMOTE': '1', 05:49:10 INFO - 'NO_EM_RESTART': '1', 05:49:10 INFO - 'PAGER': '/bin/cat', 05:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:10 INFO - 'PWD': '/builds/slave/test', 05:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:10 INFO - 'SHELL': '/bin/bash', 05:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:10 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:10 INFO - 'USER': 'cltbld', 05:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:10 INFO - 'XPC_FLAGS': '0x0', 05:49:10 INFO - 'XPC_SERVICE_NAME': '0', 05:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 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)) 05:49:11 INFO - Cleaning up... 05:49:11 INFO - Return code: 0 05:49:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:11 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:49:11 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 05:49:11 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 05:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:11 INFO - 'HOME': '/Users/cltbld', 05:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:11 INFO - 'LOGNAME': 'cltbld', 05:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:11 INFO - 'MOZ_NO_REMOTE': '1', 05:49:11 INFO - 'NO_EM_RESTART': '1', 05:49:11 INFO - 'PAGER': '/bin/cat', 05:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:11 INFO - 'PWD': '/builds/slave/test', 05:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:11 INFO - 'SHELL': '/bin/bash', 05:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:11 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:11 INFO - 'USER': 'cltbld', 05:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:11 INFO - 'XPC_FLAGS': '0x0', 05:49:11 INFO - 'XPC_SERVICE_NAME': '0', 05:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:11 INFO - Downloading/unpacking jsonschema 05:49:11 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 05:49:11 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 05:49:11 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 05:49:11 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 05:49:11 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 05:49:11 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 05:49:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49:13 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 05:49:13 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 05:49:13 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 05:49:13 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 05:49:13 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 05:49:13 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 05:49:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:14 INFO - warning: no files found matching '*.txt' 05:49:14 INFO - no previously-included directories found matching 'build' 05:49:14 INFO - no previously-included directories found matching 'dist' 05:49:14 INFO - no previously-included directories found matching '.git*' 05:49:14 INFO - Installing collected packages: jsonschema, functools32 05:49:14 INFO - Running setup.py install for functools32 05:49:14 INFO - warning: no files found matching '*.txt' 05:49:14 INFO - no previously-included directories found matching 'build' 05:49:14 INFO - no previously-included directories found matching 'dist' 05:49:14 INFO - no previously-included directories found matching '.git*' 05:49:14 INFO - Successfully installed jsonschema functools32 05:49:14 INFO - Cleaning up... 05:49:14 INFO - Return code: 0 05:49:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:14 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')]} 05:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:14 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')]} 05:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:14 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 0x10a24ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1aad31720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, '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.O93nYLLRhv/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.bKvckbJNJE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 05:49:14 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 05:49:14 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 05:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:14 INFO - 'HOME': '/Users/cltbld', 05:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:14 INFO - 'LOGNAME': 'cltbld', 05:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:14 INFO - 'MOZ_NO_REMOTE': '1', 05:49:14 INFO - 'NO_EM_RESTART': '1', 05:49:14 INFO - 'PAGER': '/bin/cat', 05:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:14 INFO - 'PWD': '/builds/slave/test', 05:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:14 INFO - 'SHELL': '/bin/bash', 05:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:14 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:14 INFO - 'USER': 'cltbld', 05:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:14 INFO - 'XPC_FLAGS': '0x0', 05:49:14 INFO - 'XPC_SERVICE_NAME': '0', 05:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:14 INFO - Downloading/unpacking flake8 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:18 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 05:49:18 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 05:49:18 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 05:49:18 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 05:49:18 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 05:49:18 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 05:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:18 INFO - no previously-included directories found matching 'docs/_build' 05:49:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:18 INFO - Running setup.py install for pep8 05:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:18 INFO - no previously-included directories found matching 'docs/_build' 05:49:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:18 INFO - Cleaning up... 05:49:18 INFO - Return code: 0 05:49:18 INFO - Running post-action listener: _resource_record_post_action 05:49:18 INFO - Running post-action listener: _start_resource_monitoring 05:49:18 INFO - Starting resource monitoring. 05:49:18 INFO - ##### 05:49:18 INFO - ##### Running install step. 05:49:18 INFO - ##### 05:49:18 INFO - Running pre-action listener: _resource_record_pre_action 05:49:18 INFO - Running main action method: install 05:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:19 INFO - Reading from file tmpfile_stdout 05:49:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:19 INFO - Reading from file tmpfile_stdout 05:49:19 INFO - Output received: 05:49:19 INFO - Usage: mozinstall [options] installer 05:49:19 INFO - Options: 05:49:19 INFO - -h, --help show this help message and exit 05:49:19 INFO - -d DEST, --destination=DEST 05:49:19 INFO - Directory to install application into. [default: 05:49:19 INFO - "/builds/slave/test"] 05:49:19 INFO - --app=APP Application being installed. [default: firefox] 05:49:19 INFO - mkdir: /builds/slave/test/build/application 05:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:49:52 INFO - Reading from file tmpfile_stdout 05:49:52 INFO - Output received: 05:49:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:49:52 INFO - Running post-action listener: _resource_record_post_action 05:49:52 INFO - ##### 05:49:52 INFO - ##### Running run-tests step. 05:49:52 INFO - ##### 05:49:52 INFO - Running pre-action listener: _resource_record_pre_action 05:49:52 INFO - Running main action method: run_tests 05:49:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:49:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:49:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:49:52 INFO - 2016-04-22 05:49:52.464 screenresolution[1640:7482] starting screenresolution argv=screenresolution get 05:49:52 INFO - 2016-04-22 05:49:52.467 screenresolution[1640:7482] Display 0: 1600x1200x32@60 05:49:52 INFO - 2016-04-22 05:49:52.473 screenresolution[1641:7484] starting screenresolution argv=screenresolution list 05:49:52 INFO - Available Modes on Display 0 05:49:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:49:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:49:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:49:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:49:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:49:52 INFO - Intel Iris: 05:49:52 INFO - Chipset Model: Intel Iris 05:49:52 INFO - Type: GPU 05:49:52 INFO - Bus: Built-In 05:49:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:49:52 INFO - Vendor: Intel (0x8086) 05:49:52 INFO - Device ID: 0x0a2e 05:49:52 INFO - Revision ID: 0x0009 05:49:52 INFO - Displays: 05:49:52 INFO - Display: 05:49:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:49:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:49:52 INFO - Display Serial Number: 1600x1200 60 05:49:52 INFO - Main Display: Yes 05:49:52 INFO - Mirror: Off 05:49:52 INFO - Online: Yes 05:49:52 INFO - Rotation: Supported 05:49:52 INFO - Return code: 0 05:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:52 INFO - Python 2.7.3 05:49:52 INFO - Return code: 0 05:49:52 INFO - grabbing minidump binary from tooltool 05:49:52 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')]} 05:49:52 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 0x10a0ede00>, '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 0x109f56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:52 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 05:49:52 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 05:49:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:52 INFO - Return code: 0 05:49:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:49:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:49:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:49:53 INFO - Return code: 0 05:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 05:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 05:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O93nYLLRhv/Render', 05:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:54 INFO - 'HOME': '/Users/cltbld', 05:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:54 INFO - 'LOGNAME': 'cltbld', 05:49:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:54 INFO - 'MOZ_NO_REMOTE': '1', 05:49:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:54 INFO - 'NO_EM_RESTART': '1', 05:49:54 INFO - 'PAGER': '/bin/cat', 05:49:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:54 INFO - 'PWD': '/builds/slave/test', 05:49:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:54 INFO - 'SHELL': '/bin/bash', 05:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bKvckbJNJE/Listeners', 05:49:54 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 05:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:54 INFO - 'USER': 'cltbld', 05:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:54 INFO - 'XPC_FLAGS': '0x0', 05:49:54 INFO - 'XPC_SERVICE_NAME': '0', 05:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 05:49:54 INFO - mozversion application_buildid: 20160419230832 05:49:54 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 05:49:54 INFO - mozversion application_display_name: Nightly 05:49:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:54 INFO - mozversion application_name: Firefox 05:49:54 INFO - mozversion application_remotingname: firefox 05:49:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:49:54 INFO - mozversion application_vendor: Mozilla 05:49:54 INFO - mozversion application_version: 48.0a1 05:49:54 INFO - mozversion platform_buildid: 20160419230832 05:49:54 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 05:49:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:49:54 INFO - mozversion platform_version: 48.0a1 05:49:54 INFO - using testdate: 1461329394 05:49:54 INFO - actual date: 1461329394 05:49:54 INFO - starting webserver on 'localhost:49276' 05:49:54 INFO - SUITE-START | Running 2 tests 05:49:54 INFO - TEST-START | dromaeo_css 05:49:54 INFO - operating with platform_type : mac_ 05:49:54 INFO - Initialising browser for dromaeo_css test... 05:49:54 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpv8EFv0/profile http://localhost:49276/getInfo.html) 05:49:57 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 05:49:57 INFO - PROCESS | 1659 | colorDepth:24 05:49:57 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 05:49:57 INFO - PROCESS | 1659 | __metrics 05:49:57 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:49:57 INFO - TEST-INFO | 1659: exit 0 05:49:57 INFO - Browser initialized. 05:49:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:57 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpv8EFv0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:09 INFO - PROCESS | 1662 | RSS: Main: 248037376 05:50:09 INFO - PROCESS | 1662 | 05:50:59 INFO - PROCESS | 1662 | 1461329459510 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] 05:53:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 05:53:12 INFO - PROCESS | 1662 | RSS: Main: 259563520 05:53:12 INFO - PROCESS | 1662 | 05:56:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:56:15 INFO - PROCESS | 1662 | RSS: Main: 271712256 05:56:15 INFO - PROCESS | 1662 | 05:59:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:59:17 INFO - PROCESS | 1662 | RSS: Main: 273821696 05:59:17 INFO - PROCESS | 1662 | 06:02:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:02:20 INFO - PROCESS | 1662 | RSS: Main: 275357696 06:02:20 INFO - PROCESS | 1662 | 06:05:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 06:05:23 INFO - PROCESS | 1662 | RSS: Main: 278175744 06:05:23 INFO - PROCESS | 1662 | 06:08:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 06:08:26 INFO - PROCESS | 1662 | RSS: Main: 279445504 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | __start_tp_report 06:08:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:08:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:08:26 INFO - PROCESS | 1662 | |i|pagename|runs| 06:08:26 INFO - PROCESS | 1662 | |0;dojo.html;3459.6886280234776;3471.0628130404793;3505.544279243698;3510.210202704392;3542.752007359483;5787.508061814746;5798.391168927265;5810.56420768443;5815.360310365856;5817.040188368919;5689.345725241598;5757.68332741699;5871.412858714127;5874.530037596993;5880.353161152269;5175.637705360636;5242.239875218091;5260.92108618371;5269.288646032794;5298.867528311785;5196.116660167761;5337.571405010711;5345.652532585389;5366.517013468787;5392.056390131711;5140.408852981917;5140.871478213037;5237.86905327368;5238.423773384925;5261.289725886994;4343.67422443318;5189.40321862983;5220.843374698765;5239.869003274911;5257.868553286198;5219.138842091088;5222.50386213313;5241;5244.449332820075;5251.396089449724;4700.553447422523;4813.133635945564;5584.357798853102;5658.207850900836;5705.6291341063115;5135.35808023997;6137.877242455171;6164.7534098636;6195.0707393890825;6195.845103872394;6096.163860440878;6231.345708700612;6243.812685619393;6245.219347581552;6248.718807653667;5193.896122077537;5830.446107619811;5889.646621202742;5980.970095149496;5982.222311099529;6278.937210627835;6301.779437719658;6310.558260921784;6318.052292156213;6324.620522768557;5150.098732721834;6060.606060606046;6242.313345531988;6246.500279977591;6247.75008999644;6116.78591249313;6127.158986117706;6234.625922444668;6238.719257633417;6249.0626406039455;6139.492138333291;6203.193584834033;6218.31598524162;6223.875522489616;6240.31356550779;6103.761967187076;6132.141360525245;6162.26052873658;6187.071939209065;6245.344238854855;4949.975250123798;4962.727050012212;4967.7019378837385;4970.801167953241;5005.849824505271;4406.184855801687;4418.226810308183;4434.312681534368;4442.733435993786;4508.81964721414;5054.519820617035;5729.312482502127;5813.360530341659;5878.353381128072;5934.762609495659;6211.223597050369;6212.751489940351;6213.130161777355;6231.813045608639;6246.3753624637175;5168.664036837668;5814.738336774855;5837.737301821428;5838.766449342063;5878.882422351529;5335.226392173113;5408.702521361284;5450.672959622435;5476;5504.614676972574;6265.843353916006;6337.271213810379;6341.143945567289;6356.523260755462;6366.808995730135;6224.439800417984;6224.533160012927;6230.252369715663;6236.688165591611;6247.375262473716;6232;6342.4291813735135;6404.263509696259;6415.133956915756;6467.611943283418;6165.260168779596;6186.690665466619;6186.969065154645;6224.346443623535;6232.906506402498;6144.910730351702;6224.221972253468;6230.7819226326865;6235.688215589112;6249.375062493714;4691.272852707836;4857.975710121426;6008.939910600838;6054.636721796706;6094.055421409688;4986.501349864984;5003.299538064746;5067.467915868928;6165.260168779596;6188.783392581238;5909.261342332208;5916.526677865846;5940.198073260228;6016.819495415145;6020.969895150496;6036.758529658764;6055.939440605714;6088.5737998341465;6106.908396374147;6111.84720381994;6066.757329706762;6079.908801367895;6086.878262434638;6110.572259941761;6134.846628834136 06:08:26 INFO - PROCESS | 1662 | |1;ext.html;519.6466402846064;570.9942900570993;574.6322353693637;578.952096704964;595.9165716799646;32557.511637325428;36906.8154659227;36917.81541092294;36936.44595331072;36951;39230.823075307715;39661.206775864535;39807.800960995155;39819.601803981954;39824.40263396051;9285.628574857015;9475.147236748691;9508.191803696694;9541.236701063934;9568.80862382752;9404;9484.857727134098;9498.240140788756;9570.856437153414;9583.233341332676;9460.526973651324;9487.430754154739;9501.904980950205;9536.475493847836;9571.952140239324;9455.858162127573;9524.095210954949;9552.188064014566;9552.95223523878;9557.856632150488;9352.345335826494;9490.383125096847;9507.334486585942;9531.237500999972;9541.618335266581;36660.63339366599;37125.25749485022;37163.81418092919;37164.81417592922;37359.4396084059;2775.5836624506283;3132.592762940826;3206.118317462693;3254.8209848458328;3408.2277215847867;26760.73239267602;26871.32821679454;27061.86469067662;27582.724172758215;27603.447931041268;2698.7975901807445;2723.019712903353;2738.835669859815;2805.4529366773486;2858.056841242385;315670;359601.201993991;363785;365622;365769;55628.60928476739;55876;55932.72033639806;56037.7198114015;56208.71895640578;63167.05249421262;65344.673276633315;66476.33523664798;66972.33027669661;67154;16551.25519351632;16589.087600181865;16699.74950375745;16756.664866702842;16815.159242037847;12848.743025139445;12929.806052909214;12936.611901642966;12951.352432378344;12967.546135885199;17194.914025430044;17886.016269105065;19014.61970760577;19505.122269497908;19573.804261957484;6969.47728920333;6992.79021629352;8330.62512186953;8388.916110838936;8409.747707568782;800;901.8286525560122;912.2291663544295;959.8176346494143;1016.9169834126632;24376.587277781124;28952.420951581273;29146;29517.852410737807;29966.101016969526;897.5512243878061;1147.3402793393832;1172.191188080222;1190.4047976011993;1211.2611307102661;15022.699546009018;15115.924420378047;15264.771028434361;15536.766948495782;15569.766453503207;679229;723187;731392;736242;742494;57617.711911441016;58561;59283.703581481815;59383.406165937784;59477.107843382386;1502.7520459124123;1533.8696210821981;1537.177609978656;1549.8527639874194;1550.837162097986;29019.85490072536;29186.832526698694;29999.55000674948;30145.397092058476;30806.691933081278;39573.60426395814;52049.739751301;53019;53090.46909530855;53159.73420132875;479242.6037869788;483496;486195;574596;575897;41143.7942810284;41718;41798.16403671849;42259;42326.730198094105;44691.882702932686;44880.77559612181;44910.3263451055;45530.86172845705;46159.53840461552;35754.28491430209;37215.464530869525;37754.24491510099;38006;38086.42870356891;35851.641483585874;36877.63122368849;37139.44290835586;37437;37466.81266593649;36543.81728091343;37359;37445.25109497849;37737.245255095295;38141.80929095448;28986.985455508955;31499.685003149676;31936.36127277488;32415.189620258738;32486.512702309956;24040.63939040951;24040.63939040951;24184.395390115387;24482.387940300923;24671 06:08:26 INFO - PROCESS | 1662 | |2;jquery.html;390.9276783794998;392.37612196607404;398.57750784168775;398.6969902873819;403.6447925825273;11662.591809286676;19646.508837279056;20186.091625876834;20214.686045407037;20487;18654.81345186551;19643.60712785747;20320.983950802474;20506.87212203328;20538.794612053876;5097.770600322976;5415.783368665268;5537.8061767838135;5778.219940308068;5837.970810145944;5609.35492418373;5762.481376676098;5780.161876527901;6659.8335041624105;6674.2658307586125;6589.110470086549;6592.736290548396;6613.6693165341785;6619.503537234703;6621.867562648744;5977.163197152402;6061.969690151565;6083.878322433527;6135.938640613604;6274.686265686721;4902.90194196114;5707.828765137053;5783.71081445926;5842.532597392198;5998.410421238375;12532.686682833002;12748.2988435636;12752.6811829705;12767.233965962072;13189.538366157234;2025.6758918573105;2120.8197303229244;2213.210938312313;2386.3198988288427;2578.303857958341;8920.910790892138;9540;9588.616455341778;10862.837057444145;14150.929245353811;1576.8107827060826;1630.5434478346083;1668.9916550417292;1694.7034269002997;1711.6576684663116;109659;117398;117882;118464.40767796192;124066;11017.83473247902;11346.149038822121;11527.365994870195;11579.88420115805;11728.179027467995;12912.741745165044;13246.139000964906;14542.636434089021;14548.199849008406;14579.198144102176;6346.413396650837;6486.837829054217;7862.012435274673;8536.530490823065;8575.785605359792;8413.495190288602;8425;8433.156684331641;8443.915560844436;8530.573471326408;4420.381146639473;4515.367848501212;4528.935700110472;4548.5906268436;4591.334256532784;1567.9921600391924;1717.7423386492126;1900.5438694713168;1929.98070019298;2011.5675129847152;937.5406051034944;941.802221533472;981.5141504954951;1010.5952725711268;1032.1742605915238;17202.569935751708;17984.550386240186;19446.513837154183;19587.706184407245;19645;965.2278177458005;981.3326937682444;985.2315194148575;1020.1175982774995;1046.3042077018697;7788.376929845599;9749.707508774749;9946.35348702332;10161.983801619926;10252.38485690861;531516;564469;568380.2133850673;577022;580396.0980195072;74130.629346854;74360;99446.5027674857;127358;130926;967.3905439573165;990.9157721593601;1006.3961623026125;1011.7420057885192;1014.1987829614669;16995.49013529596;17011.574710632332;17533.123343833013;18592.907035464737;18717;40379.394309085976;48694.75652621714;48731.75634121807;51656.483435165166;52984.94030119453;65850.67074664596;65916;66203;66397;66524;5344.388392188264;7044.555866047345;7299.781006569811;7958.124606293419;8157.673693052211;6925.203601585882;10555.050045495942;10698.555694981389;10947;11050.502727377127;10635.94682026585;10786.083182929538;10793.974572415607;10850.837237441287;10852.18608604342;10157.695269141937;10526.052655260757;10638.41488718128;10674.57301707923;10798.298110622783;9039.412438191497;10524.684259471922;11036.558537658404;11219.495122719334;11243.10055195566;7811.531308121531;7960.800979975547;7965.522068675898;8008.6396112173925;8194.467359621605;10519.316244444086;10691.839622405514;10733.19501037441;10760.946195268974;10899.073578745896 06:08:26 INFO - PROCESS | 1662 | |3;mootools.html;1597.9360825566973;1633.003867640739;1862.8789128706633;1932.729417881496;1940.1075505267577;7842.451028428012;7980.9201907980905;8172.795680108;8245.340372770179;8502.829943401128;8568.571571421435;8589.828203435927;8680.08859069798;8685.348598855095;8691;2421.0557882425824;2449.8285120041605;2449.9877500612474;2456.1771806444863;2461.126300163443;2385.974031166598;2395.6286775549816;2411.204302580153;2428.101602407112;2431.623098419739;2390.784829365357;2403.975960240393;2421.5278020785954;2452.2030340139436;2467.703875534938;2392.342105920868;2405.1461731085474;2415.335782659765;2424.806015518763;2448.2532827487607;2393.3179043972386;2416.154345978911;2420.8426452280546;2424.830261881669;2430.1373012580457;8749.343799215085;8755.3871229014;8801.075887031897;8846.823063538694;8856.424332418372;5158.613104017176;5323.707196104213;5381.461853814626;5390.1914712793005;5395.433479484637;3526.365254254233;3585.4980302757635;3590.461430785403;3643.6720695137565;3645.781253124821;939.9389039712397;962.4898803634085;994.1500017485018;1024.948752562369;1046.837740150278;11379.146564007733;11454.140939429577;11462.484188211467;11463.828042579367;11476.1392895534;4237.385579091015;4373.518912919576;4686.390769199982;4761.642876784255;4816.470188279286;9902.257330700226;9904.306698531034;9917;9922.851157232648;9949.751256218653;5324.92012619811;5336.4129945705945;5368.194770784336;5370.2750128732905;5378.031954248273;4169.687273454503;4720.669553131248;4859.878503037452;4863.221884498464;4865.391826021747;3991.4212439196153;4015.3976903464713;4077.571854955246;4112.670986321147;4146.79742874563;1346.8720471555382;1354.7425989062046;1356.907689310095;1360.9727805443836;1373.8145350377772;713.653877869233;808.2160304504621;880.8854848869734;919.7654598077447;943.2642538819731;5560.833175004756;5873.823785286449;5940.227770389822;5995.2206213192;6026.126211699279;947.1428357336621;968.6028728221395;975.7853272280087;979.7207795778169;984.6947446291673;3757.2109856929806;3873;3884.8446062157764;3913.1391093959282;3940.8817735467983;8975.955120224357;10292.228082893664;10809.891901081046;10817;10828.917108289266;10251.948740256252;10713.410762408143;10762.3542587445;10762.97751713586;10845.945770271099;6916.688749006206;7990.081140668781;8090.959545202354;8167.264946154874;8208.138145494757;5537.418571049981;5562.888742225214;5657.32112146545;5768.682722450306;5789.478946894799;9764.925858155455;9817.607295708378;9978.800423991624;10041.246906481896;10085.243606729378;9771.511424428609;10022.3485473444;10070;10182.134518566005;10254.230932680228;6404.103425520524;6734.326567343226;6897.310268973062;6989.8951515726285;7042.908349205882;8077.959610201911;8137.104918458846;8172.591370431336;8258.174182581693;8278;7153.6423178839805;7266.854662906818;7295.161056478573;7415.221401752954;7437.181909990005;6784.728610855511;7147.178074521288;7219.241979592067;7226.060612120601;7266.927330726837;6790.42281406086;6844.726210951506;6866.141732283465;6889.517733758589;6897.034415181979;4729.763511824463;4760.880977975578;4764.714117152982;4838.927416088691;4976.402831660224;4428.512863585068;4624.537546245483;4800.159972004815;4846.660733748604;5037.294778731054 06:08:26 INFO - PROCESS | 1662 | |4;prototype.html;316.34516550739966;321.7313543191435;325.396389697112;330.29152467956226;332.41826803094585;5621.594601349662;6194.473469755077;6203.751849926003;6251.7499300028;6333.841653958653;6207.068939659053;6222.408871157233;6224.28420731616;6227.5017998560115;6251.906221406671;4340.43574335336;4488.842890498833;4594.379758732562;4610.308453731934;4642.396488456496;4132.8966775830695;4496.460424749019;4626.676132670715;4634.1195172917205;4665.323528088442;4200.264953633117;4268.487781466229;4584.908301833962;4605.608523275526;4615.953840461586;4053.9257096869205;4221.662267018646;4268.530461649216;4554.726716396994;4557.997240607061;3071.5853359796365;3106.549550315214;3785.4511095891216;3896.3181443247317;3919.176972835708;4780.282957556359;5123.513266239701;5829.533637309048;5970.820875373745;5999.430054144849;4860.902781944341;5168;5460.099083651193;5473.67157970523;5476.534494567966;4894.583960363373;6437.420632143129;6562.540622156451;6718.764843230463;6747.966260168717;4386.210482113218;4510.751908645023;4514.232580461329;4533.750643714594;4544.477385100723;5861.736221870026;6924.7576334828545;7006.579605223703;7027.754028609025;7039.8592028159665;3855.7300988931065;4547.727136371828;4552.291386624953;4569.405977222939;4572.8399506017795;4451.710638808532;4664.160451118832;4669.0195059037305;4676.625869930397;4679.344891715163;4532.388127602798;4970.527799859007;5374.623776335698;5399.082156033483;5448.809291674773;5087.796488140507;5574.693391863487;6633.9668301658185;6734.393904548516;6735.090762747064;1508.4192585854526;1599.448190374319;1613.6611311624456;1623.602217456707;1639.7786298849503;991.7619771254847;1044.9164066874632;1067.996083681337;1077.7467295185625;1081.7674200047027;5670.489655930986;6123.663198524124;6137.202163718777;6149.354317796657;6155.784547540815;6124.785632502841;6453.806385808433;6657.833554161185;6869.450443964471;6875.931240687529;5532.197831314437;6028.156058151862;6082.300535438393;6091.756329746849;6132.6933653317155;3584.856605735741;3596.4065929121925;3600.225951420457;3631.1648320885815;3646.927061458809;6244.906326405107;6338.904916426165;6796.844536428819;6837.931620683829;7054.576725396492;6215.409536094064;7053.964730176316;7069;7085.716571337191;7107.680154393065;6111.602745821508;6173.536984726164;6767.7479666260915;7158.06945097134;7205.675744591401;6567.540272180901;6594.670266486753;6865.622390768356;6895;6903.240643529308;5799.3040835100055;6483.319251478715;6616.933830661632;6728.125343705287;6786.626735529593;5930.7924222652;7100.183478899786;7108.969199466152;7111.964440177766;7134.287770935042;3795.981020094882;3809.7142714295983;4600.792964316547;4612.100640375094;4622.745748983838;6515.231026813491;6879.8968015480805;6940.305969403019;6979.2671769465505;6996.930030699627;5890.263717035371;6205.47253483459;6641.26946035926;6704.161979752531;6739.6967136478;6417.582857114273;6735.406868355621;6759.222689390783;6762.932370676231;6829.556078854858;5134.562322549692;5870.911936321044;6571.3757193066585;6575.112359831362;6585.901211481736;5512.889742205213;6149.723262453111;6707.061011458497;6718.7312507499155;6720.412641133101;5456.317960254968;6334.841628959313;6539.4768418525455;6564;6566.9343306568235 06:08:26 INFO - PROCESS | 1662 | |5;yui.html;694.4166899804167;707.8336590901138;722.9714025744112;727.8259183582152;727.9417646588273;14773.48292809752;14869.330880110394;15090.245487725624;15092.924535377322;15125.848741512582;13468.663283417894;14104.64738381541;14130.364133613986;14137;14167.78748318776;716.9139703235619;906.8186362727448;932.5756780664781;932.6316105138466;944.6693657219987;942.1285311087252;946.9763255918589;947.161761840769;947.8530827721714;951.291287990448;971.9125278724913;988.9456079915637;990.0742805476866;991.459654488302;992.4293531219578;944.329526036515;944.8724422202984;969.4086607169621;985.6205360936019;987.5555999800083;727.4544091931052;733.8825787873915;737.6717360774458;738.1695592458484;738.7931379213828;15019.02376345534;15048.849511504854;15145.242737863173;15198.316075776616;15457.5362739118;11278.984891359816;11322.886771132265;11356.901936289818;11411.54353825846;11456.427178641117;9977.80044399108;10028.799424011551;10145.898541014569;10225.590976360936;10481.475926203735;3445.9483107753404;3475.0443628002504;3499.0902365384927;3508.578970523528;3539.43369060949;70049.29950700479;71602.64198679026;72331.63834180795;72621.27378726198;77377.83933241006;9472.262508160924;9477.668281610111;9479.90520094804;9685.17675997534;9769.16962058233;20645.380638580868;20788.896055519926;20819.583608328052;20834.374968750963;21174.47063823386;6426.646534440651;6448.419642232127;6473.449756770633;6495.967520162369;6624.668766561653;4084.591540845951;4091.4272001919753;4096.631303182728;4104.138130992525;4155.480564929384;3441.8451169697423;3476.252605689738;3501.142220156027;3503.7897726136002;3539.876104336336;533.3626316551683;650.0379438431054;662.9436497897636;669.4978765925556;670.7451168555917;521.2936471081706;524.729764171452;553.2779722462145;569.1405976974797;581.3372755059236;7626.199249078878;7648.874726150191;7827.334676552443;7866.134725180225;7987.1613480584865;566.6769941133597;581.3895409819672;587.1017343464506;614.8493619063358;618.1562167641138;3533.3110043541265;3753.305638456894;3767.6609105180664;3842.4044273137706;3859.9035024124623;96086.51956740172;99498.50250748845;100160;103109;103661.48169259106;77725;77908;80012;80048;80347.19652803514;73499.63250183714;75387.24612753913;76040.23959760442;76177.61911190409;78523;7270.563766173835;7345.926540734738;7417.703291868481;7457.589832559262;7570.205128461433;43900.37402074723;44335.77832110819;44464.33303500515;45943.54056459526;46697.766511168586;64404;66869.66565167143;68700.6564967172;68818.65590672015;69941.30058699349;9772.26707996889;9785.091907078051;9860.654877079554;10076.042775936274;10110.545025473724;10686.946565267124;10714;10765.946170269099;11261.042811361127;11549;9471.455411195155;9998.600055997678;10293.228007899288;10448.111910487694;11127.054200393057;9949.955254698441;10023.949880250551;10462.68611941643;10467.633632822815;10511.526981285708;7781.727639532589;10160.441175735405;10321.535530901278;10385.480725963822;10386.428746418716;7265.237150099375;8620.61207245688;8803.515806630698;8887;9185.219256363016;8997.910020899708;9404.905950940676;9445.433274003582;9451.858222126537;9454.05459454049 06:08:26 INFO - PROCESS | 1662 | __end_tp_report 06:08:26 INFO - PROCESS | 1662 | __start_cc_report 06:08:26 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,402 06:08:26 INFO - PROCESS | 1662 | __end_cc_report 06:08:26 INFO - PROCESS | 1662 | __startTimestamp1461330506206__endTimestamp 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:08:26 INFO - PROCESS | 1662 | Number of tests: 6 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5705.11 Median:5940.20 stddev:653.93 (11.0%) stddev-sans-first:631.76 06:08:26 INFO - PROCESS | 1662 | Values: 3459.7 3471.1 3505.5 3510.2 3542.8 5787.5 5798.4 5810.6 5815.4 5817.0 5689.3 5757.7 5871.4 5874.5 5880.4 5175.6 5242.2 5260.9 5269.3 5298.9 5196.1 5337.6 5345.7 5366.5 5392.1 5140.4 5140.9 5237.9 5238.4 5261.3 4343.7 5189.4 5220.8 5239.9 5257.9 5219.1 5222.5 5241.0 5244.4 5251.4 4700.6 4813.1 5584.4 5658.2 5705.6 5135.4 6137.9 6164.8 6195.1 6195.8 6096.2 6231.3 6243.8 6245.2 6248.7 5193.9 5830.4 5889.6 5981.0 5982.2 6278.9 6301.8 6310.6 6318.1 6324.6 5150.1 6060.6 6242.3 6246.5 6247.8 6116.8 6127.2 6234.6 6238.7 6249.1 6139.5 6203.2 6218.3 6223.9 6240.3 6103.8 6132.1 6162.3 6187.1 6245.3 4950.0 4962.7 4967.7 4970.8 5005.8 4406.2 4418.2 4434.3 4442.7 4508.8 5054.5 5729.3 5813.4 5878.4 5934.8 6211.2 6212.8 6213.1 6231.8 6246.4 5168.7 5814.7 5837.7 5838.8 5878.9 5335.2 5408.7 5450.7 5476.0 5504.6 6265.8 6337.3 6341.1 6356.5 6366.8 6224.4 6224.5 6230.3 6236.7 6247.4 6232.0 6342.4 6404.3 6415.1 6467.6 6165.3 6186.7 6187.0 6224.3 6232.9 6144.9 6224.2 6230.8 6235.7 6249.4 4691.3 4858.0 6008.9 6054.6 6094.1 4986.5 5003.3 5067.5 6165.3 6188.8 5909.3 5916.5 5940.2 6016.8 6021.0 6036.8 6055.9 6088.6 6106.9 6111.8 6066.8 6079.9 6086.9 6110.6 6134.8 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:66917.71 Median:37745.75 stddev:148613.47 (393.7%) stddev-sans-first:148946.75 06:08:26 INFO - PROCESS | 1662 | Values: 519.6 571.0 574.6 579.0 595.9 32557.5 36906.8 36917.8 36936.4 36951.0 39230.8 39661.2 39807.8 39819.6 39824.4 9285.6 9475.1 9508.2 9541.2 9568.8 9404.0 9484.9 9498.2 9570.9 9583.2 9460.5 9487.4 9501.9 9536.5 9572.0 9455.9 9524.1 9552.2 9553.0 9557.9 9352.3 9490.4 9507.3 9531.2 9541.6 36660.6 37125.3 37163.8 37164.8 37359.4 2775.6 3132.6 3206.1 3254.8 3408.2 26760.7 26871.3 27061.9 27582.7 27603.4 2698.8 2723.0 2738.8 2805.5 2858.1 315670.0 359601.2 363785.0 365622.0 365769.0 55628.6 55876.0 55932.7 56037.7 56208.7 63167.1 65344.7 66476.3 66972.3 67154.0 16551.3 16589.1 16699.7 16756.7 16815.2 12848.7 12929.8 12936.6 12951.4 12967.5 17194.9 17886.0 19014.6 19505.1 19573.8 6969.5 6992.8 8330.6 8388.9 8409.7 800.0 901.8 912.2 959.8 1016.9 24376.6 28952.4 29146.0 29517.9 29966.1 897.6 1147.3 1172.2 1190.4 1211.3 15022.7 15115.9 15264.8 15536.8 15569.8 679229.0 723187.0 731392.0 736242.0 742494.0 57617.7 58561.0 59283.7 59383.4 59477.1 1502.8 1533.9 1537.2 1549.9 1550.8 29019.9 29186.8 29999.6 30145.4 30806.7 39573.6 52049.7 53019.0 53090.5 53159.7 479242.6 483496.0 486195.0 574596.0 575897.0 41143.8 41718.0 41798.2 42259.0 42326.7 44691.9 44880.8 44910.3 45530.9 46159.5 35754.3 37215.5 37754.2 38006.0 38086.4 35851.6 36877.6 37139.4 37437.0 37466.8 36543.8 37359.0 37445.3 37737.2 38141.8 28987.0 31499.7 31936.4 32415.2 32486.5 24040.6 24040.6 24184.4 24482.4 24671.0 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:32182.80 Median:1484.62 stddev:93963.74 (6329.2%) stddev-sans-first:94197.01 06:08:26 INFO - PROCESS | 1662 | Values: 390.9 392.4 398.6 398.7 403.6 11662.6 19646.5 20186.1 20214.7 20487.0 18654.8 19643.6 20321.0 20506.9 20538.8 5097.8 5415.8 5537.8 5778.2 5838.0 5609.4 5762.5 5780.2 6659.8 6674.3 6589.1 6592.7 6613.7 6619.5 6621.9 5977.2 6062.0 6083.9 6135.9 6274.7 4902.9 5707.8 5783.7 5842.5 5998.4 12532.7 12748.3 12752.7 12767.2 13189.5 2025.7 2120.8 2213.2 2386.3 2578.3 8920.9 9540.0 9588.6 10862.8 14150.9 1576.8 1630.5 1669.0 1694.7 1711.7 109659.0 117398.0 117882.0 118464.4 124066.0 11017.8 11346.1 11527.4 11579.9 11728.2 12912.7 13246.1 14542.6 14548.2 14579.2 6346.4 6486.8 7862.0 8536.5 8575.8 8413.5 8425.0 8433.2 8443.9 8530.6 4420.4 4515.4 4528.9 4548.6 4591.3 1568.0 1717.7 1900.5 1930.0 2011.6 937.5 941.8 981.5 1010.6 1032.2 17202.6 17984.6 19446.5 19587.7 19645.0 965.2 981.3 985.2 1020.1 1046.3 7788.4 9749.7 9946.4 10162.0 10252.4 531516.0 564469.0 568380.2 577022.0 580396.1 74130.6 74360.0 99446.5 127358.0 130926.0 967.4 990.9 1006.4 1011.7 1014.2 16995.5 17011.6 17533.1 18592.9 18717.0 40379.4 48694.8 48731.8 51656.5 52984.9 65850.7 65916.0 66203.0 66397.0 66524.0 5344.4 7044.6 7299.8 7958.1 8157.7 6925.2 10555.1 10698.6 10947.0 11050.5 10635.9 10786.1 10794.0 10850.8 10852.2 10157.7 10526.1 10638.4 10674.6 10798.3 9039.4 10524.7 11036.6 11219.5 11243.1 7811.5 7960.8 7965.5 8008.6 8194.5 10519.3 10691.8 10733.2 10760.9 10899.1 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5634.27 Median:5006.85 stddev:3117.80 (62.3%) stddev-sans-first:3111.79 06:08:26 INFO - PROCESS | 1662 | Values: 1597.9 1633.0 1862.9 1932.7 1940.1 7842.5 7980.9 8172.8 8245.3 8502.8 8568.6 8589.8 8680.1 8685.3 8691.0 2421.1 2449.8 2450.0 2456.2 2461.1 2386.0 2395.6 2411.2 2428.1 2431.6 2390.8 2404.0 2421.5 2452.2 2467.7 2392.3 2405.1 2415.3 2424.8 2448.3 2393.3 2416.2 2420.8 2424.8 2430.1 8749.3 8755.4 8801.1 8846.8 8856.4 5158.6 5323.7 5381.5 5390.2 5395.4 3526.4 3585.5 3590.5 3643.7 3645.8 939.9 962.5 994.2 1024.9 1046.8 11379.1 11454.1 11462.5 11463.8 11476.1 4237.4 4373.5 4686.4 4761.6 4816.5 9902.3 9904.3 9917.0 9922.9 9949.8 5324.9 5336.4 5368.2 5370.3 5378.0 4169.7 4720.7 4859.9 4863.2 4865.4 3991.4 4015.4 4077.6 4112.7 4146.8 1346.9 1354.7 1356.9 1361.0 1373.8 713.7 808.2 880.9 919.8 943.3 5560.8 5873.8 5940.2 5995.2 6026.1 947.1 968.6 975.8 979.7 984.7 3757.2 3873.0 3884.8 3913.1 3940.9 8976.0 10292.2 10809.9 10817.0 10828.9 10251.9 10713.4 10762.4 10763.0 10845.9 6916.7 7990.1 8091.0 8167.3 8208.1 5537.4 5562.9 5657.3 5768.7 5789.5 9764.9 9817.6 9978.8 10041.2 10085.2 9771.5 10022.3 10070.0 10182.1 10254.2 6404.1 6734.3 6897.3 6989.9 7042.9 8078.0 8137.1 8172.6 8258.2 8278.0 7153.6 7266.9 7295.2 7415.2 7437.2 6784.7 7147.2 7219.2 7226.1 7266.9 6790.4 6844.7 6866.1 6889.5 6897.0 4729.8 4760.9 4764.7 4838.9 4976.4 4428.5 4624.5 4800.2 4846.7 5037.3 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5308.78 Median:5950.81 stddev:1681.67 (28.3%) stddev-sans-first:1644.11 06:08:26 INFO - PROCESS | 1662 | Values: 316.3 321.7 325.4 330.3 332.4 5621.6 6194.5 6203.8 6251.7 6333.8 6207.1 6222.4 6224.3 6227.5 6251.9 4340.4 4488.8 4594.4 4610.3 4642.4 4132.9 4496.5 4626.7 4634.1 4665.3 4200.3 4268.5 4584.9 4605.6 4616.0 4053.9 4221.7 4268.5 4554.7 4558.0 3071.6 3106.5 3785.5 3896.3 3919.2 4780.3 5123.5 5829.5 5970.8 5999.4 4860.9 5168.0 5460.1 5473.7 5476.5 4894.6 6437.4 6562.5 6718.8 6748.0 4386.2 4510.8 4514.2 4533.8 4544.5 5861.7 6924.8 7006.6 7027.8 7039.9 3855.7 4547.7 4552.3 4569.4 4572.8 4451.7 4664.2 4669.0 4676.6 4679.3 4532.4 4970.5 5374.6 5399.1 5448.8 5087.8 5574.7 6634.0 6734.4 6735.1 1508.4 1599.4 1613.7 1623.6 1639.8 991.8 1044.9 1068.0 1077.7 1081.8 5670.5 6123.7 6137.2 6149.4 6155.8 6124.8 6453.8 6657.8 6869.5 6875.9 5532.2 6028.2 6082.3 6091.8 6132.7 3584.9 3596.4 3600.2 3631.2 3646.9 6244.9 6338.9 6796.8 6837.9 7054.6 6215.4 7054.0 7069.0 7085.7 7107.7 6111.6 6173.5 6767.7 7158.1 7205.7 6567.5 6594.7 6865.6 6895.0 6903.2 5799.3 6483.3 6616.9 6728.1 6786.6 5930.8 7100.2 7109.0 7112.0 7134.3 3796.0 3809.7 4600.8 4612.1 4622.7 6515.2 6879.9 6940.3 6979.3 6996.9 5890.3 6205.5 6641.3 6704.2 6739.7 6417.6 6735.4 6759.2 6762.9 6829.6 5134.6 5870.9 6571.4 6575.1 6585.9 5512.9 6149.7 6707.1 6718.7 6720.4 5456.3 6334.8 6539.5 6564.0 6566.9 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18058.86 Median:3573.00 stddev:26245.56 (734.6%) stddev-sans-first:26286.80 06:08:26 INFO - PROCESS | 1662 | Values: 694.4 707.8 723.0 727.8 727.9 14773.5 14869.3 15090.2 15092.9 15125.8 13468.7 14104.6 14130.4 14137.0 14167.8 716.9 906.8 932.6 932.6 944.7 942.1 947.0 947.2 947.9 951.3 971.9 988.9 990.1 991.5 992.4 944.3 944.9 969.4 985.6 987.6 727.5 733.9 737.7 738.2 738.8 15019.0 15048.8 15145.2 15198.3 15457.5 11279.0 11322.9 11356.9 11411.5 11456.4 9977.8 10028.8 10145.9 10225.6 10481.5 3445.9 3475.0 3499.1 3508.6 3539.4 70049.3 71602.6 72331.6 72621.3 77377.8 9472.3 9477.7 9479.9 9685.2 9769.2 20645.4 20788.9 20819.6 20834.4 21174.5 6426.6 6448.4 6473.4 6496.0 6624.7 4084.6 4091.4 4096.6 4104.1 4155.5 3441.8 3476.3 3501.1 3503.8 3539.9 533.4 650.0 662.9 669.5 670.7 521.3 524.7 553.3 569.1 581.3 7626.2 7648.9 7827.3 7866.1 7987.2 566.7 581.4 587.1 614.8 618.2 3533.3 3753.3 3767.7 3842.4 3859.9 96086.5 99498.5 100160.0 103109.0 103661.5 77725.0 77908.0 80012.0 80048.0 80347.2 73499.6 75387.2 76040.2 76177.6 78523.0 7270.6 7345.9 7417.7 7457.6 7570.2 43900.4 44335.8 44464.3 45943.5 46697.8 64404.0 66869.7 68700.7 68818.7 69941.3 9772.3 9785.1 9860.7 10076.0 10110.5 10686.9 10714.0 10765.9 11261.0 11549.0 9471.5 9998.6 10293.2 10448.1 11127.1 9950.0 10023.9 10462.7 10467.6 10511.5 7781.7 10160.4 10321.5 10385.5 10386.4 7265.2 8620.6 8803.5 8887.0 9185.2 8997.9 9404.9 9445.4 9451.9 9454.1 06:08:26 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:08:26 INFO - PROCESS | 1662 | 06:08:26 INFO - TEST-INFO | 1662: exit 0 06:08:26 INFO - TEST-OK | dromaeo_css | took 1112656ms 06:08:26 INFO - TEST-START | kraken 06:08:26 INFO - operating with platform_type : mac_ 06:08:26 INFO - Initialising browser for kraken test... 06:08:26 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpQZ8uRf/profile http://localhost:49276/getInfo.html) 06:08:29 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 06:08:29 INFO - PROCESS | 1673 | colorDepth:24 06:08:29 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 06:08:29 INFO - PROCESS | 1673 | __metrics 06:08:29 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:08:30 INFO - TEST-INFO | 1673: exit 0 06:08:30 INFO - Browser initialized. 06:08:30 INFO - Running cycle 1/1 for kraken test... 06:08:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpQZ8uRf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:42 INFO - PROCESS | 1676 | RSS: Main: 247881728 06:08:42 INFO - PROCESS | 1676 | 06:08:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:45 INFO - PROCESS | 1676 | RSS: Main: 260001792 06:08:45 INFO - PROCESS | 1676 | 06:08:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 06:08:49 INFO - PROCESS | 1676 | RSS: Main: 268890112 06:08:49 INFO - PROCESS | 1676 | 06:08:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 06:08:53 INFO - PROCESS | 1676 | RSS: Main: 271986688 06:08:53 INFO - PROCESS | 1676 | 06:08:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 06:08:55 INFO - PROCESS | 1676 | RSS: Main: 272887808 06:08:55 INFO - PROCESS | 1676 | 06:08:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:58 INFO - PROCESS | 1676 | RSS: Main: 274681856 06:08:58 INFO - PROCESS | 1676 | 06:09:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:02 INFO - PROCESS | 1676 | RSS: Main: 274845696 06:09:02 INFO - PROCESS | 1676 | 06:09:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:05 INFO - PROCESS | 1676 | RSS: Main: 274898944 06:09:05 INFO - PROCESS | 1676 | 06:09:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 06:09:09 INFO - PROCESS | 1676 | RSS: Main: 275279872 06:09:09 INFO - PROCESS | 1676 | 06:09:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:11 INFO - PROCESS | 1676 | RSS: Main: 274857984 06:09:11 INFO - PROCESS | 1676 | 06:09:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:14 INFO - PROCESS | 1676 | RSS: Main: 274984960 06:09:14 INFO - PROCESS | 1676 | 06:09:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:17 INFO - PROCESS | 1676 | RSS: Main: 275279872 06:09:17 INFO - PROCESS | 1676 | 06:09:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:20 INFO - PROCESS | 1676 | RSS: Main: 275382272 06:09:20 INFO - PROCESS | 1676 | 06:09:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:24 INFO - PROCESS | 1676 | RSS: Main: 275636224 06:09:24 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 06:09:26 INFO - PROCESS | 1676 | RSS: Main: 277118976 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | __start_tp_report 06:09:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 06:09:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 06:09:26 INFO - PROCESS | 1676 | |i|pagename|runs| 06:09:26 INFO - PROCESS | 1676 | |0;ai-astar;115;109;117;115;116;128;117;115;117;115 06:09:26 INFO - PROCESS | 1676 | |1;audio-beat-detection;181;157;132;188;155;173;121;195;152;111 06:09:26 INFO - PROCESS | 1676 | |2;audio-dft;196;197;209;229;194;201;196;200;202;197 06:09:26 INFO - PROCESS | 1676 | |3;audio-fft;67;76;71;138;58;56;57;62;132;70 06:09:26 INFO - PROCESS | 1676 | |4;audio-oscillator;82;83;126;77;81;82;135;113;119;167 06:09:26 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;75;135;129;89;99;124;85;111;87 06:09:26 INFO - PROCESS | 1676 | |6;imaging-darkroom;95;107;95;93;96;103;147;151;94;96 06:09:26 INFO - PROCESS | 1676 | |7;imaging-desaturate;103;147;148;117;93;91;96;101;96;92 06:09:26 INFO - PROCESS | 1676 | |8;json-parse-financial;61;64;62;61;62;62;60;74;84;62 06:09:26 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;63;82;90;110;60;96;100;91;58;91 06:09:26 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;86;112;109;107;85;85;84;83;84;84 06:09:26 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;157;177;159;159;149;144;138;141;171;140 06:09:26 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;172;171;174;221;190;173;175;179;195;176 06:09:26 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;71;74;70;67;73;69;66;69;71;66 06:09:26 INFO - PROCESS | 1676 | __end_tp_report 06:09:26 INFO - PROCESS | 1676 | __start_cc_report 06:09:26 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1013 06:09:26 INFO - PROCESS | 1676 | __end_cc_report 06:09:26 INFO - PROCESS | 1676 | __startTimestamp1461330566466__endTimestamp 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | ------- Summary: start ------- 06:09:26 INFO - PROCESS | 1676 | Number of tests: 14 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.50 stddev:4.70 (4.0%) stddev-sans-first:4.95 06:09:26 INFO - PROCESS | 1676 | Values: 115.0 109.0 117.0 115.0 116.0 128.0 117.0 115.0 117.0 115.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:165.00 stddev:28.48 (17.3%) stddev-sans-first:28.80 06:09:26 INFO - PROCESS | 1676 | Values: 181.0 157.0 132.0 188.0 155.0 173.0 121.0 195.0 152.0 111.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:202.10 Median:200.50 stddev:10.38 (5.2%) stddev-sans-first:10.77 06:09:26 INFO - PROCESS | 1676 | Values: 196.0 197.0 209.0 229.0 194.0 201.0 196.0 200.0 202.0 197.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:78.70 Median:64.50 stddev:30.42 (47.2%) stddev-sans-first:31.97 06:09:26 INFO - PROCESS | 1676 | Values: 67.0 76.0 71.0 138.0 58.0 56.0 57.0 62.0 132.0 70.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:79.00 stddev:30.41 (38.5%) stddev-sans-first:30.94 06:09:26 INFO - PROCESS | 1676 | Values: 82.0 83.0 126.0 77.0 81.0 82.0 135.0 113.0 119.0 167.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:102.20 Median:86.00 stddev:21.08 (24.5%) stddev-sans-first:21.72 06:09:26 INFO - PROCESS | 1676 | Values: 88.0 75.0 135.0 129.0 89.0 99.0 124.0 85.0 111.0 87.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:94.50 stddev:22.22 (23.5%) stddev-sans-first:23.08 06:09:26 INFO - PROCESS | 1676 | Values: 95.0 107.0 95.0 93.0 96.0 103.0 147.0 151.0 94.0 96.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:91.50 stddev:21.94 (24.0%) stddev-sans-first:23.18 06:09:26 INFO - PROCESS | 1676 | Values: 103.0 147.0 148.0 117.0 93.0 91.0 96.0 101.0 96.0 92.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:62.00 stddev:7.71 (12.4%) stddev-sans-first:8.03 06:09:26 INFO - PROCESS | 1676 | Values: 61.0 64.0 62.0 61.0 62.0 62.0 60.0 74.0 84.0 62.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:86.00 stddev:17.97 (20.9%) stddev-sans-first:17.36 06:09:26 INFO - PROCESS | 1676 | Values: 63.0 82.0 90.0 110.0 60.0 96.0 100.0 91.0 58.0 91.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.00 stddev:12.11 (14.4%) stddev-sans-first:12.66 06:09:26 INFO - PROCESS | 1676 | Values: 86.0 112.0 109.0 107.0 85.0 85.0 84.0 83.0 84.0 84.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:158.00 stddev:13.42 (8.5%) stddev-sans-first:14.17 06:09:26 INFO - PROCESS | 1676 | Values: 157.0 177.0 159.0 159.0 149.0 144.0 138.0 141.0 171.0 140.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:177.50 stddev:15.67 (8.8%) stddev-sans-first:16.15 06:09:26 INFO - PROCESS | 1676 | Values: 172.0 171.0 174.0 221.0 190.0 173.0 175.0 179.0 195.0 176.0 06:09:26 INFO - PROCESS | 1676 | 06:09:26 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.50 stddev:2.76 (3.9%) stddev-sans-first:2.88 06:09:26 INFO - PROCESS | 1676 | Values: 71.0 74.0 70.0 67.0 73.0 69.0 66.0 69.0 71.0 66.0 06:09:26 INFO - PROCESS | 1676 | -------- Summary: end -------- 06:09:26 INFO - PROCESS | 1676 | 06:09:27 INFO - TEST-INFO | 1676: exit 0 06:09:27 INFO - TEST-OK | kraken | took 60359ms 06:09:27 INFO - SUITE-END | took 1173s 06:09:27 INFO - Completed test suite (00:19:33) 06:09:27 INFO - javascript benchmark 06:09:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3459.6886280234776, 3471.0628130404793, 3505.544279243698, 3510.210202704392, 3542.752007359483, 5787.508061814746, 5798.391168927265, 5810.56420768443, 5815.360310365856, 5817.040188368919, 5689.345725241598, 5757.68332741699, 5871.412858714127, 5874.530037596993, 5880.353161152269, 5175.637705360636, 5242.239875218091, 5260.92108618371, 5269.288646032794, 5298.867528311785, 5196.116660167761, 5337.571405010711, 5345.652532585389, 5366.517013468787, 5392.056390131711, 5140.408852981917, 5140.871478213037, 5237.86905327368, 5238.423773384925, 5261.289725886994, 4343.67422443318, 5189.40321862983, 5220.843374698765, 5239.869003274911, 5257.868553286198, 5219.138842091088, 5222.50386213313, 5241.0, 5244.449332820075, 5251.396089449724, 4700.553447422523, 4813.133635945564, 5584.357798853102, 5658.207850900836, 5705.6291341063115, 5135.35808023997, 6137.877242455171, 6164.7534098636, 6195.0707393890825, 6195.845103872394, 6096.163860440878, 6231.345708700612, 6243.812685619393, 6245.219347581552, 6248.718807653667, 5193.896122077537, 5830.446107619811, 5889.646621202742, 5980.970095149496, 5982.222311099529, 6278.937210627835, 6301.779437719658, 6310.558260921784, 6318.052292156213, 6324.620522768557, 5150.098732721834, 6060.606060606046, 6242.313345531988, 6246.500279977591, 6247.75008999644, 6116.78591249313, 6127.158986117706, 6234.625922444668, 6238.719257633417, 6249.0626406039455, 6139.492138333291, 6203.193584834033, 6218.31598524162, 6223.875522489616, 6240.31356550779, 6103.761967187076, 6132.141360525245, 6162.26052873658, 6187.071939209065, 6245.344238854855, 4949.975250123798, 4962.727050012212, 4967.7019378837385, 4970.801167953241, 5005.849824505271, 4406.184855801687, 4418.226810308183, 4434.312681534368, 4442.733435993786, 4508.81964721414, 5054.519820617035, 5729.312482502127, 5813.360530341659, 5878.353381128072, 5934.762609495659, 6211.223597050369, 6212.751489940351, 6213.130161777355, 6231.813045608639, 6246.3753624637175, 5168.664036837668, 5814.738336774855, 5837.737301821428, 5838.766449342063, 5878.882422351529, 5335.226392173113, 5408.702521361284, 5450.672959622435, 5476.0, 5504.614676972574, 6265.843353916006, 6337.271213810379, 6341.143945567289, 6356.523260755462, 6366.808995730135, 6224.439800417984, 6224.533160012927, 6230.252369715663, 6236.688165591611, 6247.375262473716, 6232.0, 6342.4291813735135, 6404.263509696259, 6415.133956915756, 6467.611943283418, 6165.260168779596, 6186.690665466619, 6186.969065154645, 6224.346443623535, 6232.906506402498, 6144.910730351702, 6224.221972253468, 6230.7819226326865, 6235.688215589112, 6249.375062493714, 4691.272852707836, 4857.975710121426, 6008.939910600838, 6054.636721796706, 6094.055421409688, 4986.501349864984, 5003.299538064746, 5067.467915868928, 6165.260168779596, 6188.783392581238, 5909.261342332208, 5916.526677865846, 5940.198073260228, 6016.819495415145, 6020.969895150496, 6036.758529658764, 6055.939440605714, 6088.5737998341465, 6106.908396374147, 6111.84720381994, 6066.757329706762, 6079.908801367895, 6086.878262434638, 6110.572259941761, 6134.846628834136], "value": 5667.185392171018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.6466402846064, 570.9942900570993, 574.6322353693637, 578.952096704964, 595.9165716799646, 32557.511637325428, 36906.8154659227, 36917.81541092294, 36936.44595331072, 36951.0, 39230.823075307715, 39661.206775864535, 39807.800960995155, 39819.601803981954, 39824.40263396051, 9285.628574857015, 9475.147236748691, 9508.191803696694, 9541.236701063934, 9568.80862382752, 9404.0, 9484.857727134098, 9498.240140788756, 9570.856437153414, 9583.233341332676, 9460.526973651324, 9487.430754154739, 9501.904980950205, 9536.475493847836, 9571.952140239324, 9455.858162127573, 9524.095210954949, 9552.188064014566, 9552.95223523878, 9557.856632150488, 9352.345335826494, 9490.383125096847, 9507.334486585942, 9531.237500999972, 9541.618335266581, 36660.63339366599, 37125.25749485022, 37163.81418092919, 37164.81417592922, 37359.4396084059, 2775.5836624506283, 3132.592762940826, 3206.118317462693, 3254.8209848458328, 3408.2277215847867, 26760.73239267602, 26871.32821679454, 27061.86469067662, 27582.724172758215, 27603.447931041268, 2698.7975901807445, 2723.019712903353, 2738.835669859815, 2805.4529366773486, 2858.056841242385, 315670.0, 359601.201993991, 363785.0, 365622.0, 365769.0, 55628.60928476739, 55876.0, 55932.72033639806, 56037.7198114015, 56208.71895640578, 63167.05249421262, 65344.673276633315, 66476.33523664798, 66972.33027669661, 67154.0, 16551.25519351632, 16589.087600181865, 16699.74950375745, 16756.664866702842, 16815.159242037847, 12848.743025139445, 12929.806052909214, 12936.611901642966, 12951.352432378344, 12967.546135885199, 17194.914025430044, 17886.016269105065, 19014.61970760577, 19505.122269497908, 19573.804261957484, 6969.47728920333, 6992.79021629352, 8330.62512186953, 8388.916110838936, 8409.747707568782, 800.0, 901.8286525560122, 912.2291663544295, 959.8176346494143, 1016.9169834126632, 24376.587277781124, 28952.420951581273, 29146.0, 29517.852410737807, 29966.101016969526, 897.5512243878061, 1147.3402793393832, 1172.191188080222, 1190.4047976011993, 1211.2611307102661, 15022.699546009018, 15115.924420378047, 15264.771028434361, 15536.766948495782, 15569.766453503207, 679229.0, 723187.0, 731392.0, 736242.0, 742494.0, 57617.711911441016, 58561.0, 59283.703581481815, 59383.406165937784, 59477.107843382386, 1502.7520459124123, 1533.8696210821981, 1537.177609978656, 1549.8527639874194, 1550.837162097986, 29019.85490072536, 29186.832526698694, 29999.55000674948, 30145.397092058476, 30806.691933081278, 39573.60426395814, 52049.739751301, 53019.0, 53090.46909530855, 53159.73420132875, 479242.6037869788, 483496.0, 486195.0, 574596.0, 575897.0, 41143.7942810284, 41718.0, 41798.16403671849, 42259.0, 42326.730198094105, 44691.882702932686, 44880.77559612181, 44910.3263451055, 45530.86172845705, 46159.53840461552, 35754.28491430209, 37215.464530869525, 37754.24491510099, 38006.0, 38086.42870356891, 35851.641483585874, 36877.63122368849, 37139.44290835586, 37437.0, 37466.81266593649, 36543.81728091343, 37359.0, 37445.25109497849, 37737.245255095295, 38141.80929095448, 28986.985455508955, 31499.685003149676, 31936.36127277488, 32415.189620258738, 32486.512702309956, 24040.63939040951, 24040.63939040951, 24184.395390115387, 24482.387940300923, 24671.0], "value": 19684.679692081503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9276783794998, 392.37612196607404, 398.57750784168775, 398.6969902873819, 403.6447925825273, 11662.591809286676, 19646.508837279056, 20186.091625876834, 20214.686045407037, 20487.0, 18654.81345186551, 19643.60712785747, 20320.983950802474, 20506.87212203328, 20538.794612053876, 5097.770600322976, 5415.783368665268, 5537.8061767838135, 5778.219940308068, 5837.970810145944, 5609.35492418373, 5762.481376676098, 5780.161876527901, 6659.8335041624105, 6674.2658307586125, 6589.110470086549, 6592.736290548396, 6613.6693165341785, 6619.503537234703, 6621.867562648744, 5977.163197152402, 6061.969690151565, 6083.878322433527, 6135.938640613604, 6274.686265686721, 4902.90194196114, 5707.828765137053, 5783.71081445926, 5842.532597392198, 5998.410421238375, 12532.686682833002, 12748.2988435636, 12752.6811829705, 12767.233965962072, 13189.538366157234, 2025.6758918573105, 2120.8197303229244, 2213.210938312313, 2386.3198988288427, 2578.303857958341, 8920.910790892138, 9540.0, 9588.616455341778, 10862.837057444145, 14150.929245353811, 1576.8107827060826, 1630.5434478346083, 1668.9916550417292, 1694.7034269002997, 1711.6576684663116, 109659.0, 117398.0, 117882.0, 118464.40767796192, 124066.0, 11017.83473247902, 11346.149038822121, 11527.365994870195, 11579.88420115805, 11728.179027467995, 12912.741745165044, 13246.139000964906, 14542.636434089021, 14548.199849008406, 14579.198144102176, 6346.413396650837, 6486.837829054217, 7862.012435274673, 8536.530490823065, 8575.785605359792, 8413.495190288602, 8425.0, 8433.156684331641, 8443.915560844436, 8530.573471326408, 4420.381146639473, 4515.367848501212, 4528.935700110472, 4548.5906268436, 4591.334256532784, 1567.9921600391924, 1717.7423386492126, 1900.5438694713168, 1929.98070019298, 2011.5675129847152, 937.5406051034944, 941.802221533472, 981.5141504954951, 1010.5952725711268, 1032.1742605915238, 17202.569935751708, 17984.550386240186, 19446.513837154183, 19587.706184407245, 19645.0, 965.2278177458005, 981.3326937682444, 985.2315194148575, 1020.1175982774995, 1046.3042077018697, 7788.376929845599, 9749.707508774749, 9946.35348702332, 10161.983801619926, 10252.38485690861, 531516.0, 564469.0, 568380.2133850673, 577022.0, 580396.0980195072, 74130.629346854, 74360.0, 99446.5027674857, 127358.0, 130926.0, 967.3905439573165, 990.9157721593601, 1006.3961623026125, 1011.7420057885192, 1014.1987829614669, 16995.49013529596, 17011.574710632332, 17533.123343833013, 18592.907035464737, 18717.0, 40379.394309085976, 48694.75652621714, 48731.75634121807, 51656.483435165166, 52984.94030119453, 65850.67074664596, 65916.0, 66203.0, 66397.0, 66524.0, 5344.388392188264, 7044.555866047345, 7299.781006569811, 7958.124606293419, 8157.673693052211, 6925.203601585882, 10555.050045495942, 10698.555694981389, 10947.0, 11050.502727377127, 10635.94682026585, 10786.083182929538, 10793.974572415607, 10850.837237441287, 10852.18608604342, 10157.695269141937, 10526.052655260757, 10638.41488718128, 10674.57301707923, 10798.298110622783, 9039.412438191497, 10524.684259471922, 11036.558537658404, 11219.495122719334, 11243.10055195566, 7811.531308121531, 7960.800979975547, 7965.522068675898, 8008.6396112173925, 8194.467359621605, 10519.316244444086, 10691.839622405514, 10733.19501037441, 10760.946195268974, 10899.073578745896], "value": 9018.537471307103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1597.9360825566973, 1633.003867640739, 1862.8789128706633, 1932.729417881496, 1940.1075505267577, 7842.451028428012, 7980.9201907980905, 8172.795680108, 8245.340372770179, 8502.829943401128, 8568.571571421435, 8589.828203435927, 8680.08859069798, 8685.348598855095, 8691.0, 2421.0557882425824, 2449.8285120041605, 2449.9877500612474, 2456.1771806444863, 2461.126300163443, 2385.974031166598, 2395.6286775549816, 2411.204302580153, 2428.101602407112, 2431.623098419739, 2390.784829365357, 2403.975960240393, 2421.5278020785954, 2452.2030340139436, 2467.703875534938, 2392.342105920868, 2405.1461731085474, 2415.335782659765, 2424.806015518763, 2448.2532827487607, 2393.3179043972386, 2416.154345978911, 2420.8426452280546, 2424.830261881669, 2430.1373012580457, 8749.343799215085, 8755.3871229014, 8801.075887031897, 8846.823063538694, 8856.424332418372, 5158.613104017176, 5323.707196104213, 5381.461853814626, 5390.1914712793005, 5395.433479484637, 3526.365254254233, 3585.4980302757635, 3590.461430785403, 3643.6720695137565, 3645.781253124821, 939.9389039712397, 962.4898803634085, 994.1500017485018, 1024.948752562369, 1046.837740150278, 11379.146564007733, 11454.140939429577, 11462.484188211467, 11463.828042579367, 11476.1392895534, 4237.385579091015, 4373.518912919576, 4686.390769199982, 4761.642876784255, 4816.470188279286, 9902.257330700226, 9904.306698531034, 9917.0, 9922.851157232648, 9949.751256218653, 5324.92012619811, 5336.4129945705945, 5368.194770784336, 5370.2750128732905, 5378.031954248273, 4169.687273454503, 4720.669553131248, 4859.878503037452, 4863.221884498464, 4865.391826021747, 3991.4212439196153, 4015.3976903464713, 4077.571854955246, 4112.670986321147, 4146.79742874563, 1346.8720471555382, 1354.7425989062046, 1356.907689310095, 1360.9727805443836, 1373.8145350377772, 713.653877869233, 808.2160304504621, 880.8854848869734, 919.7654598077447, 943.2642538819731, 5560.833175004756, 5873.823785286449, 5940.227770389822, 5995.2206213192, 6026.126211699279, 947.1428357336621, 968.6028728221395, 975.7853272280087, 979.7207795778169, 984.6947446291673, 3757.2109856929806, 3873.0, 3884.8446062157764, 3913.1391093959282, 3940.8817735467983, 8975.955120224357, 10292.228082893664, 10809.891901081046, 10817.0, 10828.917108289266, 10251.948740256252, 10713.410762408143, 10762.3542587445, 10762.97751713586, 10845.945770271099, 6916.688749006206, 7990.081140668781, 8090.959545202354, 8167.264946154874, 8208.138145494757, 5537.418571049981, 5562.888742225214, 5657.32112146545, 5768.682722450306, 5789.478946894799, 9764.925858155455, 9817.607295708378, 9978.800423991624, 10041.246906481896, 10085.243606729378, 9771.511424428609, 10022.3485473444, 10070.0, 10182.134518566005, 10254.230932680228, 6404.103425520524, 6734.326567343226, 6897.310268973062, 6989.8951515726285, 7042.908349205882, 8077.959610201911, 8137.104918458846, 8172.591370431336, 8258.174182581693, 8278.0, 7153.6423178839805, 7266.854662906818, 7295.161056478573, 7415.221401752954, 7437.181909990005, 6784.728610855511, 7147.178074521288, 7219.241979592067, 7226.060612120601, 7266.927330726837, 6790.42281406086, 6844.726210951506, 6866.141732283465, 6889.517733758589, 6897.034415181979, 4729.763511824463, 4760.880977975578, 4764.714117152982, 4838.927416088691, 4976.402831660224, 4428.512863585068, 4624.537546245483, 4800.159972004815, 4846.660733748604, 5037.294778731054], "value": 4563.5538367586705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.34516550739966, 321.7313543191435, 325.396389697112, 330.29152467956226, 332.41826803094585, 5621.594601349662, 6194.473469755077, 6203.751849926003, 6251.7499300028, 6333.841653958653, 6207.068939659053, 6222.408871157233, 6224.28420731616, 6227.5017998560115, 6251.906221406671, 4340.43574335336, 4488.842890498833, 4594.379758732562, 4610.308453731934, 4642.396488456496, 4132.8966775830695, 4496.460424749019, 4626.676132670715, 4634.1195172917205, 4665.323528088442, 4200.264953633117, 4268.487781466229, 4584.908301833962, 4605.608523275526, 4615.953840461586, 4053.9257096869205, 4221.662267018646, 4268.530461649216, 4554.726716396994, 4557.997240607061, 3071.5853359796365, 3106.549550315214, 3785.4511095891216, 3896.3181443247317, 3919.176972835708, 4780.282957556359, 5123.513266239701, 5829.533637309048, 5970.820875373745, 5999.430054144849, 4860.902781944341, 5168.0, 5460.099083651193, 5473.67157970523, 5476.534494567966, 4894.583960363373, 6437.420632143129, 6562.540622156451, 6718.764843230463, 6747.966260168717, 4386.210482113218, 4510.751908645023, 4514.232580461329, 4533.750643714594, 4544.477385100723, 5861.736221870026, 6924.7576334828545, 7006.579605223703, 7027.754028609025, 7039.8592028159665, 3855.7300988931065, 4547.727136371828, 4552.291386624953, 4569.405977222939, 4572.8399506017795, 4451.710638808532, 4664.160451118832, 4669.0195059037305, 4676.625869930397, 4679.344891715163, 4532.388127602798, 4970.527799859007, 5374.623776335698, 5399.082156033483, 5448.809291674773, 5087.796488140507, 5574.693391863487, 6633.9668301658185, 6734.393904548516, 6735.090762747064, 1508.4192585854526, 1599.448190374319, 1613.6611311624456, 1623.602217456707, 1639.7786298849503, 991.7619771254847, 1044.9164066874632, 1067.996083681337, 1077.7467295185625, 1081.7674200047027, 5670.489655930986, 6123.663198524124, 6137.202163718777, 6149.354317796657, 6155.784547540815, 6124.785632502841, 6453.806385808433, 6657.833554161185, 6869.450443964471, 6875.931240687529, 5532.197831314437, 6028.156058151862, 6082.300535438393, 6091.756329746849, 6132.6933653317155, 3584.856605735741, 3596.4065929121925, 3600.225951420457, 3631.1648320885815, 3646.927061458809, 6244.906326405107, 6338.904916426165, 6796.844536428819, 6837.931620683829, 7054.576725396492, 6215.409536094064, 7053.964730176316, 7069.0, 7085.716571337191, 7107.680154393065, 6111.602745821508, 6173.536984726164, 6767.7479666260915, 7158.06945097134, 7205.675744591401, 6567.540272180901, 6594.670266486753, 6865.622390768356, 6895.0, 6903.240643529308, 5799.3040835100055, 6483.319251478715, 6616.933830661632, 6728.125343705287, 6786.626735529593, 5930.7924222652, 7100.183478899786, 7108.969199466152, 7111.964440177766, 7134.287770935042, 3795.981020094882, 3809.7142714295983, 4600.792964316547, 4612.100640375094, 4622.745748983838, 6515.231026813491, 6879.8968015480805, 6940.305969403019, 6979.2671769465505, 6996.930030699627, 5890.263717035371, 6205.47253483459, 6641.26946035926, 6704.161979752531, 6739.6967136478, 6417.582857114273, 6735.406868355621, 6759.222689390783, 6762.932370676231, 6829.556078854858, 5134.562322549692, 5870.911936321044, 6571.3757193066585, 6575.112359831362, 6585.901211481736, 5512.889742205213, 6149.723262453111, 6707.061011458497, 6718.7312507499155, 6720.412641133101, 5456.317960254968, 6334.841628959313, 6539.4768418525455, 6564.0, 6566.9343306568235], "value": 4768.927725005976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4166899804167, 707.8336590901138, 722.9714025744112, 727.8259183582152, 727.9417646588273, 14773.48292809752, 14869.330880110394, 15090.245487725624, 15092.924535377322, 15125.848741512582, 13468.663283417894, 14104.64738381541, 14130.364133613986, 14137.0, 14167.78748318776, 716.9139703235619, 906.8186362727448, 932.5756780664781, 932.6316105138466, 944.6693657219987, 942.1285311087252, 946.9763255918589, 947.161761840769, 947.8530827721714, 951.291287990448, 971.9125278724913, 988.9456079915637, 990.0742805476866, 991.459654488302, 992.4293531219578, 944.329526036515, 944.8724422202984, 969.4086607169621, 985.6205360936019, 987.5555999800083, 727.4544091931052, 733.8825787873915, 737.6717360774458, 738.1695592458484, 738.7931379213828, 15019.02376345534, 15048.849511504854, 15145.242737863173, 15198.316075776616, 15457.5362739118, 11278.984891359816, 11322.886771132265, 11356.901936289818, 11411.54353825846, 11456.427178641117, 9977.80044399108, 10028.799424011551, 10145.898541014569, 10225.590976360936, 10481.475926203735, 3445.9483107753404, 3475.0443628002504, 3499.0902365384927, 3508.578970523528, 3539.43369060949, 70049.29950700479, 71602.64198679026, 72331.63834180795, 72621.27378726198, 77377.83933241006, 9472.262508160924, 9477.668281610111, 9479.90520094804, 9685.17675997534, 9769.16962058233, 20645.380638580868, 20788.896055519926, 20819.583608328052, 20834.374968750963, 21174.47063823386, 6426.646534440651, 6448.419642232127, 6473.449756770633, 6495.967520162369, 6624.668766561653, 4084.591540845951, 4091.4272001919753, 4096.631303182728, 4104.138130992525, 4155.480564929384, 3441.8451169697423, 3476.252605689738, 3501.142220156027, 3503.7897726136002, 3539.876104336336, 533.3626316551683, 650.0379438431054, 662.9436497897636, 669.4978765925556, 670.7451168555917, 521.2936471081706, 524.729764171452, 553.2779722462145, 569.1405976974797, 581.3372755059236, 7626.199249078878, 7648.874726150191, 7827.334676552443, 7866.134725180225, 7987.1613480584865, 566.6769941133597, 581.3895409819672, 587.1017343464506, 614.8493619063358, 618.1562167641138, 3533.3110043541265, 3753.305638456894, 3767.6609105180664, 3842.4044273137706, 3859.9035024124623, 96086.51956740172, 99498.50250748845, 100160.0, 103109.0, 103661.48169259106, 77725.0, 77908.0, 80012.0, 80048.0, 80347.19652803514, 73499.63250183714, 75387.24612753913, 76040.23959760442, 76177.61911190409, 78523.0, 7270.563766173835, 7345.926540734738, 7417.703291868481, 7457.589832559262, 7570.205128461433, 43900.37402074723, 44335.77832110819, 44464.33303500515, 45943.54056459526, 46697.766511168586, 64404.0, 66869.66565167143, 68700.6564967172, 68818.65590672015, 69941.30058699349, 9772.26707996889, 9785.091907078051, 9860.654877079554, 10076.042775936274, 10110.545025473724, 10686.946565267124, 10714.0, 10765.946170269099, 11261.042811361127, 11549.0, 9471.455411195155, 9998.600055997678, 10293.228007899288, 10448.111910487694, 11127.054200393057, 9949.955254698441, 10023.949880250551, 10462.68611941643, 10467.633632822815, 10511.526981285708, 7781.727639532589, 10160.441175735405, 10321.535530901278, 10385.480725963822, 10386.428746418716, 7265.237150099375, 8620.61207245688, 8803.515806630698, 8887.0, 9185.219256363016, 8997.910020899708, 9404.905950940676, 9445.433274003582, 9451.858222126537, 9454.05459454049], "value": 6703.1407552671235, "unit": "score"}], "name": "dromaeo_css", "value": 7262.935803495656, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 117.0, 115.0, 116.0, 128.0, 117.0, 115.0, 117.0, 115.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 157.0, 132.0, 188.0, 155.0, 173.0, 121.0, 195.0, 152.0, 111.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 209.0, 229.0, 194.0, 201.0, 196.0, 200.0, 202.0, 197.0], "value": 202.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 71.0, 138.0, 58.0, 56.0, 57.0, 62.0, 132.0, 70.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 77.0, 81.0, 82.0, 135.0, 113.0, 119.0, 167.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 75.0, 135.0, 129.0, 89.0, 99.0, 124.0, 85.0, 111.0, 87.0], "value": 102.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 107.0, 95.0, 93.0, 96.0, 103.0, 147.0, 151.0, 94.0, 96.0], "value": 107.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 147.0, 148.0, 117.0, 93.0, 91.0, 96.0, 101.0, 96.0, 92.0], "value": 108.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 62.0, 61.0, 62.0, 62.0, 60.0, 74.0, 84.0, 62.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 82.0, 90.0, 110.0, 60.0, 96.0, 100.0, 91.0, 58.0, 91.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 112.0, 109.0, 107.0, 85.0, 85.0, 84.0, 83.0, 84.0, 84.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 177.0, 159.0, 159.0, 149.0, 144.0, 138.0, 141.0, 171.0, 140.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 174.0, 221.0, 190.0, 173.0, 175.0, 179.0, 195.0, 176.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 70.0, 67.0, 73.0, 69.0, 66.0, 69.0, 71.0, 66.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1625.3999999999999, "alertThreshold": 2.0}]} 06:09:27 INFO - Return code: 0 06:09:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:27 ERROR - # TBPL SUCCESS # 06:09:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:09:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:09:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:09:27 INFO - 2016-04-22 06:09:27.780 screenresolution[1681:10252] starting screenresolution argv=screenresolution get 06:09:27 INFO - 2016-04-22 06:09:27.782 screenresolution[1681:10252] Display 0: 1600x1200x32@60 06:09:27 INFO - 2016-04-22 06:09:27.788 screenresolution[1682:10255] starting screenresolution argv=screenresolution list 06:09:27 INFO - Available Modes on Display 0 06:09:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:09:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:09:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:09:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:09:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:09:28 INFO - Intel Iris: 06:09:28 INFO - Chipset Model: Intel Iris 06:09:28 INFO - Type: GPU 06:09:28 INFO - Bus: Built-In 06:09:28 INFO - VRAM (Dynamic, Max): 1536 MB 06:09:28 INFO - Vendor: Intel (0x8086) 06:09:28 INFO - Device ID: 0x0a2e 06:09:28 INFO - Revision ID: 0x0009 06:09:28 INFO - Displays: 06:09:28 INFO - Display: 06:09:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:09:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:09:28 INFO - Display Serial Number: 1600x1200 60 06:09:28 INFO - Main Display: Yes 06:09:28 INFO - Mirror: Off 06:09:28 INFO - Online: Yes 06:09:28 INFO - Rotation: Supported 06:09:28 INFO - Return code: 0 06:09:28 INFO - Running post-action listener: _resource_record_post_action 06:09:28 INFO - Running post-run listener: _resource_record_post_run 06:09:29 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37889536; Write bytes: 696508928; Read time: 460; Write time: 1850 06:09:29 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384199168; Write bytes: 378517504; Read time: 28309; Write time: 702 06:09:29 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35943936; Write bytes: 298252800; Read time: 373; Write time: 1110 06:09:29 INFO - Running post-run listener: _upload_blobber_files 06:09:29 INFO - Blob upload gear active. 06:09:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:29 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:09:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:30 INFO - (blobuploader) - INFO - Done attempting. 06:09:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:09:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:32 INFO - (blobuploader) - INFO - Done attempting. 06:09:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:32 INFO - Return code: 0 06:09:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ce25d1fa8db7ebb955fe17b585dac33ab9364eb1aef029443091221577b62c50c5d7261856608c83b3001a4f94bee40f103acf4dcb93150db355c0625a79f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27bc4b27b20cdd4b62057ff4ebca6da328b33cb10a3a1535e2bb505f373f3735c081b281e0b532928e4df29d532f04769a9adb566ca169cd10a910f066725e4e"} 06:09:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:32 INFO - Contents: 06:09:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ce25d1fa8db7ebb955fe17b585dac33ab9364eb1aef029443091221577b62c50c5d7261856608c83b3001a4f94bee40f103acf4dcb93150db355c0625a79f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27bc4b27b20cdd4b62057ff4ebca6da328b33cb10a3a1535e2bb505f373f3735c081b281e0b532928e4df29d532f04769a9adb566ca169cd10a910f066725e4e"} 06:09:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:32 INFO - Copying logs to upload dir... 06:09:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.885275 ========= master_lag: 8.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-22 06:09:40.825290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:40.829109) ========= 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.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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/Fx-Team/sha512/36ce25d1fa8db7ebb955fe17b585dac33ab9364eb1aef029443091221577b62c50c5d7261856608c83b3001a4f94bee40f103acf4dcb93150db355c0625a79f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27bc4b27b20cdd4b62057ff4ebca6da328b33cb10a3a1535e2bb505f373f3735c081b281e0b532928e4df29d532f04769a9adb566ca169cd10a910f066725e4e"} build_url:https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ce25d1fa8db7ebb955fe17b585dac33ab9364eb1aef029443091221577b62c50c5d7261856608c83b3001a4f94bee40f103acf4dcb93150db355c0625a79f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27bc4b27b20cdd4b62057ff4ebca6da328b33cb10a3a1535e2bb505f373f3735c081b281e0b532928e4df29d532f04769a9adb566ca169cd10a910f066725e4e"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:41.289598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:41.290003) ========= 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.O93nYLLRhv/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.bKvckbJNJE/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005058 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:41.511205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:41.511557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:41.512229) ========= ========= Total master_lag: 9.32 =========