builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0110 starttime: 1461715625.7 results: success (0) buildid: 20160426144059 builduid: 5e3a427619484e129638fb2f79999862 revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:05.700919) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:05.701752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 13 secs) (at 2016-04-26 17:07:05.702202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 13 secs) (at 2016-04-26 17:07:19.575777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:19.576033) ========= 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.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-26 17:07:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.73M=0.001s 2016-04-26 17:07:20 (7.73 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119818 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:20.118659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:20.118948) ========= 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.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.027376 ========= master_lag: 0.69 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:20.835837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-26 17:07:20.839218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b567617d9f02be4bd6870db55a9bd514a5762465 --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 b567617d9f02be4bd6870db55a9bd514a5762465 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-26 17:07:21,606 truncating revision to first 12 chars 2016-04-26 17:07:21,606 Setting DEBUG logging. 2016-04-26 17:07:21,606 attempt 1/10 2016-04-26 17:07:21,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b567617d9f02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 17:07:22,837 unpacking tar archive at: fx-team-b567617d9f02/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482172 ========= master_lag: 2.72 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-26 17:07:25.044534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:25.047465) ========= script_repo_revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:25.047843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:25.048110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:07:25.641287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-26 17:07:25.641554) ========= /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.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:07:25 INFO - MultiFileLogger online at 20160426 17:07:25 in /builds/slave/test 17:07: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 17:07:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:07:25 INFO - {'append_to_log': False, 17:07:25 INFO - 'base_work_dir': '/builds/slave/test', 17:07:25 INFO - 'blob_upload_branch': 'Fx-Team', 17:07:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:07:25 INFO - 'branch': 'Fx-Team', 17:07:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:25 INFO - 'config_files': ('talos/mac_config.py',), 17:07:25 INFO - 'default_actions': ('clobber', 17:07:25 INFO - 'read-buildbot-config', 17:07:25 INFO - 'download-and-extract', 17:07:25 INFO - 'populate-webroot', 17:07:25 INFO - 'create-virtualenv', 17:07:25 INFO - 'install', 17:07:25 INFO - 'run-tests'), 17:07:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:25 INFO - 'download_minidump_stackwalk': True, 17:07:25 INFO - 'download_symbols': 'ondemand', 17:07:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:25 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:25 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:25 INFO - 'installer_path': 'installer.exe', 17:07:25 INFO - 'log_level': 'info', 17:07:25 INFO - 'log_name': 'talos', 17:07:25 INFO - 'log_to_console': True, 17:07:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:07:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:07:25 INFO - 'opt_config_files': (), 17:07:25 INFO - 'pip_index': False, 17:07:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:07:25 INFO - 'cmd': ('bash', 17:07:25 INFO - '-c', 17:07:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:07:25 INFO - 'enabled': True, 17:07:25 INFO - 'halt_on_failure': False, 17:07:25 INFO - 'name': 'check_screen_resolution'},), 17:07:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:07:25 INFO - 'cmd': ('bash', 17:07:25 INFO - '-c', 17:07:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:07:25 INFO - 'enabled': True, 17:07:25 INFO - 'halt_on_failure': False, 17:07:25 INFO - 'name': 'check_screen_resolution'},), 17:07:25 INFO - 'run_cmd_checks_enabled': True, 17:07:25 INFO - 'sps_profile': False, 17:07:25 INFO - 'sps_profile_interval': 0, 17:07:25 INFO - 'suite': 'dromaeojs-e10s', 17:07:25 INFO - 'system_bits': '32', 17:07:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:25 INFO - 'title': 't-yosemite-r7-0110', 17:07:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:25 INFO - 'use_talos_json': True, 17:07:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:07:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:25 INFO - 'work_dir': 'build'} 17:07:25 INFO - ##### 17:07:25 INFO - ##### Running clobber step. 17:07:25 INFO - ##### 17:07:25 INFO - Running pre-action listener: _resource_record_pre_action 17:07:25 INFO - Running main action method: clobber 17:07:25 INFO - rmtree: /builds/slave/test/build 17:07:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:07:27 INFO - Running post-action listener: _resource_record_post_action 17:07:27 INFO - ##### 17:07:27 INFO - ##### Running read-buildbot-config step. 17:07:27 INFO - ##### 17:07:27 INFO - Running pre-action listener: _resource_record_pre_action 17:07:27 INFO - Running main action method: read_buildbot_config 17:07:27 INFO - Using buildbot properties: 17:07:27 INFO - { 17:07:27 INFO - "project": "", 17:07:27 INFO - "product": "firefox", 17:07:27 INFO - "script_repo_revision": "production", 17:07:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:07:27 INFO - "repository": "", 17:07:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:07:27 INFO - "buildid": "20160426144059", 17:07:27 INFO - "pgo_build": "False", 17:07:27 INFO - "basedir": "/builds/slave/test", 17:07:27 INFO - "buildnumber": 642, 17:07:27 INFO - "slavename": "t-yosemite-r7-0110", 17:07:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:07:27 INFO - "platform": "yosemite_r7", 17:07:27 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:07:27 INFO - "branch": "fx-team", 17:07:27 INFO - "repo_path": "integration/fx-team", 17:07:27 INFO - "revision": "b567617d9f02be4bd6870db55a9bd514a5762465", 17:07:27 INFO - "stage_platform": "macosx64", 17:07:27 INFO - "builduid": "5e3a427619484e129638fb2f79999862", 17:07:27 INFO - "slavebuilddir": "test" 17:07:27 INFO - } 17:07:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:07:27 INFO - Running post-action listener: _resource_record_post_action 17:07:27 INFO - ##### 17:07:27 INFO - ##### Running download-and-extract step. 17:07:27 INFO - ##### 17:07:27 INFO - Running pre-action listener: _resource_record_pre_action 17:07:27 INFO - Running main action method: download_and_extract 17:07:27 INFO - mkdir: /builds/slave/test/build/tests 17:07: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')]} 17:07:27 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 17:07:40 INFO - Downloaded 1199 bytes. 17:07:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:07:40 INFO - Using the following test package requirements: 17:07:40 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:07:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:07:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:07:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'jsshell-mac.zip'], 17:07:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:07:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:07:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:07:40 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:07:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:07:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:07:40 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:07:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:07: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')]} 17:07:40 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:07:41 INFO - Downloaded 18114881 bytes. 17:07:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:07:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:07:44 INFO - Return code: 0 17:07:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:44 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:07:47 INFO - Downloaded 18114881 bytes. 17:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:07:51 INFO - Return code: 0 17:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:51 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:07:52 INFO - Downloaded 10840145 bytes. 17:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:07:52 INFO - Return code: 0 17:07: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')]} 17:07:52 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 17:07:58 INFO - Downloaded 110223149 bytes. 17:07:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:07:58 INFO - mkdir: /builds/slave/test/properties 17:07:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:58 INFO - Contents: 17:07:58 INFO - build_url:https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:07:59 INFO - Running post-action listener: _resource_record_post_action 17:07:59 INFO - Running post-action listener: set_extra_try_arguments 17:07:59 INFO - ##### 17:07:59 INFO - ##### Running populate-webroot step. 17:07:59 INFO - ##### 17:07:59 INFO - Running pre-action listener: _resource_record_pre_action 17:07:59 INFO - Running main action method: populate_webroot 17:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:07:59 INFO - '--tppagecycles', 17:07:59 INFO - '7'], 17:07:59 INFO - 'tests': ['tsvgm']}}, 17:07:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['damp', 'tps']}, 17:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'tests': ['damp', 'tps']}, 17:07:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['dromaeo_dom']}, 17:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['a11yr', 17:07:59 INFO - 'ts_paint', 17:07:59 INFO - 'tpaint', 17:07:59 INFO - 'sessionrestore', 17:07:59 INFO - 'sessionrestore_no_auto_restore', 17:07:59 INFO - 'tabpaint']}, 17:07:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['tsvgx', 17:07:59 INFO - 'tsvgr_opacity', 17:07:59 INFO - 'tart', 17:07:59 INFO - 'tscrollx', 17:07:59 INFO - 'cart']}, 17:07:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:59 INFO - 'tsvgr_opacity', 17:07:59 INFO - 'tart', 17:07:59 INFO - 'tscrollx', 17:07:59 INFO - 'cart']}, 17:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'talos_options': ['--disable-e10s'], 17:07:59 INFO - 'tests': ['tp5o']}, 17:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'tests': ['tp5o']}, 17:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'talos_options': ['--disable-e10s', 17:07:59 INFO - '--xperf_path', 17:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:59 INFO - 'tests': ['tp5n']}, 17:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:59 INFO - 'talos_options': ['--xperf_path', 17:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:59 INFO - 'tests': ['tp5n']}}, 17:07:59 INFO - 'talos.zip': {'path': '', 17:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:07:59 INFO - Running post-action listener: _resource_record_post_action 17:07:59 INFO - ##### 17:07:59 INFO - ##### Running create-virtualenv step. 17:07:59 INFO - ##### 17:07:59 INFO - Running pre-action listener: _resource_record_pre_action 17:07:59 INFO - Running main action method: create_virtualenv 17:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:59 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 17:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:59 INFO - Using real prefix '/tools/python27' 17:07:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:03 INFO - Installing pip.................done. 17:08:03 INFO - Return code: 0 17:08:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:03 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:03 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 17:08:03 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 17:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:03 INFO - 'HOME': '/Users/cltbld', 17:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:03 INFO - 'LOGNAME': 'cltbld', 17:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:03 INFO - 'MOZ_NO_REMOTE': '1', 17:08:03 INFO - 'NO_EM_RESTART': '1', 17:08:03 INFO - 'PAGER': '/bin/cat', 17:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:03 INFO - 'PWD': '/builds/slave/test', 17:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:03 INFO - 'SHELL': '/bin/bash', 17:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:03 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:03 INFO - 'USER': 'cltbld', 17:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:03 INFO - 'XPC_FLAGS': '0x0', 17:08:03 INFO - 'XPC_SERVICE_NAME': '0', 17:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:03 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 17:08:03 INFO - Cleaning up... 17:08:03 INFO - Return code: 0 17:08:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:03 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:03 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 17:08:03 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 17:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:03 INFO - 'HOME': '/Users/cltbld', 17:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:03 INFO - 'LOGNAME': 'cltbld', 17:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:03 INFO - 'MOZ_NO_REMOTE': '1', 17:08:03 INFO - 'NO_EM_RESTART': '1', 17:08:03 INFO - 'PAGER': '/bin/cat', 17:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:03 INFO - 'PWD': '/builds/slave/test', 17:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:03 INFO - 'SHELL': '/bin/bash', 17:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:03 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:03 INFO - 'USER': 'cltbld', 17:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:03 INFO - 'XPC_FLAGS': '0x0', 17:08:03 INFO - 'XPC_SERVICE_NAME': '0', 17:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:03 INFO - Downloading/unpacking psutil>=0.7.1 17:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:07 INFO - Installing collected packages: psutil 17:08:07 INFO - Running setup.py install for psutil 17:08:07 INFO - building 'psutil._psutil_osx' extension 17:08:07 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 17:08:07 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 17:08:07 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 17:08:07 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 17:08:08 INFO - building 'psutil._psutil_posix' extension 17:08:08 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 17:08:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:08:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:08:08 INFO - ^ 17:08:08 INFO - 1 warning generated. 17:08:08 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 17:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:08 INFO - Successfully installed psutil 17:08:08 INFO - Cleaning up... 17:08:08 INFO - Return code: 0 17:08:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:08 INFO - 'HOME': '/Users/cltbld', 17:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:08 INFO - 'LOGNAME': 'cltbld', 17:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:08 INFO - 'MOZ_NO_REMOTE': '1', 17:08:08 INFO - 'NO_EM_RESTART': '1', 17:08:08 INFO - 'PAGER': '/bin/cat', 17:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:08 INFO - 'PWD': '/builds/slave/test', 17:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:08 INFO - 'SHELL': '/bin/bash', 17:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:08 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:08 INFO - 'USER': 'cltbld', 17:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:08 INFO - 'XPC_FLAGS': '0x0', 17:08:08 INFO - 'XPC_SERVICE_NAME': '0', 17:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:08 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 17:08:08 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 17:08:08 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 17:08:08 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 17:08:08 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 17:08:08 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 17:08:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:11 INFO - Installing collected packages: mozsystemmonitor 17:08:11 INFO - Running setup.py install for mozsystemmonitor 17:08:11 INFO - Successfully installed mozsystemmonitor 17:08:11 INFO - Cleaning up... 17:08:11 INFO - Return code: 0 17:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', '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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08: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 blobuploader==1.2.4 17:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:11 INFO - 'HOME': '/Users/cltbld', 17:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:11 INFO - 'LOGNAME': 'cltbld', 17:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:11 INFO - 'MOZ_NO_REMOTE': '1', 17:08:11 INFO - 'NO_EM_RESTART': '1', 17:08:11 INFO - 'PAGER': '/bin/cat', 17:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:11 INFO - 'PWD': '/builds/slave/test', 17:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:11 INFO - 'SHELL': '/bin/bash', 17:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:11 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:11 INFO - 'USER': 'cltbld', 17:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:11 INFO - 'XPC_FLAGS': '0x0', 17:08:11 INFO - 'XPC_SERVICE_NAME': '0', 17:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:15 INFO - Downloading docopt-0.6.1.tar.gz 17:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:15 INFO - Running setup.py install for blobuploader 17:08:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:15 INFO - Running setup.py install for requests 17:08:16 INFO - Running setup.py install for docopt 17:08:16 INFO - Successfully installed blobuploader requests docopt 17:08:16 INFO - Cleaning up... 17:08:16 INFO - Return code: 0 17:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:16 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:16 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 17:08:16 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 17:08:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:16 INFO - 'HOME': '/Users/cltbld', 17:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:16 INFO - 'LOGNAME': 'cltbld', 17:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:16 INFO - 'MOZ_NO_REMOTE': '1', 17:08:16 INFO - 'NO_EM_RESTART': '1', 17:08:16 INFO - 'PAGER': '/bin/cat', 17:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:16 INFO - 'PWD': '/builds/slave/test', 17:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:16 INFO - 'SHELL': '/bin/bash', 17:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:16 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:16 INFO - 'USER': 'cltbld', 17:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:16 INFO - 'XPC_FLAGS': '0x0', 17:08:16 INFO - 'XPC_SERVICE_NAME': '0', 17:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-I6o_CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Wr2Rbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xRNPpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-yhZQKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-1ICAXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xk5Y_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Og_AOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-x1A3_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-iNsyDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-pR9k84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-w1Ny5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-stgZu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-B3e5IJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-WoJ8tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ac64gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:18 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-EgnJ3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:18 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-aBaZFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:18 INFO - Running setup.py install for manifestparser 17:08:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:18 INFO - Running setup.py install for mozcrash 17:08:18 INFO - Running setup.py install for mozdebug 17:08:18 INFO - Running setup.py install for mozdevice 17:08:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:18 INFO - Running setup.py install for mozfile 17:08:18 INFO - Running setup.py install for mozhttpd 17:08:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Running setup.py install for mozinfo 17:08:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Running setup.py install for mozInstall 17:08:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Running setup.py install for mozleak 17:08:19 INFO - Running setup.py install for mozlog 17:08:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Running setup.py install for moznetwork 17:08:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:19 INFO - Running setup.py install for mozprocess 17:08:20 INFO - Running setup.py install for mozprofile 17:08:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Running setup.py install for mozrunner 17:08:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Running setup.py install for mozscreenshot 17:08:20 INFO - Running setup.py install for moztest 17:08:20 INFO - Running setup.py install for mozversion 17:08:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:20 INFO - Cleaning up... 17:08:20 INFO - Return code: 0 17:08:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:20 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 17:08:20 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 17:08:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:20 INFO - 'HOME': '/Users/cltbld', 17:08:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:20 INFO - 'LOGNAME': 'cltbld', 17:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:20 INFO - 'MOZ_NO_REMOTE': '1', 17:08:20 INFO - 'NO_EM_RESTART': '1', 17:08:20 INFO - 'PAGER': '/bin/cat', 17:08:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:20 INFO - 'PWD': '/builds/slave/test', 17:08:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:20 INFO - 'SHELL': '/bin/bash', 17:08:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:20 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:20 INFO - 'USER': 'cltbld', 17:08:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:20 INFO - 'XPC_FLAGS': '0x0', 17:08:20 INFO - 'XPC_SERVICE_NAME': '0', 17:08:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ZO6wv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-V7YDe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ioDwgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-na_uXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-UnrTp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-MSUOGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-BJLZkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-RKWXAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:21 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)) 17:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-o5D4AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-9DjwaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-zf7KBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-wZgPYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-yCtZmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-RK5xDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-iE0PVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-eyWIqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:22 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)) 17:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-oQxkL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:22 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)) 17:08:22 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)) 17:08:22 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)) 17:08:22 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)) 17:08:22 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)) 17:08:22 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)) 17:08:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:22 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 17:08:22 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 17:08:22 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 17:08:22 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 17:08:22 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 17:08:22 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 17:08:25 INFO - Downloading blessings-1.6.tar.gz 17:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:25 INFO - Installing collected packages: blessings 17:08:25 INFO - Running setup.py install for blessings 17:08:25 INFO - Successfully installed blessings 17:08:25 INFO - Cleaning up... 17:08:25 INFO - Return code: 0 17:08:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:25 INFO - Reading from file tmpfile_stdout 17:08:25 INFO - Current package versions: 17:08:25 INFO - blessings == 1.6 17:08:25 INFO - blobuploader == 1.2.4 17:08:25 INFO - docopt == 0.6.1 17:08:25 INFO - manifestparser == 1.1 17:08:25 INFO - mozInstall == 1.12 17:08:25 INFO - mozcrash == 0.17 17:08:25 INFO - mozdebug == 0.1 17:08:25 INFO - mozdevice == 0.48 17:08:25 INFO - mozfile == 1.2 17:08:25 INFO - mozhttpd == 0.7 17:08:25 INFO - mozinfo == 0.9 17:08:25 INFO - mozleak == 0.1 17:08:25 INFO - mozlog == 3.1 17:08:25 INFO - moznetwork == 0.27 17:08:25 INFO - mozprocess == 0.22 17:08:25 INFO - mozprofile == 0.28 17:08:25 INFO - mozrunner == 6.11 17:08:25 INFO - mozscreenshot == 0.1 17:08:25 INFO - mozsystemmonitor == 0.0 17:08:25 INFO - moztest == 0.7 17:08:25 INFO - mozversion == 1.4 17:08:25 INFO - psutil == 3.1.1 17:08:25 INFO - requests == 1.2.3 17:08:25 INFO - wsgiref == 0.1.2 17:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:25 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:25 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 17:08:25 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 17:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:25 INFO - 'HOME': '/Users/cltbld', 17:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:25 INFO - 'LOGNAME': 'cltbld', 17:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:25 INFO - 'MOZ_NO_REMOTE': '1', 17:08:25 INFO - 'NO_EM_RESTART': '1', 17:08:25 INFO - 'PAGER': '/bin/cat', 17:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:25 INFO - 'PWD': '/builds/slave/test', 17:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:25 INFO - 'SHELL': '/bin/bash', 17:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:25 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:25 INFO - 'USER': 'cltbld', 17:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:25 INFO - 'XPC_FLAGS': '0x0', 17:08:25 INFO - 'XPC_SERVICE_NAME': '0', 17:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 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)) 17:08:26 INFO - Cleaning up... 17:08:26 INFO - Return code: 0 17:08:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08:26 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')]} 17:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 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')]} 17:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:26 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 17:08:26 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 17:08:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:26 INFO - 'HOME': '/Users/cltbld', 17:08:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:26 INFO - 'LOGNAME': 'cltbld', 17:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:26 INFO - 'MOZ_NO_REMOTE': '1', 17:08:26 INFO - 'NO_EM_RESTART': '1', 17:08:26 INFO - 'PAGER': '/bin/cat', 17:08:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:26 INFO - 'PWD': '/builds/slave/test', 17:08:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:26 INFO - 'SHELL': '/bin/bash', 17:08:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:26 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:26 INFO - 'USER': 'cltbld', 17:08:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:26 INFO - 'XPC_FLAGS': '0x0', 17:08:26 INFO - 'XPC_SERVICE_NAME': '0', 17:08:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:26 INFO - Downloading/unpacking jsonschema 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:29 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08:29 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 17:08:29 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 17:08:29 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 17:08:29 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 17:08:29 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 17:08:29 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 17:08:29 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:29 INFO - warning: no files found matching '*.txt' 17:08:29 INFO - no previously-included directories found matching 'build' 17:08:29 INFO - no previously-included directories found matching 'dist' 17:08:29 INFO - no previously-included directories found matching '.git*' 17:08:29 INFO - Installing collected packages: jsonschema, functools32 17:08:29 INFO - Running setup.py install for functools32 17:08:29 INFO - warning: no files found matching '*.txt' 17:08:29 INFO - no previously-included directories found matching 'build' 17:08:29 INFO - no previously-included directories found matching 'dist' 17:08:29 INFO - no previously-included directories found matching '.git*' 17:08:29 INFO - Successfully installed jsonschema functools32 17:08:29 INFO - Cleaning up... 17:08:29 INFO - Return code: 0 17:08:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 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 0x107929a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107939420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80249f3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, '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.YpFqIgUp61/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.v8JITREnlq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 17:08:30 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 17:08:30 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 17:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:30 INFO - 'HOME': '/Users/cltbld', 17:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:30 INFO - 'LOGNAME': 'cltbld', 17:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:30 INFO - 'MOZ_NO_REMOTE': '1', 17:08:30 INFO - 'NO_EM_RESTART': '1', 17:08:30 INFO - 'PAGER': '/bin/cat', 17:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:30 INFO - 'PWD': '/builds/slave/test', 17:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:30 INFO - 'SHELL': '/bin/bash', 17:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:08:30 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:30 INFO - 'USER': 'cltbld', 17:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:30 INFO - 'XPC_FLAGS': '0x0', 17:08:30 INFO - 'XPC_SERVICE_NAME': '0', 17:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:30 INFO - Downloading/unpacking flake8 17:08:30 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 17:08:30 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 17:08:30 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 17:08:30 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 17:08:30 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 17:08:30 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 17:08:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:34 INFO - no previously-included directories found matching 'docs/_build' 17:08:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:34 INFO - Running setup.py install for pep8 17:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:34 INFO - no previously-included directories found matching 'docs/_build' 17:08:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:34 INFO - Cleaning up... 17:08:34 INFO - Return code: 0 17:08:34 INFO - Running post-action listener: _resource_record_post_action 17:08:34 INFO - Running post-action listener: _start_resource_monitoring 17:08:34 INFO - Starting resource monitoring. 17:08:34 INFO - ##### 17:08:34 INFO - ##### Running install step. 17:08:34 INFO - ##### 17:08:34 INFO - Running pre-action listener: _resource_record_pre_action 17:08:34 INFO - Running main action method: install 17:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:35 INFO - Reading from file tmpfile_stdout 17:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:35 INFO - Reading from file tmpfile_stdout 17:08:35 INFO - Output received: 17:08:35 INFO - Usage: mozinstall [options] installer 17:08:35 INFO - Options: 17:08:35 INFO - -h, --help show this help message and exit 17:08:35 INFO - -d DEST, --destination=DEST 17:08:35 INFO - Directory to install application into. [default: 17:08:35 INFO - "/builds/slave/test"] 17:08:35 INFO - --app=APP Application being installed. [default: firefox] 17:08:35 INFO - mkdir: /builds/slave/test/build/application 17:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:09:09 INFO - Reading from file tmpfile_stdout 17:09:09 INFO - Output received: 17:09:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:09:09 INFO - Running post-action listener: _resource_record_post_action 17:09:09 INFO - ##### 17:09:09 INFO - ##### Running run-tests step. 17:09:09 INFO - ##### 17:09:09 INFO - Running pre-action listener: _resource_record_pre_action 17:09:09 INFO - Running main action method: run_tests 17:09:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:09:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:09:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:09:09 INFO - 2016-04-26 17:09:09.176 screenresolution[1645:8095] starting screenresolution argv=screenresolution get 17:09:09 INFO - 2016-04-26 17:09:09.178 screenresolution[1645:8095] Display 0: 1600x1200x32@60 17:09:09 INFO - 2016-04-26 17:09:09.184 screenresolution[1646:8097] starting screenresolution argv=screenresolution list 17:09:09 INFO - Available Modes on Display 0 17:09:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:09:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:09:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:09:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:09:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:09:09 INFO - Intel Iris: 17:09:09 INFO - Chipset Model: Intel Iris 17:09:09 INFO - Type: GPU 17:09:09 INFO - Bus: Built-In 17:09:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:09:09 INFO - Vendor: Intel (0x8086) 17:09:09 INFO - Device ID: 0x0a2e 17:09:09 INFO - Revision ID: 0x0009 17:09:09 INFO - Displays: 17:09:09 INFO - Display: 17:09:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:09:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:09:09 INFO - Display Serial Number: 1600x1200 60 17:09:09 INFO - Main Display: Yes 17:09:09 INFO - Mirror: Off 17:09:09 INFO - Online: Yes 17:09:09 INFO - Rotation: Supported 17:09:09 INFO - Return code: 0 17:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:09 INFO - Python 2.7.3 17:09:09 INFO - Return code: 0 17:09:09 INFO - grabbing minidump binary from tooltool 17:09:09 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')]} 17:09:09 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 0x1077c8e00>, '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 0x107631db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:09 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 17:09:09 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 17:09:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:09 INFO - Return code: 0 17:09:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:09:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:10 INFO - Return code: 0 17:09:10 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/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 17:09:10 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/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0110 --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 17:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YpFqIgUp61/Render', 17:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:10 INFO - 'HOME': '/Users/cltbld', 17:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:10 INFO - 'LOGNAME': 'cltbld', 17:09:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'PAGER': '/bin/cat', 17:09:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:10 INFO - 'PWD': '/builds/slave/test', 17:09:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:10 INFO - 'SHELL': '/bin/bash', 17:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v8JITREnlq/Listeners', 17:09:10 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 17:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:10 INFO - 'USER': 'cltbld', 17:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:10 INFO - 'XPC_FLAGS': '0x0', 17:09:10 INFO - 'XPC_SERVICE_NAME': '0', 17:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:10 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/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 17:09:10 INFO - mozversion application_buildid: 20160426144059 17:09:10 INFO - mozversion application_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 17:09:10 INFO - mozversion application_display_name: Nightly 17:09:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:10 INFO - mozversion application_name: Firefox 17:09:10 INFO - mozversion application_remotingname: firefox 17:09:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion application_vendor: Mozilla 17:09:10 INFO - mozversion application_version: 49.0a1 17:09:10 INFO - mozversion platform_buildid: 20160426144059 17:09:10 INFO - mozversion platform_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 17:09:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion platform_version: 49.0a1 17:09:10 INFO - using testdate: 1461715750 17:09:10 INFO - actual date: 1461715750 17:09:10 INFO - starting webserver on 'localhost:49271' 17:09:10 INFO - SUITE-START | Running 2 tests 17:09:10 INFO - TEST-START | dromaeo_css 17:09:10 INFO - operating with platform_type : mac_ 17:09:10 INFO - Initialising browser for dromaeo_css test... 17:09:10 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpLUyW88/profile http://localhost:49271/getInfo.html) 17:09:13 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 17:09:13 INFO - PROCESS | 1664 | colorDepth:24 17:09:13 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 17:09:13 INFO - PROCESS | 1664 | __metrics 17:09:14 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:09:14 INFO - TEST-INFO | 1664: exit 0 17:09:14 INFO - Browser initialized. 17:09:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:14 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpLUyW88/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:26 INFO - PROCESS | 1668 | RSS: Main: 249348096 17:09:26 INFO - PROCESS | 1668 | 17:10:16 INFO - PROCESS | 1668 | 1461715816253 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] 17:12:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 17:12:28 INFO - PROCESS | 1668 | RSS: Main: 261292032 17:12:28 INFO - PROCESS | 1668 | 17:15:30 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 17:15:30 INFO - PROCESS | 1668 | RSS: Main: 273240064 17:15:30 INFO - PROCESS | 1668 | 17:18:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 17:18:33 INFO - PROCESS | 1668 | RSS: Main: 275394560 17:18:33 INFO - PROCESS | 1668 | 17:21:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 17:21:35 INFO - PROCESS | 1668 | RSS: Main: 276971520 17:21:35 INFO - PROCESS | 1668 | 17:24:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 17:24:38 INFO - PROCESS | 1668 | RSS: Main: 279789568 17:24:38 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 17:27:41 INFO - PROCESS | 1668 | RSS: Main: 280981504 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | __start_tp_report 17:27:41 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 17:27:41 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 17:27:41 INFO - PROCESS | 1668 | |i|pagename|runs| 17:27:41 INFO - PROCESS | 1668 | |0;dojo.html;3513.5783705955287;3514.3849826280402;3535.2045789697304;3551.20097977955;3578.588462326833;5673.319201695802;5694.202811606373;5694.6867922264255;5706.258186435763;5746.827595172146;4758.262469317253;5767.855803604912;5867.002609556375;5942.019566771478;5966.194563733895;5237.86905327367;5285.6300058995885;5294.1529355303155;5322.680639161644;5352.652077614943;69.04613948748717;5274.05067087924;5291.920621190666;5299.8410047698635;5367.436419175989;5232.241325007872;5278.709670968095;5282.445343238962;5288.365396152448;5312.335958005249;5229.50319719626;5346.518813306782;5348.812791552277;5365.946340536584;5418.349798024223;5214.765335559909;5223.268742376071;5280.471952804727;5326.334208223972;5371.167469042305;5570.916436253459;5601.60788744788;5689.630174038674;5702.600817942745;5724.284464441945;5008.949910500921;6228.968855155696;6295.748170073191;6304.306526282106;6304.842378940517;6246.531510136758;6304.243490781089;6308.653024083674;6315.810525684236;6323.6521991290465;6022.45797878193;6026.939730602681;6032.276126864805;6032.849178770522;6061.060535616986;6172.197614310111;6309.716062777186;6350.33321501245;6386.872262554816;6401.487880969511;6287.591306565058;6314.463270621956;6334.271558770708;6349.333320001426;6354.23749150105;6253.53098517613;6310.558260921692;6326.588771729915;6328.968355158287;6332.715027823759;6172.043333283348;6214.844628884223;6271.3728627136925;6329.145565348619;6333.65164915934;5094.2613321068975;5673.546116310686;6265.373462653698;6272.435480806658;6275.02737075754;4957.702537847741;5022.748862556858;5029.446760856303;5035.5468007878735;5052.292679024939;4466.9553304466535;4477.552244775561;4533.5013148553635;4558;4593.173228818778;5921.822345329647;5946.137810017523;5987;6024.1265016573225;6044.214252147192;6303.6532990685955;6328.936710632926;6338.080978258126;6344.555881088372;6354.4281014708895;4772.188727916193;5127.615428842777;5892.204552385459;5943.8216853493595;5982.192404025488;4088.713790034669;4605.424321959755;5503.862403439866;5537.833864984057;5619.662820230799;6345.206849143857;6461;6470.5147113965695;6502.414782669583;6524.706388212542;6250.0937364082865;6300.779472718433;6326.810195694136;6331.2085989251345;6338.683065846782;6538.313477084837;6555.246146693191;6566.277709451861;6573.835654108686;6584.440322572635;5624.62196761796;5941.465268125889;6137;6161.815145545641;6193.38066193377;6224.221972253468;6288.905666414916;6307.463865571478;6318.873622527615;6346.873062538816;6062.545309101747;6226.221722284715;6228.377162283736;6248.656323902229;6255.78104766331;6135.416406698409;6145.846353841011;6206.224221972254;6237.126802247598;6240.563160578898;5677.630953987978;6049;6083.057126145454;6165.445109940127;6202.193714817045;6236.812895613139;6263.295553618134;6294.087357333253;6311.084892690443;6321.367863213642;6026.337102918763;6072.240969878765;6111.8777624446375;6140.140380346666;6173.043178307369 17:27:41 INFO - PROCESS | 1668 | |1;ext.html;494.1599281221921;509.86743446703855;536.9704666243355;594.0080066289296;628.3716283716284;36780.63219367809;37435.438468422995;37531.437028444525;37541.62458375416;37584.248315033685;38743.80628096856;39043.21913561727;39175.60824391755;39305;39457.40813887794;9393.90606093939;9594.136527712504;9619.278554108434;9631.807363852718;9656.662016829412;9500.429974201536;9631.951840240788;9635.951820240889;9645.903540964571;9656.951715241414;9616.56725447353;9629.903700963006;9665;9688.854667179998;9696.660616878411;9588.712338629852;9655.372400793996;9655.951720241424;9662.13040826322;9715.979822118647;9470.668526601605;9599.424034557878;9599.856002159973;9603.759906002337;9641.71074867748;37919.620803791884;38091.23817523662;38286;38324.23351532982;38338.80830595857;2696.3124403277234;2881.2652773542823;2950;3089.8258661708633;3340.1482621931495;25092.498150036896;25882.87058564714;26345.73654263452;26475;26753.866230668722;2595.156574113421;2614.9607755883676;2623.7245089265543;2637.591173368131;2817.760490358322;243968;304280;304984;305067.4746626275;305350.47324763454;33109.3378132436;33806.64773409085;57020;57893;57940;33715.15712107217;33876.32247355039;33934.98195054152;33952.15119622029;34083;13696.315184240748;13767.862321376859;14745.262736863115;14944.850551494346;14979.775303370458;12407.813882791765;12567.811482827765;12648.494060237488;12726.745465090646;12743.490260389666;7921.207879212033;8048.798780030546;8050.557219352875;8111.553864537507;8197.590120493951;3166.0027091466113;3177.968220317767;3410.4884267360094;3415.0949998250485;3441.6443967132345;981.288565789811;992.0525897767615;1014.7564584499667;1141.298101667485;1157.7337212441016;28761.99333023334;29004.564931526045;29059.418811623647;29443.558346624817;29717.257068573457;1006.5923301063082;1091.6070214722693;1100.3452945497415;1105.7180418993266;1124.3197865291545;14987.550373488813;15072.924635376752;15318.238402583622;15356.846431535765;15447.30487128082;347018;358569;359214;359281;460993;48037.75981120072;57172;57821.71089144611;57912;58618;1447.862453066957;1465.1502128765292;1469.6472846516972;1471.0438215160232;1476.4389531977995;28781.424371512872;29323.41353172967;29455.410891782474;30157.944471943378;30178.54732179063;50650.48048558549;51279.97440051103;51424.74287628538;51425.7428712869;51517.484825152766;438006.0996950076;441786;447900.0419991517;451960;454202;26756.732432675424;26773.598396023684;27029.59455608128;27295;27322;42355;42532.5746742541;42787.14425711531;43521;43570.128597428506;36218.45672314864;36256.63743362533;36477.08807279839;37157;37218.62781372152;35688.286234275685;35951.64048359483;36089.639103609676;36329.29277905769;36692.44961325636;29045.419091617627;33453.498197527544;34345.656543435245;35611.465828012086;35672;28869.711302886702;29377.559336610397;30696;31637.837244353206;31723.206919826265;19569.217231310588;23020.884895575415;23339;23992;24046.75953240515 17:27:41 INFO - PROCESS | 1668 | |2;jquery.html;349.2891964851527;390.36955317162773;399.5145897734253;404.43379269023364;407.8266736636932;18111.184996675147;18207.726884096734;20089.095990680416;20416.591668166628;20438.2846600369;18101;19594.21623135073;19623.01884905756;20757.584848303024;20792.688109678365;5283.233931079991;5350.8127215547465;5659.094544872832;5770.682612456313;5885.558583106263;5449.3188351456065;5762.4525670061275;5845.473907348338;5864.677442740647;5887.910736513737;5714.885702285952;5763.193152958589;5778.133280007991;5779.682117483537;5856.824295271127;5689.658620482743;5784.16129661201;5795.101759227306;5812.447817457335;5834.6790926499025;4982.775775090094;5032.597392208614;5069.797208111671;5085.5931525478245;5124.256982737482;21684;22562.984665690085;24212;24794.628080578805;25115.37211569707;2004.1983206717284;2099.8215151712125;2139.037433155071;2238.0935721033006;2244.2930476899724;11454.713632159179;12760.617181484571;13227.66930826737;14686.63283417923;14851.628709282246;1409.78853172024;1716.605180808421;1730.134932533733;1775.112443778111;1813.4468986959105;97758.53362199572;99014.5640533363;99757.00485990311;103174.42063948461;103410.48294758554;8870.556472176366;8947.686830960885;9535.90464095364;10394.584216631401;10597.89402105969;13735.381907814173;13778.862211377758;13804.516841910485;13816;13824.516141934984;8493.362997775192;8571.357148213785;8703.65001449605;8841.381103322705;8866.42368246062;7240.493165478471;8740.344474164463;8771.605277762515;8805.42764720291;8916.777080572907;6563.3764792344655;6688.7324507019175;6706.418029058847;6714.731410743613;6733.696983635748;1848.5655870870335;1879.595886884299;1882.2000649723814;1883.3784850999136;1910.4937191644226;964.358701463533;997.8553109799038;1036.9325993810378;1063.984040239397;1066.8453074304182;20006;20528.87091209968;20701.964901755153;20776.48058798512;21064;963.3352986439335;1038.190211634926;1040.9063184313297;1045.11165509318;1076.9299995500423;10874.782504349869;11321.037711794424;11369.943150284196;11370.31778093317;11393.658190254306;595501;596072;600316;622231;626057;80253;100620.49689751504;100802;101130.49434752927;101523.49238253909;1036.7511797168625;1041.2138835179542;1056.1497994114657;1060.0618452669444;1061.4851796878509;17634.470965871045;17793.73309400386;17802.91098544499;17975.820241797413;18356.5314774815;34040.82979585086;45846.31230531478;48131.315403960696;49878;49928.500714992384;67963;68937.65531172312;70250.64874675593;70684.29315706778;70817.93773093304;7713.151553329241;7819.0617125945255;7998.520088794691;8002.1997800219515;8303.958480207802;11396.772064558829;11404.885951140714;12152.027837772781;12357.505699771908;12360.75278494443;10388.324758890649;10439.739006524898;10801.433792099944;10804.621838235624;10845.403502807105;8709.259712924219;10240.129588985019;10271.537780800032;10367.585296588051;10557.683269501927;10562.683119506428;10795.892041079804;10842.403667798031;10844.566217351217;10888.29226100301;7491.213422590549;8032.558209298545;8192.057913339804;8237.299829514559;8255.834883302181;9646.9035309646;10798.974097460728;10915.781684366428;10976.670699879016;11125.83311250348 17:27:41 INFO - PROCESS | 1668 | |3;mootools.html;1568.4118455579155;1618.5953511622095;1863.2081365419701;1918.1464248409463;1941.679622862228;7366.5948372839475;7574.09110906692;8575.271101956334;8630.827383452328;8978.057303983085;8596.054434012254;8611.397202195849;8678.045415004344;8760.912390876088;8781.692640757576;2443.7434069422675;2493.6259561065895;2497;2504.8622325772076;2513.3339664988794;2446.645236440715;2481.5409149307347;2483.044028049205;2487.141936032066;2492.6136448850366;2463.7289898111194;2469.8271121021535;2475.752424757519;2479.231438254138;2511;2457.582211024121;2464.2360868130845;2468.839525430841;2474.39377352548;2478.6405971134177;2428.1380110061027;2453.116877923946;2476.0962248779247;2482.2181012980855;2493.47636996231;8842.027376988526;8851.114888511162;8916.15296546827;8933.955330223307;8945.955270223607;5271.736413179326;5480.506754392124;5492.945070549324;5508.862278443031;5518.392976772552;3073.800202986799;3646.1431563582537;3658.5975542690285;3685.3182161300247;3700.4634328022285;879.9912000879973;1050.2858056521563;1058.650220968264;1060.1359891688248;1064.3826580583243;11553.480093395818;11613.3612651305;11672.124590655734;11673.416329183507;11674.35791031493;4819.277108433763;4850.369451971221;4960.379952505937;4961.5534601886;4986.252062190701;9886.752831179278;9924.801503970024;9953.25350598708;9969.651062212788;10022.198224142052;5383.057964856134;5452.809151679672;5454.236406903036;5468.316460442445;5491.945080549223;4448.110377924428;4853.975730121398;4902.50974902514;4997.725125118153;4997.9750101249265;3307.5534802801794;3989.9202015959518;4069.9796501017304;4096.160287141129;4138.627523522898;1162;1358.9184648921096;1374.4914381678843;1375.4223226245;1378.696686728918;832.5795473286073;928.4336554701626;931.8509038553799;945.6949409814412;968;5826.533877289807;5909.379515150933;5959.106134079922;5972.790952316648;6053.757849685963;448.9887752806206;463.4947906781624;464.6538328944958;470.4025887123403;470.8822794301425;3906.628870257321;3908.511436070491;3981.6416522513114;4017.5580686124504;4030.2544029354663;10418.479076046318;10836.891631083747;10901;10925.945370273097;10978.011978921775;10809.40548269837;10871.510782014828;10889.673309800719;10949.83575246372;10979.780404391868;7955.84088318242;8312.33501319893;8344.04043534989;8352.373571982125;8357.749267521984;5733.455321744427;5829.979753543198;5868.295804503487;5964.970175149097;5968;10036.799264014824;10146.898531014594;10150.796984060129;10219.335743176967;10467.424291664032;8357.791055223668;9922.900770992486;9934.354266972623;10174.440405777754;10381.429021403896;6856.794296171123;7252.347288744038;7491.325780679765;7500.762374208194;7579.772606821804;8251.33989280868;8255;8320.791980200302;8352.540610266493;8403.579821008803;7246.1666908306215;7396.9260307396235;7403.222661620668;7501.5372002459;7559.1306999695735;6485.416312531895;6669.199696036507;6922.411595014481;7192.532485388433;7422.851542969219;6888.242293347828;6901.689423975833;6961.825954351182;6986.930130698628;7010.298970102949;4536.206163921366;4918.778654960607;4921.630877684116;4992.775325110451;5132.358455193101;4949.232868905326;4949.727764972961;4986.526280003394;5052.646314758079;5242.764075616683 17:27:41 INFO - PROCESS | 1668 | |4;prototype.html;319.11445738076833;320.97913635613685;324.8359578412901;329.95710557627507;330.1037682691492;5578.9163162552495;5631.436856314372;5705.400932902048;5727.742251598677;5774.624649397786;5001.674891132083;5111.1566591512355;5469.425710300421;5576.693281869496;5668.489835914766;3718.9442158367647;3879.758477287269;4010.1177740896956;4176.914002359378;4299.764122656217;4281.993731473101;4286.7856607169515;4287.33432914858;4292.1630282095;4317.15815415994;3886.844526218962;3954.248692748383;4084.774567629714;4289.5924887135825;4304.160688665712;3559.9644003559893;3753.474513568103;4157.605027522381;4282.97208669917;4307;2943.5878976943245;2980.4650604938474;3279.8032118072992;3530.1880567469625;3763.6424539668687;5480.177179411618;5489.725513724337;5492.5605951523785;5493.533049690741;5543.417941116206;4520.163769702583;4525;4643.885467487778;4755.144074066667;5035.244713292998;5343.011542864582;5832.6500409975115;5984.521238300969;5997.4002599740115;6024.96987515064;4076.7769669099152;4176.331786914079;4184.958150418487;4190.28765109929;4190.790460476964;5237.3453318335205;5989.3711160327975;6248.187735594343;6273.404026617464;6273.96863015682;4194.727342722713;4234.597713217239;4238.427812245369;4240.045989652303;4251.256030194703;3471.5834099908175;4134.565870583606;4314.92126968258;4324.200022995756;4342.913141737147;3772.07584141887;4209.884380639133;4596.218642830727;4919.114559379346;5009.273655319958;5169.810943482945;5956.493698035715;6076.875777981088;6080.361562036011;6088.665123418255;1453.556665217119;1505.9774103388459;1520.4035762449384;1521.1025494957807;1521.8706409955057;921.6083164654995;964.1756298364797;978.9608415663436;983.9754006149903;1003.9698809035741;4717.882052948635;6015.54883383748;6029.728662210211;6051.394860513913;6082.878342433127;6696.83257918556;6701.32986701326;6720.764773232913;6721.8655626887185;6725.831854203684;5281.577473802086;5842.509665736831;5926.170336152942;6030.819075427744;6043.848903777441;2910.388818348128;2915.927101822429;3260.820654864005;3352.8265107212283;3514.191735900706;6383.563698167968;6657.300983396771;6920.30796920314;6946.583205007716;7001.964990175016;5723.56748381936;5947.345791962881;6589.912664410319;6868.759593414306;6869.107016087876;6773.593584384953;6793.932060679429;6933.237343892067;6957.825304817069;6983.720651173998;6559.901601475886;6650.501212408992;6653.73385064592;6687.899681504684;6814.284500127415;5318.202269659582;6413.294537600954;6547.050677651809;6589.143411356493;6589.934100658932;6424.93575064262;6466.540400885504;6848.623325717133;6919;6971.407430368476;4328.588784065509;4353.455818022747;4355.520892701737;4356.346548017823;4367.737935723867;6289;6615.4046135848;6643.634600097041;6662.133922590032;6672.299408562031;5382.67703937765;6428.357164283534;6462.579932304385;6473.838154046187;6505.121808555785;5875.794347197828;6268.498520118471;6392.913204755296;6438.710258038306;6440.935590644033;5623.409541998195;5724.8282551523525;5862.560307976833;6257.342978987323;6287.528435367457;5632.5212356950115;6040.969795150996;6053.727582258721;6057.969710151421;6093.6039157454625;4965.975170124127;5818.418158184148;5914.290285165807;5937;5956.970215148896 17:27:41 INFO - PROCESS | 1668 | |5;yui.html;633.7148283272528;690.9585424874512;727.7234650832683;746.0599644447993;808.3452403553121;14796.778048329285;14882.330295136719;14991.775123373158;15126.470573529929;15145.939784215096;13074.934625326883;13828.446862125527;13920;13928.582142535715;13936.51222207223;895.3553441522093;895.5164211325877;898.0032164297625;905.8641203819413;928.3872644054925;717.4117223876424;877.55244825139;878.925291350236;898.0660113482004;902.8465160922626;955.5126885288483;960.812641534901;961.9903800962006;962.451402700461;963.1764841060897;925.0795458518784;925.8102089071724;935.2377812083131;952.618952419031;957.1481381570374;700.422151724824;705.9258777828356;708.7342246657504;709.0781983421531;711.2460791560962;15226.543203703906;15339.539813805604;15618.843811561852;15648.530544083696;15681.059136451735;11897.405129743565;11966.34185119818;12014;12102.334371609559;12397;9942.204623630165;10041.899581004169;10168.034036766569;10297.176225901985;10927.59717720393;3476.6349533298894;3580.6777390034763;3582.3551760683067;3647.361711700442;3685.94471082934;85361.57319213364;85673.57163214144;86409;87498;87858.56070719605;9279.118483744034;9302;9523.238140948708;9653.372530785617;9708.077732615391;21612;21620.243291485036;21669.67495487569;21700.891495542422;21710.89144554267;7200.387967022757;7254;7339.119305683352;7356.632168391559;7511.51175173612;3990.68074554035;4065.2479291331197;4067.491563554556;4072.9592704073175;4074.8370065197655;3495.3358861816173;3544.4683297505067;3571.3035957987945;3586.6592673696478;3587.497750314958;544.8256557901434;563.0259650804131;573.5669569475103;645.1065274594627;686.4268335939546;486.3021564055592;530.2523441946836;543.728135932034;578.7222133375919;609.6159419565645;8088.150744171895;8242.670293188325;8246.752597422086;8419.915800842036;8454.239118479367;501.8845665496956;524.3524247554268;570.7146426786607;574.4026212738788;597.0983814440226;3639.781613103169;3803.2963901678277;3912.7847968361443;3945.64489195968;4028.617281358266;100312.99687003037;100400.49399259017;100666;102763;107067.46466267618;83287;87031.69452458218;88370.69775813472;88680;88721.66917496243;56463.71768141215;68384.6580767093;77622;77837;77885.61057194677;6022.397760223943;6662.866742665216;7783.961080194563;7909.683612655429;7961.641726122222;46709;47246.27537246248;47422;47530.76234618805;48930.77673058202;65796.34203657902;70431.64784176047;71617;71621.28378716146;71955.92066119116;9958.701238962843;10227.693169204937;10396;10453.581856725647;10571.418571978615;10153.543090560795;10593.675790526184;11463.942680286546;11485.138614603771;11572.710682233012;9346.579403926704;10218.335808172445;10275.972402759964;10656.360618362924;10830.783384332111;10485.580576776843;10766.623168189075;10936;11022.173336999918;11058.668239952814;10587.470626468492;10762.677119686421;10790.406527641055;10949.781004380027;10961.56153753841;8241.50550966944;9204.953975230348;9208.539573021457;9455.858162127712;9642.276829237695;9097.863532047157;9109.726708198765;9166.312526560401;9210.815783684422;9236.538173091452 17:27:41 INFO - PROCESS | 1668 | __end_tp_report 17:27:41 INFO - PROCESS | 1668 | __start_cc_report 17:27:41 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,417 17:27:41 INFO - PROCESS | 1668 | __end_cc_report 17:27:41 INFO - PROCESS | 1668 | __startTimestamp1461716861828__endTimestamp 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | ------- Summary: start ------- 17:27:41 INFO - PROCESS | 1668 | Number of tests: 6 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5771.92 Median:6062.55 stddev:803.41 (13.3%) stddev-sans-first:786.09 17:27:41 INFO - PROCESS | 1668 | Values: 3513.6 3514.4 3535.2 3551.2 3578.6 5673.3 5694.2 5694.7 5706.3 5746.8 4758.3 5767.9 5867.0 5942.0 5966.2 5237.9 5285.6 5294.2 5322.7 5352.7 69.0 5274.1 5291.9 5299.8 5367.4 5232.2 5278.7 5282.4 5288.4 5312.3 5229.5 5346.5 5348.8 5365.9 5418.3 5214.8 5223.3 5280.5 5326.3 5371.2 5570.9 5601.6 5689.6 5702.6 5724.3 5008.9 6229.0 6295.7 6304.3 6304.8 6246.5 6304.2 6308.7 6315.8 6323.7 6022.5 6026.9 6032.3 6032.8 6061.1 6172.2 6309.7 6350.3 6386.9 6401.5 6287.6 6314.5 6334.3 6349.3 6354.2 6253.5 6310.6 6326.6 6329.0 6332.7 6172.0 6214.8 6271.4 6329.1 6333.7 5094.3 5673.5 6265.4 6272.4 6275.0 4957.7 5022.7 5029.4 5035.5 5052.3 4467.0 4477.6 4533.5 4558.0 4593.2 5921.8 5946.1 5987.0 6024.1 6044.2 6303.7 6328.9 6338.1 6344.6 6354.4 4772.2 5127.6 5892.2 5943.8 5982.2 4088.7 4605.4 5503.9 5537.8 5619.7 6345.2 6461.0 6470.5 6502.4 6524.7 6250.1 6300.8 6326.8 6331.2 6338.7 6538.3 6555.2 6566.3 6573.8 6584.4 5624.6 5941.5 6137.0 6161.8 6193.4 6224.2 6288.9 6307.5 6318.9 6346.9 6062.5 6226.2 6228.4 6248.7 6255.8 6135.4 6145.8 6206.2 6237.1 6240.6 5677.6 6049.0 6083.1 6165.4 6202.2 6236.8 6263.3 6294.1 6311.1 6321.4 6026.3 6072.2 6111.9 6140.1 6173.0 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:51289.16 Median:35680.14 stddev:100318.41 (281.2%) stddev-sans-first:100527.33 17:27:41 INFO - PROCESS | 1668 | Values: 494.2 509.9 537.0 594.0 628.4 36780.6 37435.4 37531.4 37541.6 37584.2 38743.8 39043.2 39175.6 39305.0 39457.4 9393.9 9594.1 9619.3 9631.8 9656.7 9500.4 9632.0 9636.0 9645.9 9657.0 9616.6 9629.9 9665.0 9688.9 9696.7 9588.7 9655.4 9656.0 9662.1 9716.0 9470.7 9599.4 9599.9 9603.8 9641.7 37919.6 38091.2 38286.0 38324.2 38338.8 2696.3 2881.3 2950.0 3089.8 3340.1 25092.5 25882.9 26345.7 26475.0 26753.9 2595.2 2615.0 2623.7 2637.6 2817.8 243968.0 304280.0 304984.0 305067.5 305350.5 33109.3 33806.6 57020.0 57893.0 57940.0 33715.2 33876.3 33935.0 33952.2 34083.0 13696.3 13767.9 14745.3 14944.9 14979.8 12407.8 12567.8 12648.5 12726.7 12743.5 7921.2 8048.8 8050.6 8111.6 8197.6 3166.0 3178.0 3410.5 3415.1 3441.6 981.3 992.1 1014.8 1141.3 1157.7 28762.0 29004.6 29059.4 29443.6 29717.3 1006.6 1091.6 1100.3 1105.7 1124.3 14987.6 15072.9 15318.2 15356.8 15447.3 347018.0 358569.0 359214.0 359281.0 460993.0 48037.8 57172.0 57821.7 57912.0 58618.0 1447.9 1465.2 1469.6 1471.0 1476.4 28781.4 29323.4 29455.4 30157.9 30178.5 50650.5 51280.0 51424.7 51425.7 51517.5 438006.1 441786.0 447900.0 451960.0 454202.0 26756.7 26773.6 27029.6 27295.0 27322.0 42355.0 42532.6 42787.1 43521.0 43570.1 36218.5 36256.6 36477.1 37157.0 37218.6 35688.3 35951.6 36089.6 36329.3 36692.4 29045.4 33453.5 34345.7 35611.5 35672.0 28869.7 29377.6 30696.0 31637.8 31723.2 19569.2 23020.9 23339.0 23992.0 24046.8 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:33376.09 Median:11911.52 stddev:100291.72 (842.0%) stddev-sans-first:100542.40 17:27:41 INFO - PROCESS | 1668 | Values: 349.3 390.4 399.5 404.4 407.8 18111.2 18207.7 20089.1 20416.6 20438.3 18101.0 19594.2 19623.0 20757.6 20792.7 5283.2 5350.8 5659.1 5770.7 5885.6 5449.3 5762.5 5845.5 5864.7 5887.9 5714.9 5763.2 5778.1 5779.7 5856.8 5689.7 5784.2 5795.1 5812.4 5834.7 4982.8 5032.6 5069.8 5085.6 5124.3 21684.0 22563.0 24212.0 24794.6 25115.4 2004.2 2099.8 2139.0 2238.1 2244.3 11454.7 12760.6 13227.7 14686.6 14851.6 1409.8 1716.6 1730.1 1775.1 1813.4 97758.5 99014.6 99757.0 103174.4 103410.5 8870.6 8947.7 9535.9 10394.6 10597.9 13735.4 13778.9 13804.5 13816.0 13824.5 8493.4 8571.4 8703.7 8841.4 8866.4 7240.5 8740.3 8771.6 8805.4 8916.8 6563.4 6688.7 6706.4 6714.7 6733.7 1848.6 1879.6 1882.2 1883.4 1910.5 964.4 997.9 1036.9 1064.0 1066.8 20006.0 20528.9 20702.0 20776.5 21064.0 963.3 1038.2 1040.9 1045.1 1076.9 10874.8 11321.0 11369.9 11370.3 11393.7 595501.0 596072.0 600316.0 622231.0 626057.0 80253.0 100620.5 100802.0 101130.5 101523.5 1036.8 1041.2 1056.1 1060.1 1061.5 17634.5 17793.7 17802.9 17975.8 18356.5 34040.8 45846.3 48131.3 49878.0 49928.5 67963.0 68937.7 70250.6 70684.3 70817.9 7713.2 7819.1 7998.5 8002.2 8304.0 11396.8 11404.9 12152.0 12357.5 12360.8 10388.3 10439.7 10801.4 10804.6 10845.4 8709.3 10240.1 10271.5 10367.6 10557.7 10562.7 10795.9 10842.4 10844.6 10888.3 7491.2 8032.6 8192.1 8237.3 8255.8 9646.9 10799.0 10915.8 10976.7 11125.8 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5723.73 Median:4949.48 stddev:3190.27 (64.5%) stddev-sans-first:3183.94 17:27:41 INFO - PROCESS | 1668 | Values: 1568.4 1618.6 1863.2 1918.1 1941.7 7366.6 7574.1 8575.3 8630.8 8978.1 8596.1 8611.4 8678.0 8760.9 8781.7 2443.7 2493.6 2497.0 2504.9 2513.3 2446.6 2481.5 2483.0 2487.1 2492.6 2463.7 2469.8 2475.8 2479.2 2511.0 2457.6 2464.2 2468.8 2474.4 2478.6 2428.1 2453.1 2476.1 2482.2 2493.5 8842.0 8851.1 8916.2 8934.0 8946.0 5271.7 5480.5 5492.9 5508.9 5518.4 3073.8 3646.1 3658.6 3685.3 3700.5 880.0 1050.3 1058.7 1060.1 1064.4 11553.5 11613.4 11672.1 11673.4 11674.4 4819.3 4850.4 4960.4 4961.6 4986.3 9886.8 9924.8 9953.3 9969.7 10022.2 5383.1 5452.8 5454.2 5468.3 5491.9 4448.1 4854.0 4902.5 4997.7 4998.0 3307.6 3989.9 4070.0 4096.2 4138.6 1162.0 1358.9 1374.5 1375.4 1378.7 832.6 928.4 931.9 945.7 968.0 5826.5 5909.4 5959.1 5972.8 6053.8 449.0 463.5 464.7 470.4 470.9 3906.6 3908.5 3981.6 4017.6 4030.3 10418.5 10836.9 10901.0 10925.9 10978.0 10809.4 10871.5 10889.7 10949.8 10979.8 7955.8 8312.3 8344.0 8352.4 8357.7 5733.5 5830.0 5868.3 5965.0 5968.0 10036.8 10146.9 10150.8 10219.3 10467.4 8357.8 9922.9 9934.4 10174.4 10381.4 6856.8 7252.3 7491.3 7500.8 7579.8 8251.3 8255.0 8320.8 8352.5 8403.6 7246.2 7396.9 7403.2 7501.5 7559.1 6485.4 6669.2 6922.4 7192.5 7422.9 6888.2 6901.7 6961.8 6986.9 7010.3 4536.2 4918.8 4921.6 4992.8 5132.4 4949.2 4949.7 4986.5 5052.6 5242.8 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5024.41 Median:5631.98 stddev:1644.82 (29.2%) stddev-sans-first:1611.07 17:27:41 INFO - PROCESS | 1668 | Values: 319.1 321.0 324.8 330.0 330.1 5578.9 5631.4 5705.4 5727.7 5774.6 5001.7 5111.2 5469.4 5576.7 5668.5 3718.9 3879.8 4010.1 4176.9 4299.8 4282.0 4286.8 4287.3 4292.2 4317.2 3886.8 3954.2 4084.8 4289.6 4304.2 3560.0 3753.5 4157.6 4283.0 4307.0 2943.6 2980.5 3279.8 3530.2 3763.6 5480.2 5489.7 5492.6 5493.5 5543.4 4520.2 4525.0 4643.9 4755.1 5035.2 5343.0 5832.7 5984.5 5997.4 6025.0 4076.8 4176.3 4185.0 4190.3 4190.8 5237.3 5989.4 6248.2 6273.4 6274.0 4194.7 4234.6 4238.4 4240.0 4251.3 3471.6 4134.6 4314.9 4324.2 4342.9 3772.1 4209.9 4596.2 4919.1 5009.3 5169.8 5956.5 6076.9 6080.4 6088.7 1453.6 1506.0 1520.4 1521.1 1521.9 921.6 964.2 979.0 984.0 1004.0 4717.9 6015.5 6029.7 6051.4 6082.9 6696.8 6701.3 6720.8 6721.9 6725.8 5281.6 5842.5 5926.2 6030.8 6043.8 2910.4 2915.9 3260.8 3352.8 3514.2 6383.6 6657.3 6920.3 6946.6 7002.0 5723.6 5947.3 6589.9 6868.8 6869.1 6773.6 6793.9 6933.2 6957.8 6983.7 6559.9 6650.5 6653.7 6687.9 6814.3 5318.2 6413.3 6547.1 6589.1 6589.9 6424.9 6466.5 6848.6 6919.0 6971.4 4328.6 4353.5 4355.5 4356.3 4367.7 6289.0 6615.4 6643.6 6662.1 6672.3 5382.7 6428.4 6462.6 6473.8 6505.1 5875.8 6268.5 6392.9 6438.7 6440.9 5623.4 5724.8 5862.6 6257.3 6287.5 5632.5 6041.0 6053.7 6058.0 6093.6 4966.0 5818.4 5914.3 5937.0 5957.0 17:27:41 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18878.44 Median:572.14 stddev:27759.27 (4851.8%) stddev-sans-first:27803.34 17:27:41 INFO - PROCESS | 1668 | Values: 633.7 691.0 727.7 746.1 808.3 14796.8 14882.3 14991.8 15126.5 15145.9 13074.9 13828.4 13920.0 13928.6 13936.5 895.4 895.5 898.0 905.9 928.4 717.4 877.6 878.9 898.1 902.8 955.5 960.8 962.0 962.5 963.2 925.1 925.8 935.2 952.6 957.1 700.4 705.9 708.7 709.1 711.2 15226.5 15339.5 15618.8 15648.5 15681.1 11897.4 11966.3 12014.0 12102.3 12397.0 9942.2 10041.9 10168.0 10297.2 10927.6 3476.6 3580.7 3582.4 3647.4 3685.9 85361.6 85673.6 86409.0 87498.0 87858.6 9279.1 9302.0 9523.2 9653.4 9708.1 21612.0 21620.2 21669.7 21700.9 21710.9 7200.4 7254.0 7339.1 7356.6 7511.5 3990.7 4065.2 4067.5 4073.0 4074.8 3495.3 3544.5 3571.3 3586.7 3587.5 544.8 563.0 573.6 645.1 686.4 486.3 530.3 543.7 578.7 609.6 8088.2 8242.7 8246.8 8419.9 8454.2 501.9 524.4 570.7 574.4 597.1 3639.8 3803.3 3912.8 3945.6 4028.6 100313.0 100400.5 100666.0 102763.0 107067.5 83287.0 87031.7 88370.7 88680.0 88721.7 56463.7 68384.7 77622.0 77837.0 77885.6 6022.4 6662.9 7784.0 7909.7 7961.6 46709.0 47246.3 47422.0 47530.8 48930.8 65796.3 70431.6 71617.0 71621.3 71955.9 9958.7 10227.7 10396.0 10453.6 10571.4 10153.5 10593.7 11463.9 11485.1 11572.7 9346.6 10218.3 10276.0 10656.4 10830.8 10485.6 10766.6 10936.0 11022.2 11058.7 10587.5 10762.7 10790.4 10949.8 10961.6 8241.5 9205.0 9208.5 9455.9 9642.3 9097.9 9109.7 9166.3 9210.8 9236.5 17:27:41 INFO - PROCESS | 1668 | -------- Summary: end -------- 17:27:41 INFO - PROCESS | 1668 | 17:27:42 INFO - TEST-INFO | 1668: exit 0 17:27:42 INFO - TEST-OK | dromaeo_css | took 1111539ms 17:27:42 INFO - TEST-START | kraken 17:27:42 INFO - operating with platform_type : mac_ 17:27:42 INFO - Initialising browser for kraken test... 17:27:42 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpRGwgnP/profile http://localhost:49271/getInfo.html) 17:27:45 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 17:27:45 INFO - PROCESS | 1675 | colorDepth:24 17:27:45 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 17:27:45 INFO - PROCESS | 1675 | __metrics 17:27:45 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:27:46 INFO - TEST-INFO | 1675: exit 0 17:27:46 INFO - Browser initialized. 17:27:46 INFO - Running cycle 1/1 for kraken test... 17:27:46 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpRGwgnP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:58 INFO - PROCESS | 1678 | RSS: Main: 249417728 17:27:58 INFO - PROCESS | 1678 | 17:28:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:01 INFO - PROCESS | 1678 | RSS: Main: 261595136 17:28:01 INFO - PROCESS | 1678 | 17:28:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 17:28:05 INFO - PROCESS | 1678 | RSS: Main: 270831616 17:28:05 INFO - PROCESS | 1678 | 17:28:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 17:28:08 INFO - PROCESS | 1678 | RSS: Main: 274132992 17:28:08 INFO - PROCESS | 1678 | 17:28:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 17:28:11 INFO - PROCESS | 1678 | RSS: Main: 276172800 17:28:11 INFO - PROCESS | 1678 | 17:28:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:14 INFO - PROCESS | 1678 | RSS: Main: 276631552 17:28:14 INFO - PROCESS | 1678 | 17:28:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:17 INFO - PROCESS | 1678 | RSS: Main: 276762624 17:28:17 INFO - PROCESS | 1678 | 17:28:20 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:21 INFO - PROCESS | 1678 | RSS: Main: 276697088 17:28:21 INFO - PROCESS | 1678 | 17:28:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 17:28:25 INFO - PROCESS | 1678 | RSS: Main: 276930560 17:28:25 INFO - PROCESS | 1678 | 17:28:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:27 INFO - PROCESS | 1678 | RSS: Main: 276480000 17:28:27 INFO - PROCESS | 1678 | 17:28:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:29 INFO - PROCESS | 1678 | RSS: Main: 276717568 17:28:29 INFO - PROCESS | 1678 | 17:28:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:32 INFO - PROCESS | 1678 | RSS: Main: 276746240 17:28:32 INFO - PROCESS | 1678 | 17:28:35 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:36 INFO - PROCESS | 1678 | RSS: Main: 276746240 17:28:36 INFO - PROCESS | 1678 | 17:28:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:40 INFO - PROCESS | 1678 | RSS: Main: 276791296 17:28:40 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 17:28:42 INFO - PROCESS | 1678 | RSS: Main: 278495232 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | __start_tp_report 17:28:42 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 17:28:42 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 17:28:42 INFO - PROCESS | 1678 | |i|pagename|runs| 17:28:42 INFO - PROCESS | 1678 | |0;ai-astar;115;124;170;164;118;129;117;115;115;116 17:28:42 INFO - PROCESS | 1678 | |1;audio-beat-detection;159;126;147;201;123;143;141;121;170;121 17:28:42 INFO - PROCESS | 1678 | |2;audio-dft;196;197;207;238;196;195;214;194;205;195 17:28:42 INFO - PROCESS | 1678 | |3;audio-fft;63;76;74;139;60;58;57;61;128;64 17:28:42 INFO - PROCESS | 1678 | |4;audio-oscillator;81;83;137;77;80;79;119;80;82;120 17:28:42 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;105;88;86;90;86;93;89;89;86 17:28:42 INFO - PROCESS | 1678 | |6;imaging-darkroom;152;108;154;113;94;96;96;94;127;114 17:28:42 INFO - PROCESS | 1678 | |7;imaging-desaturate;92;91;92;90;94;132;106;151;95;148 17:28:42 INFO - PROCESS | 1678 | |8;json-parse-financial;60;62;63;84;64;63;62;78;87;97 17:28:42 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;67;66;73;71;65;98;58;65;63 17:28:42 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;84;81;84;84;83;83;84;99;112 17:28:42 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;143;140;143;139;160;154;155;142;181;149 17:28:42 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;202;251;180;185;278;280;212;201;247;198 17:28:42 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;69;68;69;71;72;68;70;72;71;70 17:28:42 INFO - PROCESS | 1678 | __end_tp_report 17:28:42 INFO - PROCESS | 1678 | __start_cc_report 17:28:42 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1108 17:28:42 INFO - PROCESS | 1678 | __end_cc_report 17:28:42 INFO - PROCESS | 1678 | __startTimestamp1461716922282__endTimestamp 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | ------- Summary: start ------- 17:28:42 INFO - PROCESS | 1678 | Number of tests: 14 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:128.30 Median:121.00 stddev:20.94 (17.3%) stddev-sans-first:21.66 17:28:42 INFO - PROCESS | 1678 | Values: 115.0 124.0 170.0 164.0 118.0 129.0 117.0 115.0 115.0 116.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:145.00 stddev:25.77 (17.8%) stddev-sans-first:26.85 17:28:42 INFO - PROCESS | 1678 | Values: 159.0 126.0 147.0 201.0 123.0 143.0 141.0 121.0 170.0 121.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:203.70 Median:201.00 stddev:13.76 (6.8%) stddev-sans-first:14.31 17:28:42 INFO - PROCESS | 1678 | Values: 196.0 197.0 207.0 238.0 196.0 195.0 214.0 194.0 205.0 195.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:78.00 Median:62.00 stddev:30.03 (48.4%) stddev-sans-first:31.36 17:28:42 INFO - PROCESS | 1678 | Values: 63.0 76.0 74.0 139.0 60.0 58.0 57.0 61.0 128.0 64.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:80.00 stddev:22.33 (27.9%) stddev-sans-first:23.20 17:28:42 INFO - PROCESS | 1678 | Values: 81.0 83.0 137.0 77.0 80.0 79.0 119.0 80.0 82.0 120.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:89.00 stddev:5.67 (6.4%) stddev-sans-first:6.00 17:28:42 INFO - PROCESS | 1678 | Values: 89.0 105.0 88.0 86.0 90.0 86.0 93.0 89.0 89.0 86.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:114.80 Median:124.00 stddev:22.83 (18.4%) stddev-sans-first:19.86 17:28:42 INFO - PROCESS | 1678 | Values: 152.0 108.0 154.0 113.0 94.0 96.0 96.0 94.0 127.0 114.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:91.50 stddev:24.74 (27.0%) stddev-sans-first:25.45 17:28:42 INFO - PROCESS | 1678 | Values: 92.0 91.0 92.0 90.0 94.0 132.0 106.0 151.0 95.0 148.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:71.00 stddev:13.33 (18.8%) stddev-sans-first:13.42 17:28:42 INFO - PROCESS | 1678 | Values: 60.0 62.0 63.0 84.0 64.0 63.0 62.0 78.0 87.0 97.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:66.50 stddev:11.05 (16.6%) stddev-sans-first:11.51 17:28:42 INFO - PROCESS | 1678 | Values: 63.0 67.0 66.0 73.0 71.0 65.0 98.0 58.0 65.0 63.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.00 stddev:9.91 (11.8%) stddev-sans-first:10.37 17:28:42 INFO - PROCESS | 1678 | Values: 83.0 84.0 81.0 84.0 84.0 83.0 83.0 84.0 99.0 112.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:151.50 stddev:12.83 (8.5%) stddev-sans-first:13.31 17:28:42 INFO - PROCESS | 1678 | Values: 143.0 140.0 143.0 139.0 160.0 154.0 155.0 142.0 181.0 149.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:223.40 Median:229.50 stddev:37.41 (16.3%) stddev-sans-first:38.87 17:28:42 INFO - PROCESS | 1678 | Values: 202.0 251.0 180.0 185.0 278.0 280.0 212.0 201.0 247.0 198.0 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.49 (2.1%) stddev-sans-first:1.54 17:28:42 INFO - PROCESS | 1678 | Values: 69.0 68.0 69.0 71.0 72.0 68.0 70.0 72.0 71.0 70.0 17:28:42 INFO - PROCESS | 1678 | -------- Summary: end -------- 17:28:42 INFO - PROCESS | 1678 | 17:28:42 INFO - TEST-INFO | 1678: exit 0 17:28:43 INFO - TEST-OK | kraken | took 60672ms 17:28:43 INFO - SUITE-END | took 1172s 17:28:43 INFO - Completed test suite (00:19:32) 17:28:43 INFO - javascript benchmark 17:28:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3513.5783705955287, 3514.3849826280402, 3535.2045789697304, 3551.20097977955, 3578.588462326833, 5673.319201695802, 5694.202811606373, 5694.6867922264255, 5706.258186435763, 5746.827595172146, 4758.262469317253, 5767.855803604912, 5867.002609556375, 5942.019566771478, 5966.194563733895, 5237.86905327367, 5285.6300058995885, 5294.1529355303155, 5322.680639161644, 5352.652077614943, 69.04613948748717, 5274.05067087924, 5291.920621190666, 5299.8410047698635, 5367.436419175989, 5232.241325007872, 5278.709670968095, 5282.445343238962, 5288.365396152448, 5312.335958005249, 5229.50319719626, 5346.518813306782, 5348.812791552277, 5365.946340536584, 5418.349798024223, 5214.765335559909, 5223.268742376071, 5280.471952804727, 5326.334208223972, 5371.167469042305, 5570.916436253459, 5601.60788744788, 5689.630174038674, 5702.600817942745, 5724.284464441945, 5008.949910500921, 6228.968855155696, 6295.748170073191, 6304.306526282106, 6304.842378940517, 6246.531510136758, 6304.243490781089, 6308.653024083674, 6315.810525684236, 6323.6521991290465, 6022.45797878193, 6026.939730602681, 6032.276126864805, 6032.849178770522, 6061.060535616986, 6172.197614310111, 6309.716062777186, 6350.33321501245, 6386.872262554816, 6401.487880969511, 6287.591306565058, 6314.463270621956, 6334.271558770708, 6349.333320001426, 6354.23749150105, 6253.53098517613, 6310.558260921692, 6326.588771729915, 6328.968355158287, 6332.715027823759, 6172.043333283348, 6214.844628884223, 6271.3728627136925, 6329.145565348619, 6333.65164915934, 5094.2613321068975, 5673.546116310686, 6265.373462653698, 6272.435480806658, 6275.02737075754, 4957.702537847741, 5022.748862556858, 5029.446760856303, 5035.5468007878735, 5052.292679024939, 4466.9553304466535, 4477.552244775561, 4533.5013148553635, 4558.0, 4593.173228818778, 5921.822345329647, 5946.137810017523, 5987.0, 6024.1265016573225, 6044.214252147192, 6303.6532990685955, 6328.936710632926, 6338.080978258126, 6344.555881088372, 6354.4281014708895, 4772.188727916193, 5127.615428842777, 5892.204552385459, 5943.8216853493595, 5982.192404025488, 4088.713790034669, 4605.424321959755, 5503.862403439866, 5537.833864984057, 5619.662820230799, 6345.206849143857, 6461.0, 6470.5147113965695, 6502.414782669583, 6524.706388212542, 6250.0937364082865, 6300.779472718433, 6326.810195694136, 6331.2085989251345, 6338.683065846782, 6538.313477084837, 6555.246146693191, 6566.277709451861, 6573.835654108686, 6584.440322572635, 5624.62196761796, 5941.465268125889, 6137.0, 6161.815145545641, 6193.38066193377, 6224.221972253468, 6288.905666414916, 6307.463865571478, 6318.873622527615, 6346.873062538816, 6062.545309101747, 6226.221722284715, 6228.377162283736, 6248.656323902229, 6255.78104766331, 6135.416406698409, 6145.846353841011, 6206.224221972254, 6237.126802247598, 6240.563160578898, 5677.630953987978, 6049.0, 6083.057126145454, 6165.445109940127, 6202.193714817045, 6236.812895613139, 6263.295553618134, 6294.087357333253, 6311.084892690443, 6321.367863213642, 6026.337102918763, 6072.240969878765, 6111.8777624446375, 6140.140380346666, 6173.043178307369], "value": 5725.358102307551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.1599281221921, 509.86743446703855, 536.9704666243355, 594.0080066289296, 628.3716283716284, 36780.63219367809, 37435.438468422995, 37531.437028444525, 37541.62458375416, 37584.248315033685, 38743.80628096856, 39043.21913561727, 39175.60824391755, 39305.0, 39457.40813887794, 9393.90606093939, 9594.136527712504, 9619.278554108434, 9631.807363852718, 9656.662016829412, 9500.429974201536, 9631.951840240788, 9635.951820240889, 9645.903540964571, 9656.951715241414, 9616.56725447353, 9629.903700963006, 9665.0, 9688.854667179998, 9696.660616878411, 9588.712338629852, 9655.372400793996, 9655.951720241424, 9662.13040826322, 9715.979822118647, 9470.668526601605, 9599.424034557878, 9599.856002159973, 9603.759906002337, 9641.71074867748, 37919.620803791884, 38091.23817523662, 38286.0, 38324.23351532982, 38338.80830595857, 2696.3124403277234, 2881.2652773542823, 2950.0, 3089.8258661708633, 3340.1482621931495, 25092.498150036896, 25882.87058564714, 26345.73654263452, 26475.0, 26753.866230668722, 2595.156574113421, 2614.9607755883676, 2623.7245089265543, 2637.591173368131, 2817.760490358322, 243968.0, 304280.0, 304984.0, 305067.4746626275, 305350.47324763454, 33109.3378132436, 33806.64773409085, 57020.0, 57893.0, 57940.0, 33715.15712107217, 33876.32247355039, 33934.98195054152, 33952.15119622029, 34083.0, 13696.315184240748, 13767.862321376859, 14745.262736863115, 14944.850551494346, 14979.775303370458, 12407.813882791765, 12567.811482827765, 12648.494060237488, 12726.745465090646, 12743.490260389666, 7921.207879212033, 8048.798780030546, 8050.557219352875, 8111.553864537507, 8197.590120493951, 3166.0027091466113, 3177.968220317767, 3410.4884267360094, 3415.0949998250485, 3441.6443967132345, 981.288565789811, 992.0525897767615, 1014.7564584499667, 1141.298101667485, 1157.7337212441016, 28761.99333023334, 29004.564931526045, 29059.418811623647, 29443.558346624817, 29717.257068573457, 1006.5923301063082, 1091.6070214722693, 1100.3452945497415, 1105.7180418993266, 1124.3197865291545, 14987.550373488813, 15072.924635376752, 15318.238402583622, 15356.846431535765, 15447.30487128082, 347018.0, 358569.0, 359214.0, 359281.0, 460993.0, 48037.75981120072, 57172.0, 57821.71089144611, 57912.0, 58618.0, 1447.862453066957, 1465.1502128765292, 1469.6472846516972, 1471.0438215160232, 1476.4389531977995, 28781.424371512872, 29323.41353172967, 29455.410891782474, 30157.944471943378, 30178.54732179063, 50650.48048558549, 51279.97440051103, 51424.74287628538, 51425.7428712869, 51517.484825152766, 438006.0996950076, 441786.0, 447900.0419991517, 451960.0, 454202.0, 26756.732432675424, 26773.598396023684, 27029.59455608128, 27295.0, 27322.0, 42355.0, 42532.5746742541, 42787.14425711531, 43521.0, 43570.128597428506, 36218.45672314864, 36256.63743362533, 36477.08807279839, 37157.0, 37218.62781372152, 35688.286234275685, 35951.64048359483, 36089.639103609676, 36329.29277905769, 36692.44961325636, 29045.419091617627, 33453.498197527544, 34345.656543435245, 35611.465828012086, 35672.0, 28869.711302886702, 29377.559336610397, 30696.0, 31637.837244353206, 31723.206919826265, 19569.217231310588, 23020.884895575415, 23339.0, 23992.0, 24046.75953240515], "value": 17416.872472184976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.2891964851527, 390.36955317162773, 399.5145897734253, 404.43379269023364, 407.8266736636932, 18111.184996675147, 18207.726884096734, 20089.095990680416, 20416.591668166628, 20438.2846600369, 18101.0, 19594.21623135073, 19623.01884905756, 20757.584848303024, 20792.688109678365, 5283.233931079991, 5350.8127215547465, 5659.094544872832, 5770.682612456313, 5885.558583106263, 5449.3188351456065, 5762.4525670061275, 5845.473907348338, 5864.677442740647, 5887.910736513737, 5714.885702285952, 5763.193152958589, 5778.133280007991, 5779.682117483537, 5856.824295271127, 5689.658620482743, 5784.16129661201, 5795.101759227306, 5812.447817457335, 5834.6790926499025, 4982.775775090094, 5032.597392208614, 5069.797208111671, 5085.5931525478245, 5124.256982737482, 21684.0, 22562.984665690085, 24212.0, 24794.628080578805, 25115.37211569707, 2004.1983206717284, 2099.8215151712125, 2139.037433155071, 2238.0935721033006, 2244.2930476899724, 11454.713632159179, 12760.617181484571, 13227.66930826737, 14686.63283417923, 14851.628709282246, 1409.78853172024, 1716.605180808421, 1730.134932533733, 1775.112443778111, 1813.4468986959105, 97758.53362199572, 99014.5640533363, 99757.00485990311, 103174.42063948461, 103410.48294758554, 8870.556472176366, 8947.686830960885, 9535.90464095364, 10394.584216631401, 10597.89402105969, 13735.381907814173, 13778.862211377758, 13804.516841910485, 13816.0, 13824.516141934984, 8493.362997775192, 8571.357148213785, 8703.65001449605, 8841.381103322705, 8866.42368246062, 7240.493165478471, 8740.344474164463, 8771.605277762515, 8805.42764720291, 8916.777080572907, 6563.3764792344655, 6688.7324507019175, 6706.418029058847, 6714.731410743613, 6733.696983635748, 1848.5655870870335, 1879.595886884299, 1882.2000649723814, 1883.3784850999136, 1910.4937191644226, 964.358701463533, 997.8553109799038, 1036.9325993810378, 1063.984040239397, 1066.8453074304182, 20006.0, 20528.87091209968, 20701.964901755153, 20776.48058798512, 21064.0, 963.3352986439335, 1038.190211634926, 1040.9063184313297, 1045.11165509318, 1076.9299995500423, 10874.782504349869, 11321.037711794424, 11369.943150284196, 11370.31778093317, 11393.658190254306, 595501.0, 596072.0, 600316.0, 622231.0, 626057.0, 80253.0, 100620.49689751504, 100802.0, 101130.49434752927, 101523.49238253909, 1036.7511797168625, 1041.2138835179542, 1056.1497994114657, 1060.0618452669444, 1061.4851796878509, 17634.470965871045, 17793.73309400386, 17802.91098544499, 17975.820241797413, 18356.5314774815, 34040.82979585086, 45846.31230531478, 48131.315403960696, 49878.0, 49928.500714992384, 67963.0, 68937.65531172312, 70250.64874675593, 70684.29315706778, 70817.93773093304, 7713.151553329241, 7819.0617125945255, 7998.520088794691, 8002.1997800219515, 8303.958480207802, 11396.772064558829, 11404.885951140714, 12152.027837772781, 12357.505699771908, 12360.75278494443, 10388.324758890649, 10439.739006524898, 10801.433792099944, 10804.621838235624, 10845.403502807105, 8709.259712924219, 10240.129588985019, 10271.537780800032, 10367.585296588051, 10557.683269501927, 10562.683119506428, 10795.892041079804, 10842.403667798031, 10844.566217351217, 10888.29226100301, 7491.213422590549, 8032.558209298545, 8192.057913339804, 8237.299829514559, 8255.834883302181, 9646.9035309646, 10798.974097460728, 10915.781684366428, 10976.670699879016, 11125.83311250348], "value": 9370.322963190501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.4118455579155, 1618.5953511622095, 1863.2081365419701, 1918.1464248409463, 1941.679622862228, 7366.5948372839475, 7574.09110906692, 8575.271101956334, 8630.827383452328, 8978.057303983085, 8596.054434012254, 8611.397202195849, 8678.045415004344, 8760.912390876088, 8781.692640757576, 2443.7434069422675, 2493.6259561065895, 2497.0, 2504.8622325772076, 2513.3339664988794, 2446.645236440715, 2481.5409149307347, 2483.044028049205, 2487.141936032066, 2492.6136448850366, 2463.7289898111194, 2469.8271121021535, 2475.752424757519, 2479.231438254138, 2511.0, 2457.582211024121, 2464.2360868130845, 2468.839525430841, 2474.39377352548, 2478.6405971134177, 2428.1380110061027, 2453.116877923946, 2476.0962248779247, 2482.2181012980855, 2493.47636996231, 8842.027376988526, 8851.114888511162, 8916.15296546827, 8933.955330223307, 8945.955270223607, 5271.736413179326, 5480.506754392124, 5492.945070549324, 5508.862278443031, 5518.392976772552, 3073.800202986799, 3646.1431563582537, 3658.5975542690285, 3685.3182161300247, 3700.4634328022285, 879.9912000879973, 1050.2858056521563, 1058.650220968264, 1060.1359891688248, 1064.3826580583243, 11553.480093395818, 11613.3612651305, 11672.124590655734, 11673.416329183507, 11674.35791031493, 4819.277108433763, 4850.369451971221, 4960.379952505937, 4961.5534601886, 4986.252062190701, 9886.752831179278, 9924.801503970024, 9953.25350598708, 9969.651062212788, 10022.198224142052, 5383.057964856134, 5452.809151679672, 5454.236406903036, 5468.316460442445, 5491.945080549223, 4448.110377924428, 4853.975730121398, 4902.50974902514, 4997.725125118153, 4997.9750101249265, 3307.5534802801794, 3989.9202015959518, 4069.9796501017304, 4096.160287141129, 4138.627523522898, 1162.0, 1358.9184648921096, 1374.4914381678843, 1375.4223226245, 1378.696686728918, 832.5795473286073, 928.4336554701626, 931.8509038553799, 945.6949409814412, 968.0, 5826.533877289807, 5909.379515150933, 5959.106134079922, 5972.790952316648, 6053.757849685963, 448.9887752806206, 463.4947906781624, 464.6538328944958, 470.4025887123403, 470.8822794301425, 3906.628870257321, 3908.511436070491, 3981.6416522513114, 4017.5580686124504, 4030.2544029354663, 10418.479076046318, 10836.891631083747, 10901.0, 10925.945370273097, 10978.011978921775, 10809.40548269837, 10871.510782014828, 10889.673309800719, 10949.83575246372, 10979.780404391868, 7955.84088318242, 8312.33501319893, 8344.04043534989, 8352.373571982125, 8357.749267521984, 5733.455321744427, 5829.979753543198, 5868.295804503487, 5964.970175149097, 5968.0, 10036.799264014824, 10146.898531014594, 10150.796984060129, 10219.335743176967, 10467.424291664032, 8357.791055223668, 9922.900770992486, 9934.354266972623, 10174.440405777754, 10381.429021403896, 6856.794296171123, 7252.347288744038, 7491.325780679765, 7500.762374208194, 7579.772606821804, 8251.33989280868, 8255.0, 8320.791980200302, 8352.540610266493, 8403.579821008803, 7246.1666908306215, 7396.9260307396235, 7403.222661620668, 7501.5372002459, 7559.1306999695735, 6485.416312531895, 6669.199696036507, 6922.411595014481, 7192.532485388433, 7422.851542969219, 6888.242293347828, 6901.689423975833, 6961.825954351182, 6986.930130698628, 7010.298970102949, 4536.206163921366, 4918.778654960607, 4921.630877684116, 4992.775325110451, 5132.358455193101, 4949.232868905326, 4949.727764972961, 4986.526280003394, 5052.646314758079, 5242.764075616683], "value": 4555.182227019862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.11445738076833, 320.97913635613685, 324.8359578412901, 329.95710557627507, 330.1037682691492, 5578.9163162552495, 5631.436856314372, 5705.400932902048, 5727.742251598677, 5774.624649397786, 5001.674891132083, 5111.1566591512355, 5469.425710300421, 5576.693281869496, 5668.489835914766, 3718.9442158367647, 3879.758477287269, 4010.1177740896956, 4176.914002359378, 4299.764122656217, 4281.993731473101, 4286.7856607169515, 4287.33432914858, 4292.1630282095, 4317.15815415994, 3886.844526218962, 3954.248692748383, 4084.774567629714, 4289.5924887135825, 4304.160688665712, 3559.9644003559893, 3753.474513568103, 4157.605027522381, 4282.97208669917, 4307.0, 2943.5878976943245, 2980.4650604938474, 3279.8032118072992, 3530.1880567469625, 3763.6424539668687, 5480.177179411618, 5489.725513724337, 5492.5605951523785, 5493.533049690741, 5543.417941116206, 4520.163769702583, 4525.0, 4643.885467487778, 4755.144074066667, 5035.244713292998, 5343.011542864582, 5832.6500409975115, 5984.521238300969, 5997.4002599740115, 6024.96987515064, 4076.7769669099152, 4176.331786914079, 4184.958150418487, 4190.28765109929, 4190.790460476964, 5237.3453318335205, 5989.3711160327975, 6248.187735594343, 6273.404026617464, 6273.96863015682, 4194.727342722713, 4234.597713217239, 4238.427812245369, 4240.045989652303, 4251.256030194703, 3471.5834099908175, 4134.565870583606, 4314.92126968258, 4324.200022995756, 4342.913141737147, 3772.07584141887, 4209.884380639133, 4596.218642830727, 4919.114559379346, 5009.273655319958, 5169.810943482945, 5956.493698035715, 6076.875777981088, 6080.361562036011, 6088.665123418255, 1453.556665217119, 1505.9774103388459, 1520.4035762449384, 1521.1025494957807, 1521.8706409955057, 921.6083164654995, 964.1756298364797, 978.9608415663436, 983.9754006149903, 1003.9698809035741, 4717.882052948635, 6015.54883383748, 6029.728662210211, 6051.394860513913, 6082.878342433127, 6696.83257918556, 6701.32986701326, 6720.764773232913, 6721.8655626887185, 6725.831854203684, 5281.577473802086, 5842.509665736831, 5926.170336152942, 6030.819075427744, 6043.848903777441, 2910.388818348128, 2915.927101822429, 3260.820654864005, 3352.8265107212283, 3514.191735900706, 6383.563698167968, 6657.300983396771, 6920.30796920314, 6946.583205007716, 7001.964990175016, 5723.56748381936, 5947.345791962881, 6589.912664410319, 6868.759593414306, 6869.107016087876, 6773.593584384953, 6793.932060679429, 6933.237343892067, 6957.825304817069, 6983.720651173998, 6559.901601475886, 6650.501212408992, 6653.73385064592, 6687.899681504684, 6814.284500127415, 5318.202269659582, 6413.294537600954, 6547.050677651809, 6589.143411356493, 6589.934100658932, 6424.93575064262, 6466.540400885504, 6848.623325717133, 6919.0, 6971.407430368476, 4328.588784065509, 4353.455818022747, 4355.520892701737, 4356.346548017823, 4367.737935723867, 6289.0, 6615.4046135848, 6643.634600097041, 6662.133922590032, 6672.299408562031, 5382.67703937765, 6428.357164283534, 6462.579932304385, 6473.838154046187, 6505.121808555785, 5875.794347197828, 6268.498520118471, 6392.913204755296, 6438.710258038306, 6440.935590644033, 5623.409541998195, 5724.8282551523525, 5862.560307976833, 6257.342978987323, 6287.528435367457, 5632.5212356950115, 6040.969795150996, 6053.727582258721, 6057.969710151421, 6093.6039157454625, 4965.975170124127, 5818.418158184148, 5914.290285165807, 5937.0, 5956.970215148896], "value": 4500.369971508519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.7148283272528, 690.9585424874512, 727.7234650832683, 746.0599644447993, 808.3452403553121, 14796.778048329285, 14882.330295136719, 14991.775123373158, 15126.470573529929, 15145.939784215096, 13074.934625326883, 13828.446862125527, 13920.0, 13928.582142535715, 13936.51222207223, 895.3553441522093, 895.5164211325877, 898.0032164297625, 905.8641203819413, 928.3872644054925, 717.4117223876424, 877.55244825139, 878.925291350236, 898.0660113482004, 902.8465160922626, 955.5126885288483, 960.812641534901, 961.9903800962006, 962.451402700461, 963.1764841060897, 925.0795458518784, 925.8102089071724, 935.2377812083131, 952.618952419031, 957.1481381570374, 700.422151724824, 705.9258777828356, 708.7342246657504, 709.0781983421531, 711.2460791560962, 15226.543203703906, 15339.539813805604, 15618.843811561852, 15648.530544083696, 15681.059136451735, 11897.405129743565, 11966.34185119818, 12014.0, 12102.334371609559, 12397.0, 9942.204623630165, 10041.899581004169, 10168.034036766569, 10297.176225901985, 10927.59717720393, 3476.6349533298894, 3580.6777390034763, 3582.3551760683067, 3647.361711700442, 3685.94471082934, 85361.57319213364, 85673.57163214144, 86409.0, 87498.0, 87858.56070719605, 9279.118483744034, 9302.0, 9523.238140948708, 9653.372530785617, 9708.077732615391, 21612.0, 21620.243291485036, 21669.67495487569, 21700.891495542422, 21710.89144554267, 7200.387967022757, 7254.0, 7339.119305683352, 7356.632168391559, 7511.51175173612, 3990.68074554035, 4065.2479291331197, 4067.491563554556, 4072.9592704073175, 4074.8370065197655, 3495.3358861816173, 3544.4683297505067, 3571.3035957987945, 3586.6592673696478, 3587.497750314958, 544.8256557901434, 563.0259650804131, 573.5669569475103, 645.1065274594627, 686.4268335939546, 486.3021564055592, 530.2523441946836, 543.728135932034, 578.7222133375919, 609.6159419565645, 8088.150744171895, 8242.670293188325, 8246.752597422086, 8419.915800842036, 8454.239118479367, 501.8845665496956, 524.3524247554268, 570.7146426786607, 574.4026212738788, 597.0983814440226, 3639.781613103169, 3803.2963901678277, 3912.7847968361443, 3945.64489195968, 4028.617281358266, 100312.99687003037, 100400.49399259017, 100666.0, 102763.0, 107067.46466267618, 83287.0, 87031.69452458218, 88370.69775813472, 88680.0, 88721.66917496243, 56463.71768141215, 68384.6580767093, 77622.0, 77837.0, 77885.61057194677, 6022.397760223943, 6662.866742665216, 7783.961080194563, 7909.683612655429, 7961.641726122222, 46709.0, 47246.27537246248, 47422.0, 47530.76234618805, 48930.77673058202, 65796.34203657902, 70431.64784176047, 71617.0, 71621.28378716146, 71955.92066119116, 9958.701238962843, 10227.693169204937, 10396.0, 10453.581856725647, 10571.418571978615, 10153.543090560795, 10593.675790526184, 11463.942680286546, 11485.138614603771, 11572.710682233012, 9346.579403926704, 10218.335808172445, 10275.972402759964, 10656.360618362924, 10830.783384332111, 10485.580576776843, 10766.623168189075, 10936.0, 11022.173336999918, 11058.668239952814, 10587.470626468492, 10762.677119686421, 10790.406527641055, 10949.781004380027, 10961.56153753841, 8241.50550966944, 9204.953975230348, 9208.539573021457, 9455.858162127712, 9642.276829237695, 9097.863532047157, 9109.726708198765, 9166.312526560401, 9210.815783684422, 9236.538173091452], "value": 6815.409743454503, "unit": "score"}], "name": "dromaeo_css", "value": 7122.542173401555, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 170.0, 164.0, 118.0, 129.0, 117.0, 115.0, 115.0, 116.0], "value": 128.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 147.0, 201.0, 123.0, 143.0, 141.0, 121.0, 170.0, 121.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 207.0, 238.0, 196.0, 195.0, 214.0, 194.0, 205.0, 195.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 76.0, 74.0, 139.0, 60.0, 58.0, 57.0, 61.0, 128.0, 64.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 137.0, 77.0, 80.0, 79.0, 119.0, 80.0, 82.0, 120.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 105.0, 88.0, 86.0, 90.0, 86.0, 93.0, 89.0, 89.0, 86.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 108.0, 154.0, 113.0, 94.0, 96.0, 96.0, 94.0, 127.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 90.0, 94.0, 132.0, 106.0, 151.0, 95.0, 148.0], "value": 109.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 63.0, 84.0, 64.0, 63.0, 62.0, 78.0, 87.0, 97.0], "value": 72.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 73.0, 71.0, 65.0, 98.0, 58.0, 65.0, 63.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 84.0, 84.0, 83.0, 83.0, 84.0, 99.0, 112.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 143.0, 139.0, 160.0, 154.0, 155.0, 142.0, 181.0, 149.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 251.0, 180.0, 185.0, 278.0, 280.0, 212.0, 201.0, 247.0, 198.0], "value": 223.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 71.0, 72.0, 68.0, 70.0, 72.0, 71.0, 70.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1635.6000000000001, "alertThreshold": 2.0}]} 17:28:43 INFO - Return code: 0 17:28:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:43 ERROR - # TBPL SUCCESS # 17:28:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:28:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:28:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:28:43 INFO - 2016-04-26 17:28:43.601 screenresolution[1683:10931] starting screenresolution argv=screenresolution get 17:28:43 INFO - 2016-04-26 17:28:43.604 screenresolution[1683:10931] Display 0: 1600x1200x32@60 17:28:43 INFO - 2016-04-26 17:28:43.610 screenresolution[1684:10934] starting screenresolution argv=screenresolution list 17:28:43 INFO - Available Modes on Display 0 17:28:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:28:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:28:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:28:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:28:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:28:43 INFO - Intel Iris: 17:28:43 INFO - Chipset Model: Intel Iris 17:28:43 INFO - Type: GPU 17:28:43 INFO - Bus: Built-In 17:28:43 INFO - VRAM (Dynamic, Max): 1536 MB 17:28:43 INFO - Vendor: Intel (0x8086) 17:28:43 INFO - Device ID: 0x0a2e 17:28:43 INFO - Revision ID: 0x0009 17:28:43 INFO - Displays: 17:28:43 INFO - Display: 17:28:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:28:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:28:43 INFO - Display Serial Number: 1600x1200 60 17:28:43 INFO - Main Display: Yes 17:28:43 INFO - Mirror: Off 17:28:43 INFO - Online: Yes 17:28:43 INFO - Rotation: Supported 17:28:43 INFO - Return code: 0 17:28:43 INFO - Running post-action listener: _resource_record_post_action 17:28:43 INFO - Running post-run listener: _resource_record_post_run 17:28:44 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32321024; Write bytes: 700604928; Read time: 322; Write time: 2047 17:28:44 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 393241088; Write bytes: 387868160; Read time: 30096; Write time: 871 17:28:44 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30539264; Write bytes: 301251584; Read time: 304; Write time: 1149 17:28:44 INFO - Running post-run listener: _upload_blobber_files 17:28:44 INFO - Blob upload gear active. 17:28:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:44 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 17:28:44 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'] 17:28:44 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 17:28:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:46 INFO - (blobuploader) - INFO - Done attempting. 17:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:47 INFO - (blobuploader) - INFO - Done attempting. 17:28:47 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:47 INFO - Return code: 0 17:28:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/219a57b17c98e22a5b1017f4ddf7410a8bdb9349df4be5ecacf786a76a024b3e27d14888526fc7b4116efd0cc2075c69e07b6c9a616e0f93ac29cf26f876496a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69a16314cd770226860d9c5f6174b872c63a1e8897bfc7cad1790222a9b3e4cfb95155bcb9e9aa413396714acd730e9e29e51b309ebbd3c224626cda3fb6142"} 17:28:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:47 INFO - Contents: 17:28:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/219a57b17c98e22a5b1017f4ddf7410a8bdb9349df4be5ecacf786a76a024b3e27d14888526fc7b4116efd0cc2075c69e07b6c9a616e0f93ac29cf26f876496a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69a16314cd770226860d9c5f6174b872c63a1e8897bfc7cad1790222a9b3e4cfb95155bcb9e9aa413396714acd730e9e29e51b309ebbd3c224626cda3fb6142"} 17:28:47 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:47 INFO - Copying logs to upload dir... 17:28:47 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.854984 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-26 17:28:47.900896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:28:47.904616) ========= 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.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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/219a57b17c98e22a5b1017f4ddf7410a8bdb9349df4be5ecacf786a76a024b3e27d14888526fc7b4116efd0cc2075c69e07b6c9a616e0f93ac29cf26f876496a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69a16314cd770226860d9c5f6174b872c63a1e8897bfc7cad1790222a9b3e4cfb95155bcb9e9aa413396714acd730e9e29e51b309ebbd3c224626cda3fb6142"} build_url:https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/219a57b17c98e22a5b1017f4ddf7410a8bdb9349df4be5ecacf786a76a024b3e27d14888526fc7b4116efd0cc2075c69e07b6c9a616e0f93ac29cf26f876496a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69a16314cd770226860d9c5f6174b872c63a1e8897bfc7cad1790222a9b3e4cfb95155bcb9e9aa413396714acd730e9e29e51b309ebbd3c224626cda3fb6142"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:28:47.942574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:28:47.943355) ========= 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.YpFqIgUp61/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.v8JITREnlq/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005095 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:28:47.994154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:28:47.994514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:28:47.994931) ========= ========= Total master_lag: 4.31 =========