builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0083 starttime: 1461713089.33 results: success (0) buildid: 20160426144059 builduid: 5e3a427619484e129638fb2f79999862 revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.335207) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.335636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.335938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.355233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.355837) ========= 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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:24:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 52.4M=0s 2016-04-26 16:24:49 (52.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126909 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.805086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.805491) ========= 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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.027524 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:49.848913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 16:24:49.849267) ========= 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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:24:49,927 truncating revision to first 12 chars 2016-04-26 16:24:49,927 Setting DEBUG logging. 2016-04-26 16:24:49,927 attempt 1/10 2016-04-26 16:24:49,927 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 16:24:52,006 unpacking tar archive at: fx-team-b567617d9f02/testing/mozharness/ program finished with exit code 0 elapsedTime=2.326618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 16:24:52.196164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:52.196596) ========= script_repo_revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:52.197093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:52.197412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 16:24:52.211728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-26 16:24:52.212206) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:24:52 INFO - MultiFileLogger online at 20160426 16:24:52 in /builds/slave/test 16:24:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:24:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:24:52 INFO - {'append_to_log': False, 16:24:52 INFO - 'base_work_dir': '/builds/slave/test', 16:24:52 INFO - 'blob_upload_branch': 'Fx-Team', 16:24:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:24:52 INFO - 'branch': 'Fx-Team', 16:24:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:24:52 INFO - 'config_files': ('talos/mac_config.py',), 16:24:52 INFO - 'default_actions': ('clobber', 16:24:52 INFO - 'read-buildbot-config', 16:24:52 INFO - 'download-and-extract', 16:24:52 INFO - 'populate-webroot', 16:24:52 INFO - 'create-virtualenv', 16:24:52 INFO - 'install', 16:24:52 INFO - 'run-tests'), 16:24:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:24:52 INFO - 'download_minidump_stackwalk': True, 16:24:52 INFO - 'download_symbols': 'ondemand', 16:24:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:24:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:24:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:24:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:24:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:24:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:24:52 INFO - 'installer_path': 'installer.exe', 16:24:52 INFO - 'log_level': 'info', 16:24:52 INFO - 'log_name': 'talos', 16:24:52 INFO - 'log_to_console': True, 16:24:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:24:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:24:52 INFO - 'opt_config_files': (), 16:24:52 INFO - 'pip_index': False, 16:24:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:24:52 INFO - 'cmd': ('bash', 16:24:52 INFO - '-c', 16:24:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:24:52 INFO - 'enabled': True, 16:24:52 INFO - 'halt_on_failure': False, 16:24:52 INFO - 'name': 'check_screen_resolution'},), 16:24:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:24:52 INFO - 'cmd': ('bash', 16:24:52 INFO - '-c', 16:24:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:24:52 INFO - 'enabled': True, 16:24:52 INFO - 'halt_on_failure': False, 16:24:52 INFO - 'name': 'check_screen_resolution'},), 16:24:52 INFO - 'run_cmd_checks_enabled': True, 16:24:52 INFO - 'sps_profile': False, 16:24:52 INFO - 'sps_profile_interval': 0, 16:24:52 INFO - 'suite': 'dromaeojs', 16:24:52 INFO - 'system_bits': '32', 16:24:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:24:52 INFO - 'title': 't-yosemite-r7-0083', 16:24:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:24:52 INFO - 'use_talos_json': True, 16:24:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:24:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:24:52 INFO - 'work_dir': 'build'} 16:24:52 INFO - ##### 16:24:52 INFO - ##### Running clobber step. 16:24:52 INFO - ##### 16:24:52 INFO - Running pre-action listener: _resource_record_pre_action 16:24:52 INFO - Running main action method: clobber 16:24:52 INFO - rmtree: /builds/slave/test/build 16:24:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:24:54 INFO - Running post-action listener: _resource_record_post_action 16:24:54 INFO - ##### 16:24:54 INFO - ##### Running read-buildbot-config step. 16:24:54 INFO - ##### 16:24:54 INFO - Running pre-action listener: _resource_record_pre_action 16:24:54 INFO - Running main action method: read_buildbot_config 16:24:54 INFO - Using buildbot properties: 16:24:54 INFO - { 16:24:54 INFO - "project": "", 16:24:54 INFO - "product": "firefox", 16:24:54 INFO - "script_repo_revision": "production", 16:24:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:24:54 INFO - "repository": "", 16:24:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:24:54 INFO - "buildid": "20160426144059", 16:24:54 INFO - "pgo_build": "False", 16:24:54 INFO - "basedir": "/builds/slave/test", 16:24:54 INFO - "buildnumber": 671, 16:24:54 INFO - "slavename": "t-yosemite-r7-0083", 16:24:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:24:54 INFO - "platform": "yosemite_r7", 16:24:54 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:24:54 INFO - "branch": "fx-team", 16:24:54 INFO - "repo_path": "integration/fx-team", 16:24:54 INFO - "revision": "b567617d9f02be4bd6870db55a9bd514a5762465", 16:24:54 INFO - "stage_platform": "macosx64", 16:24:54 INFO - "builduid": "5e3a427619484e129638fb2f79999862", 16:24:54 INFO - "slavebuilddir": "test" 16:24:54 INFO - } 16:24:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 16:24:54 INFO - Running post-action listener: _resource_record_post_action 16:24:54 INFO - ##### 16:24:54 INFO - ##### Running download-and-extract step. 16:24:54 INFO - ##### 16:24:54 INFO - Running pre-action listener: _resource_record_pre_action 16:24:54 INFO - Running main action method: download_and_extract 16:24:54 INFO - mkdir: /builds/slave/test/build/tests 16:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:54 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 16:24:54 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 16:24:54 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 16:24:54 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 16:24:54 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 16:24:56 INFO - Downloaded 1199 bytes. 16:24:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:24:56 INFO - Using the following test package requirements: 16:24:56 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:24:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 16:24:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 16:24:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'jsshell-mac.zip'], 16:24:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 16:24:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:24:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 16:24:56 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 16:24:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 16:24:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:24:56 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 16:24:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:56 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 16:24:56 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 16:24:56 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 16:24:56 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 16:24:56 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 16:24:58 INFO - Downloaded 18114881 bytes. 16:24:58 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'] 16:24:58 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 16:25:01 INFO - Return code: 0 16:25:01 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 16:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:01 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 16:25:01 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 16:25:01 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 16:25:01 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 16:25:01 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 16:25:04 INFO - Downloaded 18114881 bytes. 16:25:04 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'] 16:25:04 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 16:25:08 INFO - Return code: 0 16:25: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')]} 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 INFO - Downloaded 10840145 bytes. 16:25:08 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'] 16:25:08 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 16:25:09 INFO - Return code: 0 16:25: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')]} 16:25:09 INFO - https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:25:09 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 16:25:09 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 16:25:09 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 16:25:09 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 16:25:12 INFO - Downloaded 110223149 bytes. 16:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:25:12 INFO - mkdir: /builds/slave/test/properties 16:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:25:12 INFO - Contents: 16:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:25:13 INFO - Running post-action listener: _resource_record_post_action 16:25:13 INFO - Running post-action listener: set_extra_try_arguments 16:25:13 INFO - ##### 16:25:13 INFO - ##### Running populate-webroot step. 16:25:13 INFO - ##### 16:25:13 INFO - Running pre-action listener: _resource_record_pre_action 16:25:13 INFO - Running main action method: populate_webroot 16:25:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:25:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:25:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:25:13 INFO - '--tppagecycles', 16:25:13 INFO - '7'], 16:25:13 INFO - 'tests': ['tsvgm']}}, 16:25:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:25:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:25:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:25:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:25:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['damp', 'tps']}, 16:25:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'tests': ['damp', 'tps']}, 16:25:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['dromaeo_dom']}, 16:25:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:25:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'other-e10s': {'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['a11yr', 16:25:13 INFO - 'ts_paint', 16:25:13 INFO - 'tpaint', 16:25:13 INFO - 'sessionrestore', 16:25:13 INFO - 'sessionrestore_no_auto_restore', 16:25:13 INFO - 'tabpaint']}, 16:25:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['tsvgx', 16:25:13 INFO - 'tsvgr_opacity', 16:25:13 INFO - 'tart', 16:25:13 INFO - 'tscrollx', 16:25:13 INFO - 'cart']}, 16:25:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:25:13 INFO - 'tsvgr_opacity', 16:25:13 INFO - 'tart', 16:25:13 INFO - 'tscrollx', 16:25:13 INFO - 'cart']}, 16:25:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'talos_options': ['--disable-e10s'], 16:25:13 INFO - 'tests': ['tp5o']}, 16:25:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'tests': ['tp5o']}, 16:25:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'talos_options': ['--disable-e10s', 16:25:13 INFO - '--xperf_path', 16:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:13 INFO - 'tests': ['tp5n']}, 16:25:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:13 INFO - 'talos_options': ['--xperf_path', 16:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:13 INFO - 'tests': ['tp5n']}}, 16:25:13 INFO - 'talos.zip': {'path': '', 16:25:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:25:13 INFO - Running post-action listener: _resource_record_post_action 16:25:13 INFO - ##### 16:25:13 INFO - ##### Running create-virtualenv step. 16:25:13 INFO - ##### 16:25:13 INFO - Running pre-action listener: _resource_record_pre_action 16:25:13 INFO - Running main action method: create_virtualenv 16:25:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:25:13 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 16:25:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:25:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:25:13 INFO - Using real prefix '/tools/python27' 16:25:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:25:14 INFO - Installing distribute.............................................................................................................................................................................................done. 16:25:17 INFO - Installing pip.................done. 16:25:17 INFO - Return code: 0 16:25:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:17 INFO - 'HOME': '/Users/cltbld', 16:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:17 INFO - 'LOGNAME': 'cltbld', 16:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:17 INFO - 'MOZ_NO_REMOTE': '1', 16:25:17 INFO - 'NO_EM_RESTART': '1', 16:25:17 INFO - 'PAGER': '/bin/cat', 16:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:17 INFO - 'PWD': '/builds/slave/test', 16:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:17 INFO - 'SHELL': '/bin/bash', 16:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:17 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:17 INFO - 'USER': 'cltbld', 16:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:17 INFO - 'XPC_FLAGS': '0x0', 16:25:17 INFO - 'XPC_SERVICE_NAME': '0', 16:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:17 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 16:25:17 INFO - Cleaning up... 16:25:17 INFO - Return code: 0 16:25:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:17 INFO - 'HOME': '/Users/cltbld', 16:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:17 INFO - 'LOGNAME': 'cltbld', 16:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:17 INFO - 'MOZ_NO_REMOTE': '1', 16:25:17 INFO - 'NO_EM_RESTART': '1', 16:25:17 INFO - 'PAGER': '/bin/cat', 16:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:17 INFO - 'PWD': '/builds/slave/test', 16:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:17 INFO - 'SHELL': '/bin/bash', 16:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:17 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:17 INFO - 'USER': 'cltbld', 16:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:17 INFO - 'XPC_FLAGS': '0x0', 16:25:17 INFO - 'XPC_SERVICE_NAME': '0', 16:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:17 INFO - Downloading/unpacking psutil>=0.7.1 16:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:20 INFO - Installing collected packages: psutil 16:25:20 INFO - Running setup.py install for psutil 16:25:20 INFO - building 'psutil._psutil_osx' extension 16:25:20 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 16:25:21 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 16:25:21 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 16:25:21 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 16:25:21 INFO - building 'psutil._psutil_posix' extension 16:25:21 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 16:25:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:25:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:25:21 INFO - ^ 16:25:21 INFO - 1 warning generated. 16:25:21 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 16:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:21 INFO - Successfully installed psutil 16:25:21 INFO - Cleaning up... 16:25:21 INFO - Return code: 0 16:25:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:21 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:21 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 16:25:21 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 16:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:21 INFO - 'HOME': '/Users/cltbld', 16:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:21 INFO - 'LOGNAME': 'cltbld', 16:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:21 INFO - 'MOZ_NO_REMOTE': '1', 16:25:21 INFO - 'NO_EM_RESTART': '1', 16:25:21 INFO - 'PAGER': '/bin/cat', 16:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:21 INFO - 'PWD': '/builds/slave/test', 16:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:21 INFO - 'SHELL': '/bin/bash', 16:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:21 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:21 INFO - 'USER': 'cltbld', 16:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:21 INFO - 'XPC_FLAGS': '0x0', 16:25:21 INFO - 'XPC_SERVICE_NAME': '0', 16:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:25: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 16:25: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 16:25: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 16:25: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 16:25: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 16:25: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 16:25:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:25:24 INFO - Installing collected packages: mozsystemmonitor 16:25:24 INFO - Running setup.py install for mozsystemmonitor 16:25:24 INFO - Successfully installed mozsystemmonitor 16:25:24 INFO - Cleaning up... 16:25:24 INFO - Return code: 0 16:25:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25:24 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')]} 16:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:24 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')]} 16:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:24 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:24 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 16:25:24 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 16:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:24 INFO - 'HOME': '/Users/cltbld', 16:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:24 INFO - 'LOGNAME': 'cltbld', 16:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:24 INFO - 'MOZ_NO_REMOTE': '1', 16:25:24 INFO - 'NO_EM_RESTART': '1', 16:25:24 INFO - 'PAGER': '/bin/cat', 16:25:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:24 INFO - 'PWD': '/builds/slave/test', 16:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:24 INFO - 'SHELL': '/bin/bash', 16:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:24 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:24 INFO - 'USER': 'cltbld', 16:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:24 INFO - 'XPC_FLAGS': '0x0', 16:25:24 INFO - 'XPC_SERVICE_NAME': '0', 16:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:27 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 16:25:27 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 16:25:27 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 16:25:27 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 16:25:27 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 16:25:27 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 16:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 INFO - Downloading docopt-0.6.1.tar.gz 16:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:28 INFO - Running setup.py install for blobuploader 16:25:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:28 INFO - Running setup.py install for requests 16:25:29 INFO - Running setup.py install for docopt 16:25:29 INFO - Successfully installed blobuploader requests docopt 16:25:29 INFO - Cleaning up... 16:25:29 INFO - Return code: 0 16:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:29 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:29 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 16:25:29 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 16:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:29 INFO - 'HOME': '/Users/cltbld', 16:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:29 INFO - 'LOGNAME': 'cltbld', 16:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:29 INFO - 'MOZ_NO_REMOTE': '1', 16:25:29 INFO - 'NO_EM_RESTART': '1', 16:25:29 INFO - 'PAGER': '/bin/cat', 16:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:29 INFO - 'PWD': '/builds/slave/test', 16:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:29 INFO - 'SHELL': '/bin/bash', 16:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:29 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:29 INFO - 'USER': 'cltbld', 16:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:29 INFO - 'XPC_FLAGS': '0x0', 16:25:29 INFO - 'XPC_SERVICE_NAME': '0', 16:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ycFCwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Z4eJ0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VYvg3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wnH3Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-jx37y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ATi8_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-t_DJXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-gPEwRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-itK81R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-E_0Mn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:30 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ARWn6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-_MnvUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AwQim5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-b9uiiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tXCmNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-R50eUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:31 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-efH9Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:31 INFO - Running setup.py install for manifestparser 16:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:31 INFO - Running setup.py install for mozcrash 16:25:31 INFO - Running setup.py install for mozdebug 16:25:32 INFO - Running setup.py install for mozdevice 16:25:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Running setup.py install for mozfile 16:25:32 INFO - Running setup.py install for mozhttpd 16:25:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Running setup.py install for mozinfo 16:25:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Running setup.py install for mozInstall 16:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:32 INFO - Running setup.py install for mozleak 16:25:32 INFO - Running setup.py install for mozlog 16:25:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Running setup.py install for moznetwork 16:25:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Running setup.py install for mozprocess 16:25:33 INFO - Running setup.py install for mozprofile 16:25:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Running setup.py install for mozrunner 16:25:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:33 INFO - Running setup.py install for mozscreenshot 16:25:33 INFO - Running setup.py install for moztest 16:25:34 INFO - Running setup.py install for mozversion 16:25:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:34 INFO - Cleaning up... 16:25:34 INFO - Return code: 0 16:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:34 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:34 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 16:25:34 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 16:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:34 INFO - 'HOME': '/Users/cltbld', 16:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:34 INFO - 'LOGNAME': 'cltbld', 16:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:34 INFO - 'MOZ_NO_REMOTE': '1', 16:25:34 INFO - 'NO_EM_RESTART': '1', 16:25:34 INFO - 'PAGER': '/bin/cat', 16:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:34 INFO - 'PWD': '/builds/slave/test', 16:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:34 INFO - 'SHELL': '/bin/bash', 16:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:34 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:34 INFO - 'USER': 'cltbld', 16:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:34 INFO - 'XPC_FLAGS': '0x0', 16:25:34 INFO - 'XPC_SERVICE_NAME': '0', 16:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-61ViNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:34 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)) 16:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CyUW8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:34 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)) 16:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tYhaZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:34 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)) 16:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DFe0gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:34 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)) 16:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:34 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-YQtLYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-_b6a46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-lCUUNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wpcSku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Wm7BrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VB1wat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wVYjWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vMQqwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-C8oMkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:35 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)) 16:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:35 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-OFcA1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:36 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)) 16:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:36 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Ii_UAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:36 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)) 16:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:36 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6momc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:36 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)) 16:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:36 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EaALCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:36 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)) 16:25:36 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)) 16:25:36 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)) 16:25:36 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)) 16:25:36 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)) 16:25:36 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)) 16:25:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:36 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 16:25:36 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 16:25:36 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 16:25:36 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 16:25:36 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 16:25:36 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 16:25:38 INFO - Downloading blessings-1.6.tar.gz 16:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:38 INFO - Installing collected packages: blessings 16:25:38 INFO - Running setup.py install for blessings 16:25:39 INFO - Successfully installed blessings 16:25:39 INFO - Cleaning up... 16:25:39 INFO - Return code: 0 16:25:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:39 INFO - Reading from file tmpfile_stdout 16:25:39 INFO - Current package versions: 16:25:39 INFO - blessings == 1.6 16:25:39 INFO - blobuploader == 1.2.4 16:25:39 INFO - docopt == 0.6.1 16:25:39 INFO - manifestparser == 1.1 16:25:39 INFO - mozInstall == 1.12 16:25:39 INFO - mozcrash == 0.17 16:25:39 INFO - mozdebug == 0.1 16:25:39 INFO - mozdevice == 0.48 16:25:39 INFO - mozfile == 1.2 16:25:39 INFO - mozhttpd == 0.7 16:25:39 INFO - mozinfo == 0.9 16:25:39 INFO - mozleak == 0.1 16:25:39 INFO - mozlog == 3.1 16:25:39 INFO - moznetwork == 0.27 16:25:39 INFO - mozprocess == 0.22 16:25:39 INFO - mozprofile == 0.28 16:25:39 INFO - mozrunner == 6.11 16:25:39 INFO - mozscreenshot == 0.1 16:25:39 INFO - mozsystemmonitor == 0.0 16:25:39 INFO - moztest == 0.7 16:25:39 INFO - mozversion == 1.4 16:25:39 INFO - psutil == 3.1.1 16:25:39 INFO - requests == 1.2.3 16:25:39 INFO - wsgiref == 0.1.2 16:25:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:39 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:39 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 16:25:39 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 16:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:39 INFO - 'HOME': '/Users/cltbld', 16:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:39 INFO - 'LOGNAME': 'cltbld', 16:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:39 INFO - 'MOZ_NO_REMOTE': '1', 16:25:39 INFO - 'NO_EM_RESTART': '1', 16:25:39 INFO - 'PAGER': '/bin/cat', 16:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:39 INFO - 'PWD': '/builds/slave/test', 16:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:39 INFO - 'SHELL': '/bin/bash', 16:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:39 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:39 INFO - 'USER': 'cltbld', 16:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:39 INFO - 'XPC_FLAGS': '0x0', 16:25:39 INFO - 'XPC_SERVICE_NAME': '0', 16:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 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)) 16:25:39 INFO - Cleaning up... 16:25:39 INFO - Return code: 0 16:25:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:39 INFO - 'HOME': '/Users/cltbld', 16:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:39 INFO - 'LOGNAME': 'cltbld', 16:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:39 INFO - 'MOZ_NO_REMOTE': '1', 16:25:39 INFO - 'NO_EM_RESTART': '1', 16:25:39 INFO - 'PAGER': '/bin/cat', 16:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:39 INFO - 'PWD': '/builds/slave/test', 16:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:39 INFO - 'SHELL': '/bin/bash', 16:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:39 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:39 INFO - 'USER': 'cltbld', 16:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:39 INFO - 'XPC_FLAGS': '0x0', 16:25:39 INFO - 'XPC_SERVICE_NAME': '0', 16:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:39 INFO - Downloading/unpacking jsonschema 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:25:42 INFO - Downloading/unpacking functools32 (from jsonschema) 16:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:42 INFO - Downloading functools32-3.2.3-2.tar.gz 16:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:25:42 INFO - warning: no files found matching '*.txt' 16:25:42 INFO - no previously-included directories found matching 'build' 16:25:42 INFO - no previously-included directories found matching 'dist' 16:25:42 INFO - no previously-included directories found matching '.git*' 16:25:42 INFO - Installing collected packages: jsonschema, functools32 16:25:43 INFO - Running setup.py install for functools32 16:25:43 INFO - warning: no files found matching '*.txt' 16:25:43 INFO - no previously-included directories found matching 'build' 16:25:43 INFO - no previously-included directories found matching 'dist' 16:25:43 INFO - no previously-included directories found matching '.git*' 16:25:43 INFO - Successfully installed jsonschema functools32 16:25:43 INFO - Cleaning up... 16:25:43 INFO - Return code: 0 16:25:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:25:43 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')]} 16:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:43 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')]} 16:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:43 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 0x100874a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd35a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, '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.bTCJlmNy0l/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.Eg10TimxHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 16:25:43 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 16:25:43 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 16:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:43 INFO - 'HOME': '/Users/cltbld', 16:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:43 INFO - 'LOGNAME': 'cltbld', 16:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:43 INFO - 'MOZ_NO_REMOTE': '1', 16:25:43 INFO - 'NO_EM_RESTART': '1', 16:25:43 INFO - 'PAGER': '/bin/cat', 16:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:43 INFO - 'PWD': '/builds/slave/test', 16:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:43 INFO - 'SHELL': '/bin/bash', 16:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:25:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:43 INFO - 'USER': 'cltbld', 16:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:43 INFO - 'XPC_FLAGS': '0x0', 16:25:43 INFO - 'XPC_SERVICE_NAME': '0', 16:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:43 INFO - Downloading/unpacking flake8 16:25:43 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 16:25:43 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 16:25:43 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 16:25:43 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 16:25:43 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 16:25:43 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 16:25:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:25:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:25:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:46 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 16:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:25:47 INFO - no previously-included directories found matching 'docs/_build' 16:25:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:25:47 INFO - Running setup.py install for pep8 16:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:25:47 INFO - no previously-included directories found matching 'docs/_build' 16:25:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:25:47 INFO - Cleaning up... 16:25:47 INFO - Return code: 0 16:25:47 INFO - Running post-action listener: _resource_record_post_action 16:25:47 INFO - Running post-action listener: _start_resource_monitoring 16:25:47 INFO - Starting resource monitoring. 16:25:47 INFO - ##### 16:25:47 INFO - ##### Running install step. 16:25:47 INFO - ##### 16:25:47 INFO - Running pre-action listener: _resource_record_pre_action 16:25:47 INFO - Running main action method: install 16:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:47 INFO - Reading from file tmpfile_stdout 16:25:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:47 INFO - Reading from file tmpfile_stdout 16:25:47 INFO - Output received: 16:25:47 INFO - Usage: mozinstall [options] installer 16:25:47 INFO - Options: 16:25:47 INFO - -h, --help show this help message and exit 16:25:47 INFO - -d DEST, --destination=DEST 16:25:47 INFO - Directory to install application into. [default: 16:25:47 INFO - "/builds/slave/test"] 16:25:47 INFO - --app=APP Application being installed. [default: firefox] 16:25:47 INFO - mkdir: /builds/slave/test/build/application 16:25:47 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'] 16:25:47 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 16:26:21 INFO - Reading from file tmpfile_stdout 16:26:21 INFO - Output received: 16:26:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:26:21 INFO - Running post-action listener: _resource_record_post_action 16:26:21 INFO - ##### 16:26:21 INFO - ##### Running run-tests step. 16:26:21 INFO - ##### 16:26:21 INFO - Running pre-action listener: _resource_record_pre_action 16:26:21 INFO - Running main action method: run_tests 16:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:26:21 INFO - 2016-04-26 16:26:21.844 screenresolution[1633:7568] starting screenresolution argv=screenresolution get 16:26:21 INFO - 2016-04-26 16:26:21.846 screenresolution[1633:7568] Display 0: 1600x1200x32@60 16:26:21 INFO - 2016-04-26 16:26:21.852 screenresolution[1634:7570] starting screenresolution argv=screenresolution list 16:26:21 INFO - Available Modes on Display 0 16:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:26:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:26:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:26:22 INFO - Intel Iris: 16:26:22 INFO - Chipset Model: Intel Iris 16:26:22 INFO - Type: GPU 16:26:22 INFO - Bus: Built-In 16:26:22 INFO - VRAM (Dynamic, Max): 1536 MB 16:26:22 INFO - Vendor: Intel (0x8086) 16:26:22 INFO - Device ID: 0x0a2e 16:26:22 INFO - Revision ID: 0x0009 16:26:22 INFO - Displays: 16:26:22 INFO - Display: 16:26:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:26:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:26:22 INFO - Display Serial Number: 1600x1200 60 16:26:22 INFO - Main Display: Yes 16:26:22 INFO - Mirror: Off 16:26:22 INFO - Online: Yes 16:26:22 INFO - Rotation: Supported 16:26:22 INFO - Return code: 0 16:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:26:22 INFO - Python 2.7.3 16:26:22 INFO - Return code: 0 16:26:22 INFO - grabbing minidump binary from tooltool 16:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:22 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 0x100713e00>, '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 0x10053cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10070eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:26:22 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 16:26:22 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 16:26:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:26:22 INFO - Return code: 0 16:26:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:26:23 INFO - Return code: 0 16:26:23 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', '--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-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:26:23 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 --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-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTCJlmNy0l/Render', 16:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:26:23 INFO - 'HOME': '/Users/cltbld', 16:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:26:23 INFO - 'LOGNAME': 'cltbld', 16:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:23 INFO - 'MOZ_NO_REMOTE': '1', 16:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:26:23 INFO - 'NO_EM_RESTART': '1', 16:26:23 INFO - 'PAGER': '/bin/cat', 16:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:23 INFO - 'PWD': '/builds/slave/test', 16:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:26:23 INFO - 'SHELL': '/bin/bash', 16:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg10TimxHW/Listeners', 16:26:23 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 16:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:26:23 INFO - 'USER': 'cltbld', 16:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:23 INFO - 'XPC_FLAGS': '0x0', 16:26:23 INFO - 'XPC_SERVICE_NAME': '0', 16:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:26:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:26:23 INFO - mozversion application_buildid: 20160426144059 16:26:23 INFO - mozversion application_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 16:26:23 INFO - mozversion application_display_name: Nightly 16:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:26:23 INFO - mozversion application_name: Firefox 16:26:23 INFO - mozversion application_remotingname: firefox 16:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:26:23 INFO - mozversion application_vendor: Mozilla 16:26:23 INFO - mozversion application_version: 49.0a1 16:26:23 INFO - mozversion platform_buildid: 20160426144059 16:26:23 INFO - mozversion platform_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 16:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:26:23 INFO - mozversion platform_version: 49.0a1 16:26:23 INFO - using testdate: 1461713183 16:26:23 INFO - actual date: 1461713183 16:26:23 INFO - starting webserver on 'localhost:49269' 16:26:23 INFO - SUITE-START | Running 2 tests 16:26:23 INFO - TEST-START | dromaeo_css 16:26:23 INFO - operating with platform_type : mac_ 16:26:23 INFO - Initialising browser for dromaeo_css test... 16:26:23 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpU7uisz/profile http://localhost:49269/getInfo.html) 16:26:25 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 16:26:25 INFO - PROCESS | 1652 | colorDepth:24 16:26:25 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 16:26:25 INFO - PROCESS | 1652 | __metrics 16:26:25 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:26:25 ERROR - PROCESS | 1652 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:26:26 INFO - TEST-INFO | 1652: exit 0 16:26:26 INFO - Browser initialized. 16:26:26 INFO - Running cycle 1/1 for dromaeo_css test... 16:26:26 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpU7uisz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:38 INFO - PROCESS | 1654 | RSS: Main: 239116288 16:26:38 INFO - PROCESS | 1654 | 16:27:30 INFO - PROCESS | 1654 | 1461713250026 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] 16:29:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 16:29:41 INFO - PROCESS | 1654 | RSS: Main: 396279808 16:29:41 INFO - PROCESS | 1654 | 16:32:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 16:32:45 INFO - PROCESS | 1654 | RSS: Main: 381607936 16:32:45 INFO - PROCESS | 1654 | 16:35:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 16:35:48 INFO - PROCESS | 1654 | RSS: Main: 375255040 16:35:48 INFO - PROCESS | 1654 | 16:38:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 16:38:51 INFO - PROCESS | 1654 | RSS: Main: 374784000 16:38:51 INFO - PROCESS | 1654 | 16:41:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 16:41:55 INFO - PROCESS | 1654 | RSS: Main: 343457792 16:41:55 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 16:44:58 INFO - PROCESS | 1654 | RSS: Main: 387788800 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | __start_tp_report 16:44:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 16:44:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 16:44:58 INFO - PROCESS | 1654 | |i|pagename|runs| 16:44:58 INFO - PROCESS | 1654 | |0;dojo.html;3347.4644056950888;3402.370561446133;3412.300478401927;3436.0722604896664;3477.235008298175;5568.582356323272;5631.380548139701;5632.408597097297;5647.43525647435;5661.490465858072;5577.637453565515;5650.124230744231;5659.405762394951;5674.829755107343;5688.886222275552;5059.6964182149095;5090.592752579803;5098.59211263098;5102.132637451624;5180.481951804808;4315.525292217869;5129.769160387791;5148.2020286855595;5161.458046905077;5193.5325820676135;5094.312267843849;5170.146925757264;5175.171972484403;5185.896282074356;5188.351456067991;5142.845714628548;5166.121759300928;5173.482651734834;5183.637145399824;5221.817236396708;5023.748812559394;5038.042771873333;5109.259157422191;5112.105381558213;5118.6416950813455;5464.207689884985;5471.343438787331;5485.259489968843;5525.806596769094;5583.804566840141;6076.301225359052;6115.082737589352;6124.601900876429;6125.356837532039;6131.570790044699;5280.709560974145;6101.2983506896835;6116.571839971204;6152.80020396023;6170.352113028157;5757.625754325955;5767.798127065533;5786.1610066540115;5795.826125216208;5835.299764028301;6178.62928224308;6250.249970003629;6268.655223962634;6271.278802937721;6287.465565426898;6000.069989151689;6023.161413562588;6042.516598672096;6093.177421048102;6122.938770612237;6217.502599792006;6243.968780156161;6245;6253.093301471261;6255.12428260044;5653.519450846642;6082.118092876508;6164.445199932027;6185.474234690102;6193.287771906288;5040.647154699209;5995.640261584319;6043.395660434009;6193.411625895533;6241.96879015602;4790.473047964721;4838.612910967114;4843.685160464629;4846.61227101831;4853.223484242504;4421.403110580095;4441.422615060022;4447.421835161408;4450.06548624786;4452.710573812692;5518.2826232590305;5547.750351234205;5551.444855514497;5552.444755524415;5557.083081291542;6132.845047373359;6163.722632481549;6223.066540019034;6236.937630623635;6255.749770009149;5602.523785478198;5602.915956260659;5606.915896261559;5619.550435965113;5620.213170156181;5256.211568264791;5353.330833645794;5357.11607584752;5360.276362690986;5369.114096174166;6229.314775374705;6294.685265736786;6322.083297921868;6335.36646335372;6339.524535659936;6255.186825712628;6260;6260.217472815898;6295.118683384421;6298.590591611531;6150.892839288971;6226.066090086342;6298.527610429144;6319.936800631935;6321.747130114744;4928.408590969107;6150.231221097363;6157.8607957528;6166.1983942087245;6171.413715697002;6198.163247961467;6232.127502149793;6243.37566243372;6253.499720022478;6253.687315634291;5877.353491115889;5978.312494063064;6000.639961602318;6065.696715164312;6077.544184186116;5790.855228619318;5915.615484993462;6085.695715214133;6097.4036925702085;6115.270764408704;5747.712614369181;5905.675187864708;5928.881422371443;5940.821775346746;5964.254468191476;5902.439268269508;6097.054956481752;6106.236720409949;6108.602940808833;6118.821051373654;5899.026660600953;5901.763929442946;5909.23179986599;5919.467247947706;5926.733297001559 16:44:58 INFO - PROCESS | 1654 | |1;ext.html;475.1162837122951;486.4405933176847;507.9009593129339;544.7004147718757;585.7217821534774;30089.398212035747;30925.536116958236;37953.67162149322;38938;39180;42481.15037699244;43220.78389608047;43373.7831310843;43411.78294108533;43430.565694343124;9426.811463770737;9643.807123857554;9681.177099946477;9681.322307438482;9685.32202745808;8346.749597512084;8544.914550854473;8546.957265213696;8562.400631955765;8579.95710021449;11281.37952412617;11589.710257243552;11596.072314214885;11606.709832254177;11623.360715160663;11283.774324513504;11467.254628449124;11467.598634047768;11469.534050179169;11472.082233421306;8255.917440825635;11015.83476247857;11202;11340.659780206606;11375.431228438545;29770.70229297701;37798;37878.8106059468;37923.241535169145;37949.24101517954;3228.903132905993;3255.8507430221066;3261.7390608751243;3339.34882697874;3482.1120614243205;26030.088946886768;27382.45235095287;27507.58738618922;27534.44931101367;27635.585466218025;2571.704254010794;2731.235254128847;2761.8078013335003;2779.1523585306472;2861.642294713161;334756.99999999756;384310;384535;387973.9999999972;389038;62473.75052498925;62796.68601656963;62858.371416286165;62976;63015.6849215751;65427.69144617081;65508;65519.344806552275;65543.34456655373;65575;16270.105144217181;16797.83202167987;16814.243359048873;16819.915900420663;16822.495325140266;12927.676808079874;12987.610371688865;12995;13004.219746815032;13012.47950082005;14138.727514523742;17170.055646939538;17399.391021314193;17564.121793910253;17853.7321940171;6183.319834818167;6332.145160403379;6389.827458664076;6392.712327945161;6427;982.6118683120128;995.7809281957958;1013.9340942838692;1151.6026970695098;1197.3534291482501;29390.412191756473;29730.73582330314;29752.702472974994;29804.403911922072;30654.846725766674;1087.0596933652334;1095.7917995580815;1128.6162704680448;1188.762247550476;1215.7082300248053;14822.851771482363;15014.174220417983;15410.460633877985;15434.228288585526;15527.611809704622;410298;482773;484324;487673;490039;58863.41136588665;59024.40975590275;59031.40968590345;59063;59409.51476213043;1342.3489607540334;1354.288998275913;1426.4436869621063;1483.6513419346445;1486.680363721805;22447.551048979254;28441.573376398956;28894;29129.854350728958;29498.262543436587;49307;53226;55268.72365638146;55343;55513;329244;331190;334566;336160;340352;32362.029139125865;39244;39590.60409395869;40738.79630601828;41403;44227.557724423634;44776.328355075355;45339.77330113328;45480.8629784258;45519;29274.560881586367;35604;37143.62856371402;38182.23635527218;38293.85118446451;35087.82456087703;35599.28801423905;35752;36410.63589364073;36432;34754.478682820285;35238.823805880806;37726.056848579006;38069.04827379338;38098;29753.10740677783;30640;31551.21121971969;31753.682463175996;31882.52176217312;23347.416314592272;23460.413489662213;23712.407189819703;23950.28149155528;23956.640650390607 16:44:58 INFO - PROCESS | 1654 | |2;jquery.html;372.8937252882928;389.6648881961513;390.36955317162773;400.4433836966615;409.7009183296196;16212.432564860232;18784.718229226557;19135.33026344075;20054.1978320867;20194.39416817496;18861.05694715262;19276.903615481937;19693.50766230845;20787.896060519714;20965.790342096614;5087.287779710843;5573.191887176357;5863.648181109126;6125.632462052291;6133.877322453548;6043.033114701649;6095.329513753483;6111.449969502743;6112.083187521863;6116.663583502906;5738.42615738427;6031.215941927543;6044.939550604482;6045.183900173464;6070.908936365958;5647.3505546862225;5986.161937328756;6019.578629495959;6024.09638554216;6025.608335458225;5155.149400348938;5155.690658560498;5180.171172612401;5184.922226166611;5238.109521381374;20334.491637709027;21137.471563211042;21377.358679239493;24823.25530234096;24887.875560622262;2066.8553201275918;2175.967360489594;2199.373178644095;2228.5988522066023;2350.142198097682;14594.927025364912;14973.775393369;15186.696266074616;15357;15382.461613843574;1676.8155502894795;1704.2671651189983;1766.6025144342548;1794.2284817528457;1816.3642725046127;109719.35420968692;112836;114088;114211;114464.28303575453;10510.527026283835;10931.836022459669;11178.720531986766;11180.608678696206;11341.773164536828;14065.367058482392;14146.929265353607;14160.929195354163;14179.78730319046;14201.147931124166;8620.655173792979;8811.603477843513;8815.515146666994;8921.241694455914;8952.14954579314;8775.122487751301;8775.210231079234;8793.38446308765;8930.821383572422;8943.195112439911;6557.475401967831;6703.698333575001;6704.96647516769;6760.898586521206;6761.966190169018;1856.610111876494;1873.2319748902885;1880.0881572437356;1890;1918.0697361779526;968.2544440780559;1009.2279406254221;1036.2694300518117;1047.6804574604819;1061.474570087796;19231.553960916033;19730.90134549318;20096.39710808678;20371.490712732004;20537.897310513352;979.6816034788723;983.8032393521181;997.3118548201718;998.32612986234;1026.8921763214905;10991.560337586567;11378.601748938747;11443.828342574869;11507.252028618113;11543.538258469567;601148;601660;619528;626067;626991;56192.87614247692;77110.6144469274;103615;104193.47903260436;106687;992.1269283030887;1013;1030.860833787444;1052.4948024947914;1057.7884423115254;15796.76304855405;17912.910435448262;18402.539936501693;18798.624027519647;18863.784175590303;38603.61396386113;39242.2151556973;39751.60248397479;41139.97150071272;43128.13743725171;59521.702391487765;60066;60886.695566521885;61241.775164497354;62699.37300626935;7810.101838288442;7849.960750196213;7896.881546776688;7909.446338756462;7921.881171782313;10172.593096276067;12030.338331391857;12482.001439884969;12497.93751031239;12534.749305014031;10504.947475262576;10594.364338139736;10648.89351106479;10675.081372524784;10865.239433239914;10386.636467723594;10448;10595.629152979609;10698.144148467949;10787.946060269649;7844.725434609762;10449;11072.778544429228;11123.943225393574;11158.497867595815;7223.8555228896175;7922.524648521107;7974.441789074709;7987.121416644049;8170.264676178935;10314.535845886803;10786.514606842555;11058.396532502902;11067.225294229327;11094.778104438028 16:44:58 INFO - PROCESS | 1654 | |3;mootools.html;1367.7127803161338;1416.5396246219982;1607.3168903216133;1801.5676237702955;1986.2452268138106;7891.802704932373;8136.918630813698;8937.776555586113;8952.373333866632;8970.955145224281;8539.103394143604;8769.123087691243;8775.166359195866;8788.340874434427;8801.031886492481;2453.852768833867;2487.2911220302217;2490.439651078511;2491.638712386703;2496.4757400945823;2234.7876951689564;2430.2709187243845;2489.4025433895827;2490.178241180406;2496.1388321029217;2198.670199470076;2442.218490083174;2457.0785955266774;2477.876106194692;2481.2184161988916;2417.226487523993;2443.450223699671;2448.51029794041;2449.020391843268;2459.0655550890724;2411.9035238590436;2432.6715893354526;2442.6091825307867;2442.6091825307867;2444.2401470940895;8510.446820956618;8785.73642790711;8862.11378862115;8865.113488651083;8872.467651940904;4659.906801863977;5214.687118772886;5226.425093239741;5486.31421072366;5511.917321240185;3513.8067406292644;3542.0613537412605;3670.467782171597;3674.026383008505;3679.3193259247123;1032.7521394865178;1064.1486810551528;1067.2849191041944;1068.7221322456217;1070.6734445994045;11242.831357529643;11682.766344673144;11700.356480393575;11704.53181872724;11720.238184517979;4834.734089625034;4900.558949694473;4916.262560615936;5011.574016208663;5038.168702164102;10220.846687299696;10245.7438564035;10251.692449226535;10260.640877569249;10273.126784223276;5562.527185189304;5562.944370556243;5564.582656300794;5566.916496252559;5567;4356.4336636237085;4472.910541789146;4552.306750847025;4981.12830254704;5003.524665156804;3313.353895990259;3949.2496425679606;4048.2510735514024;4095.935056885172;4105.261053010427;1291.8256035435095;1301.342821874947;1341.1952828303135;1361.7539950944774;1375.2917247617486;890.5324704530044;918.6876462002817;925.9398139121071;938.8591711243369;958.0228167269346;5194.75325921776;5325;5698.2592263005545;5876.294844618587;5910.054391297458;397.37215199983956;469.957703806659;473.3444179810987;487.16451286043895;487.9194932836113;3735.9252814943547;3882.8835134946;3960.9009774755286;3965.7025723070883;3967.3652215645357;10299.12457441111;10834.891651083388;10893.346399216072;10986.066184374258;10992.340459572291;10315.432651204255;10924.96212859777;10941.070009049161;10947.945260273807;10962.616308429326;8189.385796065319;8224.259816616413;8277.54473503951;8367.372447066495;8368.748937531762;4746.691465054761;5688.857778555569;5833.4749872511675;5980.581359304807;6144.600600960924;9721.173700235277;9750.268729845431;9854;9905.900940990787;10094.646687365906;9823.950880245553;9894.752631184278;9970.252231082553;10099.242556808416;10114.29199955996;6926.722931082902;7234.891476627749;7385.113786345673;7618.085829700472;7624.199459056941;7526.795712685944;7982.441229113906;8287.792805179919;8316.83366332682;8391.16088391156;7147.356737893615;7438.851222975619;7499.737509187153;7500.512466689648;7570.205128461653;7191.101112360955;7303.780886573411;7307.378872795872;7466.701331946661;7476.25237476248;6946.8610627788175;7000.719971201095;7028.262032486516;7028.824279393056;7035.788926332219;4531.342955271533;4695.929561056519;4733.1716949533;4802.135615589227;4881.780319885543;4603.733973157408;4901.2893130496595;4938.555530002173;4964.553190212898;5104.795808167632 16:44:58 INFO - PROCESS | 1654 | |4;prototype.html;318.3728055730211;319.7234392250703;325.0784027282652;327.31264344875757;330.1037682691492;4814.63890208234;4934.407871055474;5280.973595132024;5366.302380690505;5380.973095134519;5305.363356397228;5314.521693047625;5352.464753524655;5363.8122665706705;5384.811531596395;3168.892686363571;3945.5857135000842;3996.900077498057;4101.159262351211;4101.200265948141;3574.6782789548934;3608.5850127235312;4034.1326614777818;4056.8580099696514;4098.663761655857;3413.4197186478236;3447.7586568940183;3998.6401223889843;4018.9598104019024;4086.9973712880624;3716.758410703296;3823.5985221551614;3892.6107389260987;3917.8041097945134;4098.385242213662;3540.398132317512;3553.573571171476;3563.750537462379;3564.893053208382;3576.4635304704243;4836.903261934777;5119.2321151827155;5126.846194614168;5133.666311689728;5134.306868572732;3938.8227529760943;4507.774611269423;4676.392069031038;4711.623070154414;4740.762961851894;4903.607711383081;5564.554835613141;5565.5825813063775;5573.41479144688;5632.7746890124345;3197;3339.5658564386717;3682.742208045438;3971.153413662632;4040.8585699500672;5481.698506582136;5808.3901190375245;5828.388019258002;5854.297484301911;5858.853528661775;3329.6170940341685;3582.194006348551;3661.0664280608808;3778.678812300985;4027.838886444568;3522.330757156132;3816.293985612615;4105.609967053125;4107.732997355162;4108.979455102705;3619.8552057917914;4036.313826649418;4471.642268618502;4621.936954500484;4710.905781884411;4948.455669876311;5251.687078230442;5339.626226164131;5644.5484361251;5693.146028095819;1250.9117068150767;1431.5705288413642;1462.429652435551;1463.6999415119874;1467.7137958098283;822.5558198572704;914.4147745442922;934.5233930695258;970.9514524273758;971.8639390485338;4185.686073544435;4685.976570117127;5023.974880125576;5239.659422137549;5574.275344205227;5779.219805326311;5787.8553036174435;5797.2173756542325;5806.274215723035;5830.5044071254415;4959.305697202394;5234.67057159568;5255.5532779713385;5266.710330931759;5292.2800089970915;2905.157504323765;3287.2110693433406;3330.1341651170387;3344.9498257526157;3361.1261072121424;6056.515478761688;6614.371634694697;6642.96678516614;6662.800115996431;6688.331166883273;4949.267756285271;5058.367704036996;5285.947140528622;5638.971805140948;5985.545926170336;5139.820106296262;5793.971030144822;5804.862696513532;6023.397660234029;6079.696015199311;5269.341332333458;5506.504414602705;5824.767009319749;5837.328707198557;5845.590808643354;5815.273090863642;5822.417758224144;5824.271966004249;5860.443257890493;5864.794732184353;5390.407055223844;5712.34308054579;5822.796202132905;6143.477804386677;6170.722317495633;3175.8412079395475;3370.5786776652917;3382.627910929845;3403.625601183818;3986.700997425147;4560.67405623128;4670.556297151765;5853.443922827325;5896.557758168069;5920.822375328747;5480.232767412645;5720.399358067343;5734.455226753452;5747.15515819672;5750.482456578928;4323.78381080951;5587.497125258747;5680.829575112753;5706.146926536731;5742.856428589152;4425.756583387944;4944.975275123601;4951.430585482715;5354.892902141857;5646.830595082154;5522.641028333145;5619.775208991595;5688.232088668143;5693;5693.345265294544;4915.434725006527;5544.473275038865;5577.52591029767;5587.608867379245;5643.858903527444 16:44:58 INFO - PROCESS | 1654 | |5;yui.html;622.7726879688913;653.8071268975651;680.2755065854861;720.9963950180248;739.1167554772046;14376.71246575068;14597.635059123528;14893.77659335111;14928.25358732063;14934.551963441101;14011.369488373022;14103;14105.294735263247;14109.012369134165;14121.505747298846;724.6920058974941;746.1531162130993;889.0087552379115;892.2415946445518;905.4567259644226;889.5552223888056;918.3663272342096;921.9907800922006;924.5053896165552;925.1026504290827;945.7966537194502;984.1585444445004;986.0238364019641;986.0927946289431;987.2940847294183;763.4159867701213;816.7100679258837;820.216693058128;946.5172761891416;985.4727720669479;681.6591704147926;697.0485287582464;709.1986055756962;710.4955481608065;712.8289210589473;14791.260436978107;14885.92557037208;14890.702185956328;14895.32971016296;14902.850971490363;12032.939835300767;12300.384980751016;12348.38258087101;12359.25844449336;12461.483410532204;10843.566257349696;11015.228933974626;11088;11138.164637652208;11483.20098350336;4084.7957602119777;4200.411942328046;4228.894277643053;4258.488981322261;4294.656427485794;77127.45745085123;77740.22259777387;77879;78317;78549.60725196394;9585.089416505421;9611.903880961101;9643.566039528238;9690.660826871026;9772.16936560386;21528.354149375544;21774.782252177592;21827.236046738606;21837.563248734936;22562.984665690085;7695.345895598824;7728.536287822636;7891.684332626745;7978.5611791350875;8036.758897233092;4054.1688953764406;4160.108724436548;4169.499660040754;4174.4364510791265;4466.1067786442845;3602.5136606558303;3698.6671199592165;3701.6668499835146;3705.81470926458;3707.1658876753054;659.5317324699421;659.9010148477671;665.643880523927;666.5733930284622;671.9092922455503;536.3429798496888;540.3245942571785;557.5278640146945;577.1631134854478;620.2835724737935;7843.882341764878;8047.195280472023;8265;8419.158084191531;8472.279856212292;512.0118171928215;528.918017707256;587.090010483757;609.1441524657863;613.414189449075;3299.173717773724;3661.487391765155;3714.23858109087;3789.4315852622326;4021.5174179098694;91437;91535;91973.5401322989;92389;94747.0525294752;69199;75160.62419687866;77255;77931;80788;68116.6594167036;69232.65383673151;69417.65291173512;69626.9555956661;71841.28158718346;7628.504147230412;7744.114473000673;7752.612369381395;7779.883301750365;7876.133625301327;43999.560004399544;44428.55571444244;44523;44888;44953.32570011387;59481.70259148676;59599.70200148971;64743.35256647373;64789.676051621325;64797;10520.631777887736;10542.525586348786;10701.94649026781;10739.677809665722;11010.39442830652;11173.944130279297;11257.155713321697;11265.324080555192;11594.536218551164;12264.93376655836;10450.320729152581;10472.476376181314;10477.16182705397;10851.837222441827;10884.238103332691;10460.79078418412;10559.63041293551;10789.946050269698;10834.891651083704;10855.40295283767;10376.896231037594;10422.133913173939;10783.137349011904;10914.072303854262;11410.030147437228;8758.386912916034;8759.824803504021;9102.59038343263;9113.225375843127;9193.77015574616;8800.38397312182;8840.29277657773;8978.416402933788;9086.636534538544;9144.085591440802 16:44:58 INFO - PROCESS | 1654 | __end_tp_report 16:44:58 INFO - PROCESS | 1654 | __start_cc_report 16:44:58 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1551 16:44:58 INFO - PROCESS | 1654 | __end_cc_report 16:44:58 INFO - PROCESS | 1654 | __startTimestamp1461714298696__endTimestamp 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | ------- Summary: start ------- 16:44:58 INFO - PROCESS | 1654 | Number of tests: 6 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5664.74 Median:5899.03 stddev:639.94 (10.8%) stddev-sans-first:615.54 16:44:58 INFO - PROCESS | 1654 | Values: 3347.5 3402.4 3412.3 3436.1 3477.2 5568.6 5631.4 5632.4 5647.4 5661.5 5577.6 5650.1 5659.4 5674.8 5688.9 5059.7 5090.6 5098.6 5102.1 5180.5 4315.5 5129.8 5148.2 5161.5 5193.5 5094.3 5170.1 5175.2 5185.9 5188.4 5142.8 5166.1 5173.5 5183.6 5221.8 5023.7 5038.0 5109.3 5112.1 5118.6 5464.2 5471.3 5485.3 5525.8 5583.8 6076.3 6115.1 6124.6 6125.4 6131.6 5280.7 6101.3 6116.6 6152.8 6170.4 5757.6 5767.8 5786.2 5795.8 5835.3 6178.6 6250.2 6268.7 6271.3 6287.5 6000.1 6023.2 6042.5 6093.2 6122.9 6217.5 6244.0 6245.0 6253.1 6255.1 5653.5 6082.1 6164.4 6185.5 6193.3 5040.6 5995.6 6043.4 6193.4 6242.0 4790.5 4838.6 4843.7 4846.6 4853.2 4421.4 4441.4 4447.4 4450.1 4452.7 5518.3 5547.8 5551.4 5552.4 5557.1 6132.8 6163.7 6223.1 6236.9 6255.7 5602.5 5602.9 5606.9 5619.6 5620.2 5256.2 5353.3 5357.1 5360.3 5369.1 6229.3 6294.7 6322.1 6335.4 6339.5 6255.2 6260.0 6260.2 6295.1 6298.6 6150.9 6226.1 6298.5 6319.9 6321.7 4928.4 6150.2 6157.9 6166.2 6171.4 6198.2 6232.1 6243.4 6253.5 6253.7 5877.4 5978.3 6000.6 6065.7 6077.5 5790.9 5915.6 6085.7 6097.4 6115.3 5747.7 5905.7 5928.9 5940.8 5964.3 5902.4 6097.1 6106.2 6108.6 6118.8 5899.0 5901.8 5909.2 5919.5 5926.7 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:55532.08 Median:338256.00 stddev:105372.52 (31.2%) stddev-sans-first:105587.04 16:44:58 INFO - PROCESS | 1654 | Values: 475.1 486.4 507.9 544.7 585.7 30089.4 30925.5 37953.7 38938.0 39180.0 42481.2 43220.8 43373.8 43411.8 43430.6 9426.8 9643.8 9681.2 9681.3 9685.3 8346.7 8544.9 8547.0 8562.4 8580.0 11281.4 11589.7 11596.1 11606.7 11623.4 11283.8 11467.3 11467.6 11469.5 11472.1 8255.9 11015.8 11202.0 11340.7 11375.4 29770.7 37798.0 37878.8 37923.2 37949.2 3228.9 3255.9 3261.7 3339.3 3482.1 26030.1 27382.5 27507.6 27534.4 27635.6 2571.7 2731.2 2761.8 2779.2 2861.6 334757.0 384310.0 384535.0 387974.0 389038.0 62473.8 62796.7 62858.4 62976.0 63015.7 65427.7 65508.0 65519.3 65543.3 65575.0 16270.1 16797.8 16814.2 16819.9 16822.5 12927.7 12987.6 12995.0 13004.2 13012.5 14138.7 17170.1 17399.4 17564.1 17853.7 6183.3 6332.1 6389.8 6392.7 6427.0 982.6 995.8 1013.9 1151.6 1197.4 29390.4 29730.7 29752.7 29804.4 30654.8 1087.1 1095.8 1128.6 1188.8 1215.7 14822.9 15014.2 15410.5 15434.2 15527.6 410298.0 482773.0 484324.0 487673.0 490039.0 58863.4 59024.4 59031.4 59063.0 59409.5 1342.3 1354.3 1426.4 1483.7 1486.7 22447.6 28441.6 28894.0 29129.9 29498.3 49307.0 53226.0 55268.7 55343.0 55513.0 329244.0 331190.0 334566.0 336160.0 340352.0 32362.0 39244.0 39590.6 40738.8 41403.0 44227.6 44776.3 45339.8 45480.9 45519.0 29274.6 35604.0 37143.6 38182.2 38293.9 35087.8 35599.3 35752.0 36410.6 36432.0 34754.5 35238.8 37726.1 38069.0 38098.0 29753.1 30640.0 31551.2 31753.7 31882.5 23347.4 23460.4 23712.4 23950.3 23956.6 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:33405.18 Median:11427.38 stddev:101469.13 (887.9%) stddev-sans-first:101723.46 16:44:58 INFO - PROCESS | 1654 | Values: 372.9 389.7 390.4 400.4 409.7 16212.4 18784.7 19135.3 20054.2 20194.4 18861.1 19276.9 19693.5 20787.9 20965.8 5087.3 5573.2 5863.6 6125.6 6133.9 6043.0 6095.3 6111.4 6112.1 6116.7 5738.4 6031.2 6044.9 6045.2 6070.9 5647.4 5986.2 6019.6 6024.1 6025.6 5155.1 5155.7 5180.2 5184.9 5238.1 20334.5 21137.5 21377.4 24823.3 24887.9 2066.9 2176.0 2199.4 2228.6 2350.1 14594.9 14973.8 15186.7 15357.0 15382.5 1676.8 1704.3 1766.6 1794.2 1816.4 109719.4 112836.0 114088.0 114211.0 114464.3 10510.5 10931.8 11178.7 11180.6 11341.8 14065.4 14146.9 14160.9 14179.8 14201.1 8620.7 8811.6 8815.5 8921.2 8952.1 8775.1 8775.2 8793.4 8930.8 8943.2 6557.5 6703.7 6705.0 6760.9 6762.0 1856.6 1873.2 1880.1 1890.0 1918.1 968.3 1009.2 1036.3 1047.7 1061.5 19231.6 19730.9 20096.4 20371.5 20537.9 979.7 983.8 997.3 998.3 1026.9 10991.6 11378.6 11443.8 11507.3 11543.5 601148.0 601660.0 619528.0 626067.0 626991.0 56192.9 77110.6 103615.0 104193.5 106687.0 992.1 1013.0 1030.9 1052.5 1057.8 15796.8 17912.9 18402.5 18798.6 18863.8 38603.6 39242.2 39751.6 41140.0 43128.1 59521.7 60066.0 60886.7 61241.8 62699.4 7810.1 7850.0 7896.9 7909.4 7921.9 10172.6 12030.3 12482.0 12497.9 12534.7 10504.9 10594.4 10648.9 10675.1 10865.2 10386.6 10448.0 10595.6 10698.1 10787.9 7844.7 10449.0 11072.8 11123.9 11158.5 7223.9 7922.5 7974.4 7987.1 8170.3 10314.5 10786.5 11058.4 11067.2 11094.8 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5702.85 Median:4818.43 stddev:3211.41 (66.6%) stddev-sans-first:3203.89 16:44:58 INFO - PROCESS | 1654 | Values: 1367.7 1416.5 1607.3 1801.6 1986.2 7891.8 8136.9 8937.8 8952.4 8971.0 8539.1 8769.1 8775.2 8788.3 8801.0 2453.9 2487.3 2490.4 2491.6 2496.5 2234.8 2430.3 2489.4 2490.2 2496.1 2198.7 2442.2 2457.1 2477.9 2481.2 2417.2 2443.5 2448.5 2449.0 2459.1 2411.9 2432.7 2442.6 2442.6 2444.2 8510.4 8785.7 8862.1 8865.1 8872.5 4659.9 5214.7 5226.4 5486.3 5511.9 3513.8 3542.1 3670.5 3674.0 3679.3 1032.8 1064.1 1067.3 1068.7 1070.7 11242.8 11682.8 11700.4 11704.5 11720.2 4834.7 4900.6 4916.3 5011.6 5038.2 10220.8 10245.7 10251.7 10260.6 10273.1 5562.5 5562.9 5564.6 5566.9 5567.0 4356.4 4472.9 4552.3 4981.1 5003.5 3313.4 3949.2 4048.3 4095.9 4105.3 1291.8 1301.3 1341.2 1361.8 1375.3 890.5 918.7 925.9 938.9 958.0 5194.8 5325.0 5698.3 5876.3 5910.1 397.4 470.0 473.3 487.2 487.9 3735.9 3882.9 3960.9 3965.7 3967.4 10299.1 10834.9 10893.3 10986.1 10992.3 10315.4 10925.0 10941.1 10947.9 10962.6 8189.4 8224.3 8277.5 8367.4 8368.7 4746.7 5688.9 5833.5 5980.6 6144.6 9721.2 9750.3 9854.0 9905.9 10094.6 9824.0 9894.8 9970.3 10099.2 10114.3 6926.7 7234.9 7385.1 7618.1 7624.2 7526.8 7982.4 8287.8 8316.8 8391.2 7147.4 7438.9 7499.7 7500.5 7570.2 7191.1 7303.8 7307.4 7466.7 7476.3 6946.9 7000.7 7028.3 7028.8 7035.8 4531.3 4695.9 4733.2 4802.1 4881.8 4603.7 4901.3 4938.6 4964.6 5104.8 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4560.59 Median:5133.99 stddev:1432.58 (27.9%) stddev-sans-first:1400.77 16:44:58 INFO - PROCESS | 1654 | Values: 318.4 319.7 325.1 327.3 330.1 4814.6 4934.4 5281.0 5366.3 5381.0 5305.4 5314.5 5352.5 5363.8 5384.8 3168.9 3945.6 3996.9 4101.2 4101.2 3574.7 3608.6 4034.1 4056.9 4098.7 3413.4 3447.8 3998.6 4019.0 4087.0 3716.8 3823.6 3892.6 3917.8 4098.4 3540.4 3553.6 3563.8 3564.9 3576.5 4836.9 5119.2 5126.8 5133.7 5134.3 3938.8 4507.8 4676.4 4711.6 4740.8 4903.6 5564.6 5565.6 5573.4 5632.8 3197.0 3339.6 3682.7 3971.2 4040.9 5481.7 5808.4 5828.4 5854.3 5858.9 3329.6 3582.2 3661.1 3778.7 4027.8 3522.3 3816.3 4105.6 4107.7 4109.0 3619.9 4036.3 4471.6 4621.9 4710.9 4948.5 5251.7 5339.6 5644.5 5693.1 1250.9 1431.6 1462.4 1463.7 1467.7 822.6 914.4 934.5 971.0 971.9 4185.7 4686.0 5024.0 5239.7 5574.3 5779.2 5787.9 5797.2 5806.3 5830.5 4959.3 5234.7 5255.6 5266.7 5292.3 2905.2 3287.2 3330.1 3344.9 3361.1 6056.5 6614.4 6643.0 6662.8 6688.3 4949.3 5058.4 5285.9 5639.0 5985.5 5139.8 5794.0 5804.9 6023.4 6079.7 5269.3 5506.5 5824.8 5837.3 5845.6 5815.3 5822.4 5824.3 5860.4 5864.8 5390.4 5712.3 5822.8 6143.5 6170.7 3175.8 3370.6 3382.6 3403.6 3986.7 4560.7 4670.6 5853.4 5896.6 5920.8 5480.2 5720.4 5734.5 5747.2 5750.5 4323.8 5587.5 5680.8 5706.1 5742.9 4425.8 4945.0 4951.4 5354.9 5646.8 5522.6 5619.8 5688.2 5693.0 5693.3 4915.4 5544.5 5577.5 5587.6 5643.9 16:44:58 INFO - PROCESS | 1654 | 16:44:58 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:17796.43 Median:616.85 stddev:24948.42 (4044.5%) stddev-sans-first:24985.08 16:44:58 INFO - PROCESS | 1654 | Values: 622.8 653.8 680.3 721.0 739.1 14376.7 14597.6 14893.8 14928.3 14934.6 14011.4 14103.0 14105.3 14109.0 14121.5 724.7 746.2 889.0 892.2 905.5 889.6 918.4 922.0 924.5 925.1 945.8 984.2 986.0 986.1 987.3 763.4 816.7 820.2 946.5 985.5 681.7 697.0 709.2 710.5 712.8 14791.3 14885.9 14890.7 14895.3 14902.9 12032.9 12300.4 12348.4 12359.3 12461.5 10843.6 11015.2 11088.0 11138.2 11483.2 4084.8 4200.4 4228.9 4258.5 4294.7 77127.5 77740.2 77879.0 78317.0 78549.6 9585.1 9611.9 9643.6 9690.7 9772.2 21528.4 21774.8 21827.2 21837.6 22563.0 7695.3 7728.5 7891.7 7978.6 8036.8 4054.2 4160.1 4169.5 4174.4 4466.1 3602.5 3698.7 3701.7 3705.8 3707.2 659.5 659.9 665.6 666.6 671.9 536.3 540.3 557.5 577.2 620.3 7843.9 8047.2 8265.0 8419.2 8472.3 512.0 528.9 587.1 609.1 613.4 3299.2 3661.5 3714.2 3789.4 4021.5 91437.0 91535.0 91973.5 92389.0 94747.1 69199.0 75160.6 77255.0 77931.0 80788.0 68116.7 69232.7 69417.7 69627.0 71841.3 7628.5 7744.1 7752.6 7779.9 7876.1 43999.6 44428.6 44523.0 44888.0 44953.3 59481.7 59599.7 64743.4 64789.7 64797.0 10520.6 10542.5 10701.9 10739.7 11010.4 11173.9 11257.2 11265.3 11594.5 12264.9 10450.3 10472.5 10477.2 10851.8 10884.2 10460.8 10559.6 10789.9 10834.9 10855.4 10376.9 10422.1 10783.1 10914.1 11410.0 8758.4 8759.8 9102.6 9113.2 9193.8 8800.4 8840.3 8978.4 9086.6 9144.1 16:44:58 INFO - PROCESS | 1654 | -------- Summary: end -------- 16:44:58 INFO - PROCESS | 1654 | 16:44:59 INFO - TEST-INFO | 1654: exit 0 16:44:59 INFO - TEST-OK | dromaeo_css | took 1115861ms 16:44:59 INFO - TEST-START | kraken 16:44:59 INFO - operating with platform_type : mac_ 16:44:59 INFO - Initialising browser for kraken test... 16:44:59 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp1rrfYY/profile http://localhost:49269/getInfo.html) 16:45:01 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 16:45:01 INFO - PROCESS | 1664 | colorDepth:24 16:45:01 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 16:45:01 INFO - PROCESS | 1664 | __metrics 16:45:01 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:45:01 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:45:02 INFO - TEST-INFO | 1664: exit 0 16:45:02 INFO - Browser initialized. 16:45:02 INFO - Running cycle 1/1 for kraken test... 16:45:02 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp1rrfYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:14 INFO - PROCESS | 1666 | RSS: Main: 239140864 16:45:14 INFO - PROCESS | 1666 | 16:45:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 16:45:17 INFO - PROCESS | 1666 | RSS: Main: 286425088 16:45:17 INFO - PROCESS | 1666 | 16:45:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 16:45:20 INFO - PROCESS | 1666 | RSS: Main: 299864064 16:45:20 INFO - PROCESS | 1666 | 16:45:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 16:45:24 INFO - PROCESS | 1666 | RSS: Main: 387047424 16:45:24 INFO - PROCESS | 1666 | 16:45:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 16:45:27 INFO - PROCESS | 1666 | RSS: Main: 287838208 16:45:27 INFO - PROCESS | 1666 | 16:45:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:45:30 INFO - PROCESS | 1666 | RSS: Main: 292208640 16:45:30 INFO - PROCESS | 1666 | 16:45:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 16:45:33 INFO - PROCESS | 1666 | RSS: Main: 328347648 16:45:33 INFO - PROCESS | 1666 | 16:45:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 16:45:37 INFO - PROCESS | 1666 | RSS: Main: 330661888 16:45:37 INFO - PROCESS | 1666 | 16:45:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 16:45:40 INFO - PROCESS | 1666 | RSS: Main: 327950336 16:45:40 INFO - PROCESS | 1666 | 16:45:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:45:42 INFO - PROCESS | 1666 | RSS: Main: 321495040 16:45:42 INFO - PROCESS | 1666 | 16:45:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:45:45 INFO - PROCESS | 1666 | RSS: Main: 328253440 16:45:45 INFO - PROCESS | 1666 | 16:45:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:45:48 INFO - PROCESS | 1666 | RSS: Main: 330694656 16:45:48 INFO - PROCESS | 1666 | 16:45:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:45:51 INFO - PROCESS | 1666 | RSS: Main: 326230016 16:45:51 INFO - PROCESS | 1666 | 16:45:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:45:55 INFO - PROCESS | 1666 | RSS: Main: 326217728 16:45:55 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 16:45:57 INFO - PROCESS | 1666 | RSS: Main: 390590464 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | __start_tp_report 16:45:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 16:45:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 16:45:57 INFO - PROCESS | 1666 | |i|pagename|runs| 16:45:57 INFO - PROCESS | 1666 | |0;ai-astar;113;113;106;113;113;111;113;112;104;115 16:45:57 INFO - PROCESS | 1666 | |1;audio-beat-detection;157;122;144;168;119;139;152;153;181;118 16:45:57 INFO - PROCESS | 1666 | |2;audio-dft;183;187;186;183;183;182;181;185;182;183 16:45:57 INFO - PROCESS | 1666 | |3;audio-fft;76;73;89;93;58;57;58;84;86;56 16:45:57 INFO - PROCESS | 1666 | |4;audio-oscillator;92;93;136;78;79;81;126;79;77;126 16:45:57 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;90;86;90;88;90;87;91;87;90;86 16:45:57 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;94;96;95;88;148;136;94;93;94 16:45:57 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;84;84;84;83;85;87;84;82;84 16:45:57 INFO - PROCESS | 1666 | |8;json-parse-financial;60;63;58;56;58;58;58;76;61;57 16:45:57 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;63;62;78;74;71;70;98;100;95;68 16:45:57 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;82;82;82;82;78;80;82;82;82;84 16:45:57 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;159;143;138;136;136;137;139;153;198;143 16:45:57 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;205;199;199;198;202;197;200;202;198;198 16:45:57 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;71;68;70;69;70;69;71;69;69;69 16:45:57 INFO - PROCESS | 1666 | __end_tp_report 16:45:57 INFO - PROCESS | 1666 | __start_cc_report 16:45:57 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2004 16:45:57 INFO - PROCESS | 1666 | __end_cc_report 16:45:57 INFO - PROCESS | 1666 | __startTimestamp1461714357558__endTimestamp 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | ------- Summary: start ------- 16:45:57 INFO - PROCESS | 1666 | Number of tests: 14 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:3.66 16:45:57 INFO - PROCESS | 1666 | Values: 113.0 113.0 106.0 113.0 113.0 111.0 113.0 112.0 104.0 115.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.50 stddev:21.22 (13.9%) stddev-sans-first:22.08 16:45:57 INFO - PROCESS | 1666 | Values: 157.0 122.0 144.0 168.0 119.0 139.0 152.0 153.0 181.0 118.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.00 stddev:1.90 (1.0%) stddev-sans-first:2.01 16:45:57 INFO - PROCESS | 1666 | Values: 183.0 187.0 186.0 183.0 183.0 182.0 181.0 185.0 182.0 183.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:73.00 Median:80.00 stddev:14.72 (18.4%) stddev-sans-first:15.57 16:45:57 INFO - PROCESS | 1666 | Values: 76.0 73.0 89.0 93.0 58.0 57.0 58.0 84.0 86.0 56.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.00 stddev:23.35 (29.6%) stddev-sans-first:24.71 16:45:57 INFO - PROCESS | 1666 | Values: 92.0 93.0 136.0 78.0 79.0 81.0 126.0 79.0 77.0 126.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:90.00 stddev:1.90 (2.1%) stddev-sans-first:1.94 16:45:57 INFO - PROCESS | 1666 | Values: 90.0 86.0 90.0 88.0 90.0 87.0 91.0 87.0 90.0 86.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:94.00 stddev:20.75 (22.1%) stddev-sans-first:21.74 16:45:57 INFO - PROCESS | 1666 | Values: 94.0 94.0 96.0 95.0 88.0 148.0 136.0 94.0 93.0 94.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 16:45:57 INFO - PROCESS | 1666 | Values: 84.0 84.0 84.0 84.0 83.0 85.0 87.0 84.0 82.0 84.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:5.82 (9.9%) stddev-sans-first:6.17 16:45:57 INFO - PROCESS | 1666 | Values: 60.0 63.0 58.0 56.0 58.0 58.0 58.0 76.0 61.0 57.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:72.50 stddev:14.46 (20.0%) stddev-sans-first:14.30 16:45:57 INFO - PROCESS | 1666 | Values: 63.0 62.0 78.0 74.0 71.0 70.0 98.0 100.0 95.0 68.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.58 (1.9%) stddev-sans-first:1.67 16:45:57 INFO - PROCESS | 1666 | Values: 82.0 82.0 82.0 82.0 78.0 80.0 82.0 82.0 82.0 84.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:143.00 stddev:19.11 (13.4%) stddev-sans-first:19.86 16:45:57 INFO - PROCESS | 1666 | Values: 159.0 143.0 138.0 136.0 136.0 137.0 139.0 153.0 198.0 143.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.80 Median:199.50 stddev:2.49 (1.2%) stddev-sans-first:1.79 16:45:57 INFO - PROCESS | 1666 | Values: 205.0 199.0 199.0 198.0 202.0 197.0 200.0 202.0 198.0 198.0 16:45:57 INFO - PROCESS | 1666 | 16:45:57 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 16:45:57 INFO - PROCESS | 1666 | Values: 71.0 68.0 70.0 69.0 70.0 69.0 71.0 69.0 69.0 69.0 16:45:57 INFO - PROCESS | 1666 | -------- Summary: end -------- 16:45:57 INFO - PROCESS | 1666 | 16:45:58 INFO - TEST-INFO | 1666: exit 0 16:45:58 INFO - TEST-OK | kraken | took 58965ms 16:45:58 INFO - SUITE-END | took 1174s 16:45:58 INFO - Completed test suite (00:19:35) 16:45:58 INFO - javascript benchmark 16:45:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.4644056950888, 3402.370561446133, 3412.300478401927, 3436.0722604896664, 3477.235008298175, 5568.582356323272, 5631.380548139701, 5632.408597097297, 5647.43525647435, 5661.490465858072, 5577.637453565515, 5650.124230744231, 5659.405762394951, 5674.829755107343, 5688.886222275552, 5059.6964182149095, 5090.592752579803, 5098.59211263098, 5102.132637451624, 5180.481951804808, 4315.525292217869, 5129.769160387791, 5148.2020286855595, 5161.458046905077, 5193.5325820676135, 5094.312267843849, 5170.146925757264, 5175.171972484403, 5185.896282074356, 5188.351456067991, 5142.845714628548, 5166.121759300928, 5173.482651734834, 5183.637145399824, 5221.817236396708, 5023.748812559394, 5038.042771873333, 5109.259157422191, 5112.105381558213, 5118.6416950813455, 5464.207689884985, 5471.343438787331, 5485.259489968843, 5525.806596769094, 5583.804566840141, 6076.301225359052, 6115.082737589352, 6124.601900876429, 6125.356837532039, 6131.570790044699, 5280.709560974145, 6101.2983506896835, 6116.571839971204, 6152.80020396023, 6170.352113028157, 5757.625754325955, 5767.798127065533, 5786.1610066540115, 5795.826125216208, 5835.299764028301, 6178.62928224308, 6250.249970003629, 6268.655223962634, 6271.278802937721, 6287.465565426898, 6000.069989151689, 6023.161413562588, 6042.516598672096, 6093.177421048102, 6122.938770612237, 6217.502599792006, 6243.968780156161, 6245.0, 6253.093301471261, 6255.12428260044, 5653.519450846642, 6082.118092876508, 6164.445199932027, 6185.474234690102, 6193.287771906288, 5040.647154699209, 5995.640261584319, 6043.395660434009, 6193.411625895533, 6241.96879015602, 4790.473047964721, 4838.612910967114, 4843.685160464629, 4846.61227101831, 4853.223484242504, 4421.403110580095, 4441.422615060022, 4447.421835161408, 4450.06548624786, 4452.710573812692, 5518.2826232590305, 5547.750351234205, 5551.444855514497, 5552.444755524415, 5557.083081291542, 6132.845047373359, 6163.722632481549, 6223.066540019034, 6236.937630623635, 6255.749770009149, 5602.523785478198, 5602.915956260659, 5606.915896261559, 5619.550435965113, 5620.213170156181, 5256.211568264791, 5353.330833645794, 5357.11607584752, 5360.276362690986, 5369.114096174166, 6229.314775374705, 6294.685265736786, 6322.083297921868, 6335.36646335372, 6339.524535659936, 6255.186825712628, 6260.0, 6260.217472815898, 6295.118683384421, 6298.590591611531, 6150.892839288971, 6226.066090086342, 6298.527610429144, 6319.936800631935, 6321.747130114744, 4928.408590969107, 6150.231221097363, 6157.8607957528, 6166.1983942087245, 6171.413715697002, 6198.163247961467, 6232.127502149793, 6243.37566243372, 6253.499720022478, 6253.687315634291, 5877.353491115889, 5978.312494063064, 6000.639961602318, 6065.696715164312, 6077.544184186116, 5790.855228619318, 5915.615484993462, 6085.695715214133, 6097.4036925702085, 6115.270764408704, 5747.712614369181, 5905.675187864708, 5928.881422371443, 5940.821775346746, 5964.254468191476, 5902.439268269508, 6097.054956481752, 6106.236720409949, 6108.602940808833, 6118.821051373654, 5899.026660600953, 5901.763929442946, 5909.23179986599, 5919.467247947706, 5926.733297001559], "value": 5625.199463586197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.1162837122951, 486.4405933176847, 507.9009593129339, 544.7004147718757, 585.7217821534774, 30089.398212035747, 30925.536116958236, 37953.67162149322, 38938.0, 39180.0, 42481.15037699244, 43220.78389608047, 43373.7831310843, 43411.78294108533, 43430.565694343124, 9426.811463770737, 9643.807123857554, 9681.177099946477, 9681.322307438482, 9685.32202745808, 8346.749597512084, 8544.914550854473, 8546.957265213696, 8562.400631955765, 8579.95710021449, 11281.37952412617, 11589.710257243552, 11596.072314214885, 11606.709832254177, 11623.360715160663, 11283.774324513504, 11467.254628449124, 11467.598634047768, 11469.534050179169, 11472.082233421306, 8255.917440825635, 11015.83476247857, 11202.0, 11340.659780206606, 11375.431228438545, 29770.70229297701, 37798.0, 37878.8106059468, 37923.241535169145, 37949.24101517954, 3228.903132905993, 3255.8507430221066, 3261.7390608751243, 3339.34882697874, 3482.1120614243205, 26030.088946886768, 27382.45235095287, 27507.58738618922, 27534.44931101367, 27635.585466218025, 2571.704254010794, 2731.235254128847, 2761.8078013335003, 2779.1523585306472, 2861.642294713161, 334756.99999999756, 384310.0, 384535.0, 387973.9999999972, 389038.0, 62473.75052498925, 62796.68601656963, 62858.371416286165, 62976.0, 63015.6849215751, 65427.69144617081, 65508.0, 65519.344806552275, 65543.34456655373, 65575.0, 16270.105144217181, 16797.83202167987, 16814.243359048873, 16819.915900420663, 16822.495325140266, 12927.676808079874, 12987.610371688865, 12995.0, 13004.219746815032, 13012.47950082005, 14138.727514523742, 17170.055646939538, 17399.391021314193, 17564.121793910253, 17853.7321940171, 6183.319834818167, 6332.145160403379, 6389.827458664076, 6392.712327945161, 6427.0, 982.6118683120128, 995.7809281957958, 1013.9340942838692, 1151.6026970695098, 1197.3534291482501, 29390.412191756473, 29730.73582330314, 29752.702472974994, 29804.403911922072, 30654.846725766674, 1087.0596933652334, 1095.7917995580815, 1128.6162704680448, 1188.762247550476, 1215.7082300248053, 14822.851771482363, 15014.174220417983, 15410.460633877985, 15434.228288585526, 15527.611809704622, 410298.0, 482773.0, 484324.0, 487673.0, 490039.0, 58863.41136588665, 59024.40975590275, 59031.40968590345, 59063.0, 59409.51476213043, 1342.3489607540334, 1354.288998275913, 1426.4436869621063, 1483.6513419346445, 1486.680363721805, 22447.551048979254, 28441.573376398956, 28894.0, 29129.854350728958, 29498.262543436587, 49307.0, 53226.0, 55268.72365638146, 55343.0, 55513.0, 329244.0, 331190.0, 334566.0, 336160.0, 340352.0, 32362.029139125865, 39244.0, 39590.60409395869, 40738.79630601828, 41403.0, 44227.557724423634, 44776.328355075355, 45339.77330113328, 45480.8629784258, 45519.0, 29274.560881586367, 35604.0, 37143.62856371402, 38182.23635527218, 38293.85118446451, 35087.82456087703, 35599.28801423905, 35752.0, 36410.63589364073, 36432.0, 34754.478682820285, 35238.823805880806, 37726.056848579006, 38069.04827379338, 38098.0, 29753.10740677783, 30640.0, 31551.21121971969, 31753.682463175996, 31882.52176217312, 23347.416314592272, 23460.413489662213, 23712.407189819703, 23950.28149155528, 23956.640650390607], "value": 19311.975317139335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8937252882928, 389.6648881961513, 390.36955317162773, 400.4433836966615, 409.7009183296196, 16212.432564860232, 18784.718229226557, 19135.33026344075, 20054.1978320867, 20194.39416817496, 18861.05694715262, 19276.903615481937, 19693.50766230845, 20787.896060519714, 20965.790342096614, 5087.287779710843, 5573.191887176357, 5863.648181109126, 6125.632462052291, 6133.877322453548, 6043.033114701649, 6095.329513753483, 6111.449969502743, 6112.083187521863, 6116.663583502906, 5738.42615738427, 6031.215941927543, 6044.939550604482, 6045.183900173464, 6070.908936365958, 5647.3505546862225, 5986.161937328756, 6019.578629495959, 6024.09638554216, 6025.608335458225, 5155.149400348938, 5155.690658560498, 5180.171172612401, 5184.922226166611, 5238.109521381374, 20334.491637709027, 21137.471563211042, 21377.358679239493, 24823.25530234096, 24887.875560622262, 2066.8553201275918, 2175.967360489594, 2199.373178644095, 2228.5988522066023, 2350.142198097682, 14594.927025364912, 14973.775393369, 15186.696266074616, 15357.0, 15382.461613843574, 1676.8155502894795, 1704.2671651189983, 1766.6025144342548, 1794.2284817528457, 1816.3642725046127, 109719.35420968692, 112836.0, 114088.0, 114211.0, 114464.28303575453, 10510.527026283835, 10931.836022459669, 11178.720531986766, 11180.608678696206, 11341.773164536828, 14065.367058482392, 14146.929265353607, 14160.929195354163, 14179.78730319046, 14201.147931124166, 8620.655173792979, 8811.603477843513, 8815.515146666994, 8921.241694455914, 8952.14954579314, 8775.122487751301, 8775.210231079234, 8793.38446308765, 8930.821383572422, 8943.195112439911, 6557.475401967831, 6703.698333575001, 6704.96647516769, 6760.898586521206, 6761.966190169018, 1856.610111876494, 1873.2319748902885, 1880.0881572437356, 1890.0, 1918.0697361779526, 968.2544440780559, 1009.2279406254221, 1036.2694300518117, 1047.6804574604819, 1061.474570087796, 19231.553960916033, 19730.90134549318, 20096.39710808678, 20371.490712732004, 20537.897310513352, 979.6816034788723, 983.8032393521181, 997.3118548201718, 998.32612986234, 1026.8921763214905, 10991.560337586567, 11378.601748938747, 11443.828342574869, 11507.252028618113, 11543.538258469567, 601148.0, 601660.0, 619528.0, 626067.0, 626991.0, 56192.87614247692, 77110.6144469274, 103615.0, 104193.47903260436, 106687.0, 992.1269283030887, 1013.0, 1030.860833787444, 1052.4948024947914, 1057.7884423115254, 15796.76304855405, 17912.910435448262, 18402.539936501693, 18798.624027519647, 18863.784175590303, 38603.61396386113, 39242.2151556973, 39751.60248397479, 41139.97150071272, 43128.13743725171, 59521.702391487765, 60066.0, 60886.695566521885, 61241.775164497354, 62699.37300626935, 7810.101838288442, 7849.960750196213, 7896.881546776688, 7909.446338756462, 7921.881171782313, 10172.593096276067, 12030.338331391857, 12482.001439884969, 12497.93751031239, 12534.749305014031, 10504.947475262576, 10594.364338139736, 10648.89351106479, 10675.081372524784, 10865.239433239914, 10386.636467723594, 10448.0, 10595.629152979609, 10698.144148467949, 10787.946060269649, 7844.725434609762, 10449.0, 11072.778544429228, 11123.943225393574, 11158.497867595815, 7223.8555228896175, 7922.524648521107, 7974.441789074709, 7987.121416644049, 8170.264676178935, 10314.535845886803, 10786.514606842555, 11058.396532502902, 11067.225294229327, 11094.778104438028], "value": 9426.011927764253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.7127803161338, 1416.5396246219982, 1607.3168903216133, 1801.5676237702955, 1986.2452268138106, 7891.802704932373, 8136.918630813698, 8937.776555586113, 8952.373333866632, 8970.955145224281, 8539.103394143604, 8769.123087691243, 8775.166359195866, 8788.340874434427, 8801.031886492481, 2453.852768833867, 2487.2911220302217, 2490.439651078511, 2491.638712386703, 2496.4757400945823, 2234.7876951689564, 2430.2709187243845, 2489.4025433895827, 2490.178241180406, 2496.1388321029217, 2198.670199470076, 2442.218490083174, 2457.0785955266774, 2477.876106194692, 2481.2184161988916, 2417.226487523993, 2443.450223699671, 2448.51029794041, 2449.020391843268, 2459.0655550890724, 2411.9035238590436, 2432.6715893354526, 2442.6091825307867, 2442.6091825307867, 2444.2401470940895, 8510.446820956618, 8785.73642790711, 8862.11378862115, 8865.113488651083, 8872.467651940904, 4659.906801863977, 5214.687118772886, 5226.425093239741, 5486.31421072366, 5511.917321240185, 3513.8067406292644, 3542.0613537412605, 3670.467782171597, 3674.026383008505, 3679.3193259247123, 1032.7521394865178, 1064.1486810551528, 1067.2849191041944, 1068.7221322456217, 1070.6734445994045, 11242.831357529643, 11682.766344673144, 11700.356480393575, 11704.53181872724, 11720.238184517979, 4834.734089625034, 4900.558949694473, 4916.262560615936, 5011.574016208663, 5038.168702164102, 10220.846687299696, 10245.7438564035, 10251.692449226535, 10260.640877569249, 10273.126784223276, 5562.527185189304, 5562.944370556243, 5564.582656300794, 5566.916496252559, 5567.0, 4356.4336636237085, 4472.910541789146, 4552.306750847025, 4981.12830254704, 5003.524665156804, 3313.353895990259, 3949.2496425679606, 4048.2510735514024, 4095.935056885172, 4105.261053010427, 1291.8256035435095, 1301.342821874947, 1341.1952828303135, 1361.7539950944774, 1375.2917247617486, 890.5324704530044, 918.6876462002817, 925.9398139121071, 938.8591711243369, 958.0228167269346, 5194.75325921776, 5325.0, 5698.2592263005545, 5876.294844618587, 5910.054391297458, 397.37215199983956, 469.957703806659, 473.3444179810987, 487.16451286043895, 487.9194932836113, 3735.9252814943547, 3882.8835134946, 3960.9009774755286, 3965.7025723070883, 3967.3652215645357, 10299.12457441111, 10834.891651083388, 10893.346399216072, 10986.066184374258, 10992.340459572291, 10315.432651204255, 10924.96212859777, 10941.070009049161, 10947.945260273807, 10962.616308429326, 8189.385796065319, 8224.259816616413, 8277.54473503951, 8367.372447066495, 8368.748937531762, 4746.691465054761, 5688.857778555569, 5833.4749872511675, 5980.581359304807, 6144.600600960924, 9721.173700235277, 9750.268729845431, 9854.0, 9905.900940990787, 10094.646687365906, 9823.950880245553, 9894.752631184278, 9970.252231082553, 10099.242556808416, 10114.29199955996, 6926.722931082902, 7234.891476627749, 7385.113786345673, 7618.085829700472, 7624.199459056941, 7526.795712685944, 7982.441229113906, 8287.792805179919, 8316.83366332682, 8391.16088391156, 7147.356737893615, 7438.851222975619, 7499.737509187153, 7500.512466689648, 7570.205128461653, 7191.101112360955, 7303.780886573411, 7307.378872795872, 7466.701331946661, 7476.25237476248, 6946.8610627788175, 7000.719971201095, 7028.262032486516, 7028.824279393056, 7035.788926332219, 4531.342955271533, 4695.929561056519, 4733.1716949533, 4802.135615589227, 4881.780319885543, 4603.733973157408, 4901.2893130496595, 4938.555530002173, 4964.553190212898, 5104.795808167632], "value": 4524.925007418902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.3728055730211, 319.7234392250703, 325.0784027282652, 327.31264344875757, 330.1037682691492, 4814.63890208234, 4934.407871055474, 5280.973595132024, 5366.302380690505, 5380.973095134519, 5305.363356397228, 5314.521693047625, 5352.464753524655, 5363.8122665706705, 5384.811531596395, 3168.892686363571, 3945.5857135000842, 3996.900077498057, 4101.159262351211, 4101.200265948141, 3574.6782789548934, 3608.5850127235312, 4034.1326614777818, 4056.8580099696514, 4098.663761655857, 3413.4197186478236, 3447.7586568940183, 3998.6401223889843, 4018.9598104019024, 4086.9973712880624, 3716.758410703296, 3823.5985221551614, 3892.6107389260987, 3917.8041097945134, 4098.385242213662, 3540.398132317512, 3553.573571171476, 3563.750537462379, 3564.893053208382, 3576.4635304704243, 4836.903261934777, 5119.2321151827155, 5126.846194614168, 5133.666311689728, 5134.306868572732, 3938.8227529760943, 4507.774611269423, 4676.392069031038, 4711.623070154414, 4740.762961851894, 4903.607711383081, 5564.554835613141, 5565.5825813063775, 5573.41479144688, 5632.7746890124345, 3197.0, 3339.5658564386717, 3682.742208045438, 3971.153413662632, 4040.8585699500672, 5481.698506582136, 5808.3901190375245, 5828.388019258002, 5854.297484301911, 5858.853528661775, 3329.6170940341685, 3582.194006348551, 3661.0664280608808, 3778.678812300985, 4027.838886444568, 3522.330757156132, 3816.293985612615, 4105.609967053125, 4107.732997355162, 4108.979455102705, 3619.8552057917914, 4036.313826649418, 4471.642268618502, 4621.936954500484, 4710.905781884411, 4948.455669876311, 5251.687078230442, 5339.626226164131, 5644.5484361251, 5693.146028095819, 1250.9117068150767, 1431.5705288413642, 1462.429652435551, 1463.6999415119874, 1467.7137958098283, 822.5558198572704, 914.4147745442922, 934.5233930695258, 970.9514524273758, 971.8639390485338, 4185.686073544435, 4685.976570117127, 5023.974880125576, 5239.659422137549, 5574.275344205227, 5779.219805326311, 5787.8553036174435, 5797.2173756542325, 5806.274215723035, 5830.5044071254415, 4959.305697202394, 5234.67057159568, 5255.5532779713385, 5266.710330931759, 5292.2800089970915, 2905.157504323765, 3287.2110693433406, 3330.1341651170387, 3344.9498257526157, 3361.1261072121424, 6056.515478761688, 6614.371634694697, 6642.96678516614, 6662.800115996431, 6688.331166883273, 4949.267756285271, 5058.367704036996, 5285.947140528622, 5638.971805140948, 5985.545926170336, 5139.820106296262, 5793.971030144822, 5804.862696513532, 6023.397660234029, 6079.696015199311, 5269.341332333458, 5506.504414602705, 5824.767009319749, 5837.328707198557, 5845.590808643354, 5815.273090863642, 5822.417758224144, 5824.271966004249, 5860.443257890493, 5864.794732184353, 5390.407055223844, 5712.34308054579, 5822.796202132905, 6143.477804386677, 6170.722317495633, 3175.8412079395475, 3370.5786776652917, 3382.627910929845, 3403.625601183818, 3986.700997425147, 4560.67405623128, 4670.556297151765, 5853.443922827325, 5896.557758168069, 5920.822375328747, 5480.232767412645, 5720.399358067343, 5734.455226753452, 5747.15515819672, 5750.482456578928, 4323.78381080951, 5587.497125258747, 5680.829575112753, 5706.146926536731, 5742.856428589152, 4425.756583387944, 4944.975275123601, 4951.430585482715, 5354.892902141857, 5646.830595082154, 5522.641028333145, 5619.775208991595, 5688.232088668143, 5693.0, 5693.345265294544, 4915.434725006527, 5544.473275038865, 5577.52591029767, 5587.608867379245, 5643.858903527444], "value": 4119.48037309934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.7726879688913, 653.8071268975651, 680.2755065854861, 720.9963950180248, 739.1167554772046, 14376.71246575068, 14597.635059123528, 14893.77659335111, 14928.25358732063, 14934.551963441101, 14011.369488373022, 14103.0, 14105.294735263247, 14109.012369134165, 14121.505747298846, 724.6920058974941, 746.1531162130993, 889.0087552379115, 892.2415946445518, 905.4567259644226, 889.5552223888056, 918.3663272342096, 921.9907800922006, 924.5053896165552, 925.1026504290827, 945.7966537194502, 984.1585444445004, 986.0238364019641, 986.0927946289431, 987.2940847294183, 763.4159867701213, 816.7100679258837, 820.216693058128, 946.5172761891416, 985.4727720669479, 681.6591704147926, 697.0485287582464, 709.1986055756962, 710.4955481608065, 712.8289210589473, 14791.260436978107, 14885.92557037208, 14890.702185956328, 14895.32971016296, 14902.850971490363, 12032.939835300767, 12300.384980751016, 12348.38258087101, 12359.25844449336, 12461.483410532204, 10843.566257349696, 11015.228933974626, 11088.0, 11138.164637652208, 11483.20098350336, 4084.7957602119777, 4200.411942328046, 4228.894277643053, 4258.488981322261, 4294.656427485794, 77127.45745085123, 77740.22259777387, 77879.0, 78317.0, 78549.60725196394, 9585.089416505421, 9611.903880961101, 9643.566039528238, 9690.660826871026, 9772.16936560386, 21528.354149375544, 21774.782252177592, 21827.236046738606, 21837.563248734936, 22562.984665690085, 7695.345895598824, 7728.536287822636, 7891.684332626745, 7978.5611791350875, 8036.758897233092, 4054.1688953764406, 4160.108724436548, 4169.499660040754, 4174.4364510791265, 4466.1067786442845, 3602.5136606558303, 3698.6671199592165, 3701.6668499835146, 3705.81470926458, 3707.1658876753054, 659.5317324699421, 659.9010148477671, 665.643880523927, 666.5733930284622, 671.9092922455503, 536.3429798496888, 540.3245942571785, 557.5278640146945, 577.1631134854478, 620.2835724737935, 7843.882341764878, 8047.195280472023, 8265.0, 8419.158084191531, 8472.279856212292, 512.0118171928215, 528.918017707256, 587.090010483757, 609.1441524657863, 613.414189449075, 3299.173717773724, 3661.487391765155, 3714.23858109087, 3789.4315852622326, 4021.5174179098694, 91437.0, 91535.0, 91973.5401322989, 92389.0, 94747.0525294752, 69199.0, 75160.62419687866, 77255.0, 77931.0, 80788.0, 68116.6594167036, 69232.65383673151, 69417.65291173512, 69626.9555956661, 71841.28158718346, 7628.504147230412, 7744.114473000673, 7752.612369381395, 7779.883301750365, 7876.133625301327, 43999.560004399544, 44428.55571444244, 44523.0, 44888.0, 44953.32570011387, 59481.70259148676, 59599.70200148971, 64743.35256647373, 64789.676051621325, 64797.0, 10520.631777887736, 10542.525586348786, 10701.94649026781, 10739.677809665722, 11010.39442830652, 11173.944130279297, 11257.155713321697, 11265.324080555192, 11594.536218551164, 12264.93376655836, 10450.320729152581, 10472.476376181314, 10477.16182705397, 10851.837222441827, 10884.238103332691, 10460.79078418412, 10559.63041293551, 10789.946050269698, 10834.891651083704, 10855.40295283767, 10376.896231037594, 10422.133913173939, 10783.137349011904, 10914.072303854262, 11410.030147437228, 8758.386912916034, 8759.824803504021, 9102.59038343263, 9113.225375843127, 9193.77015574616, 8800.38397312182, 8840.29277657773, 8978.416402933788, 9086.636534538544, 9144.085591440802], "value": 6801.343644619344, "unit": "score"}], "name": "dromaeo_css", "value": 7115.919001352982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 106.0, 113.0, 113.0, 111.0, 113.0, 112.0, 104.0, 115.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 144.0, 168.0, 119.0, 139.0, 152.0, 153.0, 181.0, 118.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 186.0, 183.0, 183.0, 182.0, 181.0, 185.0, 182.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 89.0, 93.0, 58.0, 57.0, 58.0, 84.0, 86.0, 56.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 136.0, 78.0, 79.0, 81.0, 126.0, 79.0, 77.0, 126.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 88.0, 90.0, 87.0, 91.0, 87.0, 90.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 95.0, 88.0, 148.0, 136.0, 94.0, 93.0, 94.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 83.0, 85.0, 87.0, 84.0, 82.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 58.0, 56.0, 58.0, 58.0, 58.0, 76.0, 61.0, 57.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 78.0, 74.0, 71.0, 70.0, 98.0, 100.0, 95.0, 68.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 78.0, 80.0, 82.0, 82.0, 82.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 143.0, 138.0, 136.0, 136.0, 137.0, 139.0, 153.0, 198.0, 143.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 199.0, 199.0, 198.0, 202.0, 197.0, 200.0, 202.0, 198.0, 198.0], "value": 199.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 70.0, 69.0, 71.0, 69.0, 69.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1523.1000000000001, "alertThreshold": 2.0}]} 16:45:58 INFO - Return code: 0 16:45:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:45:58 ERROR - # TBPL SUCCESS # 16:45:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:45:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:45:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:45:58 INFO - 2016-04-26 16:45:58.864 screenresolution[1670:9937] starting screenresolution argv=screenresolution get 16:45:58 INFO - 2016-04-26 16:45:58.867 screenresolution[1670:9937] Display 0: 1600x1200x32@60 16:45:58 INFO - 2016-04-26 16:45:58.873 screenresolution[1671:9940] starting screenresolution argv=screenresolution list 16:45:58 INFO - Available Modes on Display 0 16:45:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:45:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:45:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:45:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:45:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:45:59 INFO - Intel Iris: 16:45:59 INFO - Chipset Model: Intel Iris 16:45:59 INFO - Type: GPU 16:45:59 INFO - Bus: Built-In 16:45:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:45:59 INFO - Vendor: Intel (0x8086) 16:45:59 INFO - Device ID: 0x0a2e 16:45:59 INFO - Revision ID: 0x0009 16:45:59 INFO - Displays: 16:45:59 INFO - Display: 16:45:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:45:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:45:59 INFO - Display Serial Number: 1600x1200 60 16:45:59 INFO - Main Display: Yes 16:45:59 INFO - Mirror: Off 16:45:59 INFO - Online: Yes 16:45:59 INFO - Rotation: Supported 16:45:59 INFO - Return code: 0 16:45:59 INFO - Running post-action listener: _resource_record_post_action 16:45:59 INFO - Running post-run listener: _resource_record_post_run 16:46:00 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37873152; Write bytes: 695747584; Read time: 393; Write time: 2118 16:46:00 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 393286144; Write bytes: 387471360; Read time: 29733; Write time: 711 16:46:00 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36046336; Write bytes: 296844288; Read time: 372; Write time: 1378 16:46:00 INFO - Running post-run listener: _upload_blobber_files 16:46:00 INFO - Blob upload gear active. 16:46:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:46:00 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 16:46:00 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'] 16:46:00 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 16:46:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:46:02 INFO - (blobuploader) - INFO - Done attempting. 16:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:46:03 INFO - (blobuploader) - INFO - Done attempting. 16:46:03 INFO - (blobuploader) - INFO - Iteration through files over. 16:46:03 INFO - Return code: 0 16:46:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:46:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:46:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e0b3133e6da8ed502caab6c58bba762cd51104f990a312a328d49dc597426a5bc3c247d57467d45b7a26ce7e34da5a5fcb6c7df772020c9152f51bdf38aed5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01810899f29e98f0f370fa9d21808be23e596c77c6482a27cdd2072479f73930a24cf50d4aac4c74a3657b0a8402227de85b53d32e936af8d9651abd9a43f82e"} 16:46:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:46:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:46:03 INFO - Contents: 16:46:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e0b3133e6da8ed502caab6c58bba762cd51104f990a312a328d49dc597426a5bc3c247d57467d45b7a26ce7e34da5a5fcb6c7df772020c9152f51bdf38aed5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01810899f29e98f0f370fa9d21808be23e596c77c6482a27cdd2072479f73930a24cf50d4aac4c74a3657b0a8402227de85b53d32e936af8d9651abd9a43f82e"} 16:46:03 INFO - Running post-run listener: copy_logs_to_upload_dir 16:46:03 INFO - Copying logs to upload dir... 16:46:03 INFO - mkdir: /builds/slave/test/build/upload/logs 16:46:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.104304 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-26 16:46:03.903928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:46:03.908254) ========= 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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e0b3133e6da8ed502caab6c58bba762cd51104f990a312a328d49dc597426a5bc3c247d57467d45b7a26ce7e34da5a5fcb6c7df772020c9152f51bdf38aed5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01810899f29e98f0f370fa9d21808be23e596c77c6482a27cdd2072479f73930a24cf50d4aac4c74a3657b0a8402227de85b53d32e936af8d9651abd9a43f82e"} 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.011164 build_url: 'https://queue.taskcluster.net/v1/task/GmfWImDgTAapKm1AsW6ZPg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e0b3133e6da8ed502caab6c58bba762cd51104f990a312a328d49dc597426a5bc3c247d57467d45b7a26ce7e34da5a5fcb6c7df772020c9152f51bdf38aed5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01810899f29e98f0f370fa9d21808be23e596c77c6482a27cdd2072479f73930a24cf50d4aac4c74a3657b0a8402227de85b53d32e936af8d9651abd9a43f82e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:46:03.944551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:46:03.944960) ========= 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.bTCJlmNy0l/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.Eg10TimxHW/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:46:03.993560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:46:03.994408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:46:03.994838) ========= ========= Total master_lag: 1.01 =========