builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1459460704.84 results: success (0) buildid: 20160331124731 builduid: 5bc3feb01c4c4363924a5d7c0024abd6 revision: 09f42355aa061bada9ab92056215d9cdae86a220 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.841445) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.841891) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.842177) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005787 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.865585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.867068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.883791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.884081) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.932451) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.932739) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.933092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:04.933360) ========= 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.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-03-31 14:45:05-- 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% 145M=0s 2016-03-31 14:45:05 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100615 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:05.124251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:05.124575) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.021535 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:05.176174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:05.176521) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 09f42355aa061bada9ab92056215d9cdae86a220 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 09f42355aa061bada9ab92056215d9cdae86a220 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-03-31 14:45:05,253 truncating revision to first 12 chars 2016-03-31 14:45:05,253 Setting DEBUG logging. 2016-03-31 14:45:05,253 attempt 1/10 2016-03-31 14:45:05,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/09f42355aa06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-31 14:45:05,873 unpacking tar archive at: mozilla-central-09f42355aa06/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:06.067208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:06.067554) ========= echo 09f42355aa061bada9ab92056215d9cdae86a220 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'09f42355aa061bada9ab92056215d9cdae86a220'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09f42355aa061bada9ab92056215d9cdae86a220 program finished with exit code 0 elapsedTime=0.005164 script_repo_revision: '09f42355aa061bada9ab92056215d9cdae86a220' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:06.117894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:06.118214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 14:45:06.132286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-31 14:45:06.132696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:06 INFO - MultiFileLogger online at 20160331 14:45:06 in /builds/slave/test 14:45:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:45:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:45:06 INFO - {'append_to_log': False, 14:45:06 INFO - 'base_work_dir': '/builds/slave/test', 14:45:06 INFO - 'blob_upload_branch': 'Firefox', 14:45:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:45:06 INFO - 'branch': 'Firefox', 14:45:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:45:06 INFO - 'config_files': ('talos/mac_config.py',), 14:45:06 INFO - 'default_actions': ('clobber', 14:45:06 INFO - 'read-buildbot-config', 14:45:06 INFO - 'download-and-extract', 14:45:06 INFO - 'populate-webroot', 14:45:06 INFO - 'create-virtualenv', 14:45:06 INFO - 'install', 14:45:06 INFO - 'run-tests'), 14:45:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:45:06 INFO - 'download_minidump_stackwalk': True, 14:45:06 INFO - 'download_symbols': 'ondemand', 14:45:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:45:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:45:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:45:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:45:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:45:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:45:06 INFO - 'installer_path': 'installer.exe', 14:45:06 INFO - 'log_level': 'info', 14:45:06 INFO - 'log_name': 'talos', 14:45:06 INFO - 'log_to_console': True, 14:45:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:45:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:45:06 INFO - 'opt_config_files': (), 14:45:06 INFO - 'pip_index': False, 14:45:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:45:06 INFO - 'cmd': ('bash', 14:45:06 INFO - '-c', 14:45:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:45:06 INFO - 'enabled': True, 14:45:06 INFO - 'halt_on_failure': False, 14:45:06 INFO - 'name': 'check_screen_resolution'},), 14:45:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:45:06 INFO - 'cmd': ('bash', 14:45:06 INFO - '-c', 14:45:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:45:06 INFO - 'enabled': True, 14:45:06 INFO - 'halt_on_failure': False, 14:45:06 INFO - 'name': 'check_screen_resolution'},), 14:45:06 INFO - 'run_cmd_checks_enabled': True, 14:45:06 INFO - 'sps_profile': False, 14:45:06 INFO - 'sps_profile_interval': 0, 14:45:06 INFO - 'suite': 'dromaeojs', 14:45:06 INFO - 'system_bits': '32', 14:45:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:45:06 INFO - 'title': 't-yosemite-r7-0137', 14:45:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:45:06 INFO - 'use_talos_json': True, 14:45:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:45:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:45:06 INFO - 'work_dir': 'build'} 14:45:06 INFO - ##### 14:45:06 INFO - ##### Running clobber step. 14:45:06 INFO - ##### 14:45:06 INFO - Running pre-action listener: _resource_record_pre_action 14:45:06 INFO - Running main action method: clobber 14:45:06 INFO - rmtree: /builds/slave/test/build 14:45:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:45:07 INFO - Running post-action listener: _resource_record_post_action 14:45:07 INFO - ##### 14:45:07 INFO - ##### Running read-buildbot-config step. 14:45:07 INFO - ##### 14:45:07 INFO - Running pre-action listener: _resource_record_pre_action 14:45:07 INFO - Running main action method: read_buildbot_config 14:45:07 INFO - Using buildbot properties: 14:45:07 INFO - { 14:45:07 INFO - "project": "", 14:45:07 INFO - "product": "firefox", 14:45:07 INFO - "script_repo_revision": "production", 14:45:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:45:07 INFO - "repository": "", 14:45:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:45:07 INFO - "buildid": "20160331124731", 14:45:07 INFO - "pgo_build": "False", 14:45:07 INFO - "basedir": "/builds/slave/test", 14:45:07 INFO - "buildnumber": 193, 14:45:07 INFO - "slavename": "t-yosemite-r7-0137", 14:45:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:45:07 INFO - "platform": "yosemite_r7", 14:45:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:45:07 INFO - "branch": "mozilla-central", 14:45:07 INFO - "repo_path": "mozilla-central", 14:45:07 INFO - "revision": "09f42355aa061bada9ab92056215d9cdae86a220", 14:45:07 INFO - "stage_platform": "macosx64", 14:45:07 INFO - "builduid": "5bc3feb01c4c4363924a5d7c0024abd6", 14:45:07 INFO - "slavebuilddir": "test" 14:45:07 INFO - } 14:45:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:45:07 INFO - Running post-action listener: _resource_record_post_action 14:45:07 INFO - ##### 14:45:07 INFO - ##### Running download-and-extract step. 14:45:07 INFO - ##### 14:45:07 INFO - Running pre-action listener: _resource_record_pre_action 14:45:07 INFO - Running main action method: download_and_extract 14:45:07 INFO - mkdir: /builds/slave/test/build/tests 14:45:07 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')]} 14:45:07 INFO - https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 14:45:09 INFO - Downloaded 1199 bytes. 14:45:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:45:09 INFO - Using the following test package requirements: 14:45:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:45:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:45:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:45:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'jsshell-mac.zip'], 14:45:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:45:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:45:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:45:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:45:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:45:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:45:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:45:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:45: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')]} 14:45:09 INFO - https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:45:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:45:10 INFO - Downloaded 17946657 bytes. 14:45:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:45:13 INFO - Return code: 0 14:45:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:13 INFO - https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:45:22 INFO - Downloaded 17946657 bytes. 14:45:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:45:25 INFO - Return code: 0 14:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:25 INFO - https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:45:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:45:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:45:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:45:27 INFO - Downloaded 10847531 bytes. 14:45:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:45:27 INFO - Return code: 0 14:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:27 INFO - https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 14:45:32 INFO - Downloaded 111442643 bytes. 14:45:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:45:32 INFO - mkdir: /builds/slave/test/properties 14:45:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:45:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:45:32 INFO - Contents: 14:45:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:45:35 INFO - Running post-action listener: _resource_record_post_action 14:45:35 INFO - Running post-action listener: set_extra_try_arguments 14:45:35 INFO - ##### 14:45:35 INFO - ##### Running populate-webroot step. 14:45:35 INFO - ##### 14:45:35 INFO - Running pre-action listener: _resource_record_pre_action 14:45:35 INFO - Running main action method: populate_webroot 14:45:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:45:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:45:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:45:35 INFO - '--tppagecycles', 14:45:35 INFO - '7'], 14:45:35 INFO - 'tests': ['tsvgm']}}, 14:45:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:45:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:45:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:45:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:45:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'tests': ['damp', 'tps']}, 14:45:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['damp', 'tps']}, 14:45:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:45:35 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['dromaeo_dom']}, 14:45:35 INFO - 'other': {'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'other_l64': {'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'other_nol64': {'tests': ['a11yr', 14:45:35 INFO - 'ts_paint', 14:45:35 INFO - 'tpaint', 14:45:35 INFO - 'sessionrestore', 14:45:35 INFO - 'sessionrestore_no_auto_restore', 14:45:35 INFO - 'tabpaint']}, 14:45:35 INFO - 'svgr': {'tests': ['tsvgx', 14:45:35 INFO - 'tsvgr_opacity', 14:45:35 INFO - 'tart', 14:45:35 INFO - 'tscrollx', 14:45:35 INFO - 'cart']}, 14:45:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['tsvgx', 14:45:35 INFO - 'tsvgr_opacity', 14:45:35 INFO - 'tart', 14:45:35 INFO - 'tscrollx', 14:45:35 INFO - 'cart']}, 14:45:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'tests': ['tp5o']}, 14:45:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'talos_options': ['--e10s'], 14:45:35 INFO - 'tests': ['tp5o']}, 14:45:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'talos_options': ['--xperf_path', 14:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:35 INFO - 'tests': ['tp5n']}, 14:45:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:35 INFO - 'talos_options': ['--e10s', 14:45:35 INFO - '--xperf_path', 14:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:35 INFO - 'tests': ['tp5n']}}, 14:45:35 INFO - 'talos.zip': {'path': '', 14:45:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:45:35 INFO - Running post-action listener: _resource_record_post_action 14:45:35 INFO - ##### 14:45:35 INFO - ##### Running create-virtualenv step. 14:45:35 INFO - ##### 14:45:35 INFO - Running pre-action listener: _resource_record_pre_action 14:45:35 INFO - Running main action method: create_virtualenv 14:45:35 INFO - Creating virtualenv /builds/slave/test/build/venv 14:45:35 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 14:45:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:45:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:45:35 INFO - Using real prefix '/tools/python27' 14:45:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:45:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:45:38 INFO - Installing pip.................done. 14:45:38 INFO - Return code: 0 14:45:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:38 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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:38 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 14:45:38 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 14:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:38 INFO - 'HOME': '/Users/cltbld', 14:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:38 INFO - 'LOGNAME': 'cltbld', 14:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:38 INFO - 'MOZ_NO_REMOTE': '1', 14:45:38 INFO - 'NO_EM_RESTART': '1', 14:45:38 INFO - 'PAGER': '/bin/cat', 14:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:38 INFO - 'PWD': '/builds/slave/test', 14:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:38 INFO - 'SHELL': '/bin/bash', 14:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:38 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:38 INFO - 'USER': 'cltbld', 14:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:38 INFO - 'XPC_FLAGS': '0x0', 14:45:38 INFO - 'XPC_SERVICE_NAME': '0', 14:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:38 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 14:45:38 INFO - Cleaning up... 14:45:39 INFO - Return code: 0 14:45:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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', '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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:45: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 psutil>=0.7.1 14:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:39 INFO - 'HOME': '/Users/cltbld', 14:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:39 INFO - 'LOGNAME': 'cltbld', 14:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:39 INFO - 'MOZ_NO_REMOTE': '1', 14:45:39 INFO - 'NO_EM_RESTART': '1', 14:45:39 INFO - 'PAGER': '/bin/cat', 14:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:39 INFO - 'PWD': '/builds/slave/test', 14:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:39 INFO - 'SHELL': '/bin/bash', 14:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:39 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:39 INFO - 'USER': 'cltbld', 14:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:39 INFO - 'XPC_FLAGS': '0x0', 14:45:39 INFO - 'XPC_SERVICE_NAME': '0', 14:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:39 INFO - Downloading/unpacking psutil>=0.7.1 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:45:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:41 INFO - Installing collected packages: psutil 14:45:41 INFO - Running setup.py install for psutil 14:45:41 INFO - building 'psutil._psutil_osx' extension 14:45:41 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 14:45:42 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 14:45:42 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 14:45:42 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 14:45:42 INFO - building 'psutil._psutil_posix' extension 14:45:42 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 14:45:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:45:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:45:42 INFO - ^ 14:45:42 INFO - 1 warning generated. 14:45:42 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 14:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:42 INFO - Successfully installed psutil 14:45:42 INFO - Cleaning up... 14:45:42 INFO - Return code: 0 14:45:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:42 INFO - 'HOME': '/Users/cltbld', 14:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:42 INFO - 'LOGNAME': 'cltbld', 14:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:42 INFO - 'MOZ_NO_REMOTE': '1', 14:45:42 INFO - 'NO_EM_RESTART': '1', 14:45:42 INFO - 'PAGER': '/bin/cat', 14:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:42 INFO - 'PWD': '/builds/slave/test', 14:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:42 INFO - 'SHELL': '/bin/bash', 14:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:42 INFO - 'USER': 'cltbld', 14:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:42 INFO - 'XPC_FLAGS': '0x0', 14:45:42 INFO - 'XPC_SERVICE_NAME': '0', 14:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:45:45 INFO - Installing collected packages: mozsystemmonitor 14:45:45 INFO - Running setup.py install for mozsystemmonitor 14:45:45 INFO - Successfully installed mozsystemmonitor 14:45:45 INFO - Cleaning up... 14:45:45 INFO - Return code: 0 14:45:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:45 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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:45 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 14:45:45 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 14:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:45 INFO - 'HOME': '/Users/cltbld', 14:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:45 INFO - 'LOGNAME': 'cltbld', 14:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:45 INFO - 'MOZ_NO_REMOTE': '1', 14:45:45 INFO - 'NO_EM_RESTART': '1', 14:45:45 INFO - 'PAGER': '/bin/cat', 14:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:45 INFO - 'PWD': '/builds/slave/test', 14:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:45 INFO - 'SHELL': '/bin/bash', 14:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:45 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:45 INFO - 'USER': 'cltbld', 14:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:45 INFO - 'XPC_FLAGS': '0x0', 14:45:45 INFO - 'XPC_SERVICE_NAME': '0', 14:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45: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 14:45:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:45:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:48 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 14:45:49 INFO - Downloading docopt-0.6.1.tar.gz 14:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:45:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:45:49 INFO - Running setup.py install for blobuploader 14:45:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:45:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:45:49 INFO - Running setup.py install for requests 14:45:50 INFO - Running setup.py install for docopt 14:45:50 INFO - Successfully installed blobuploader requests docopt 14:45:50 INFO - Cleaning up... 14:45:50 INFO - Return code: 0 14:45:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:50 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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:50 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 14:45:50 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 14:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:50 INFO - 'HOME': '/Users/cltbld', 14:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:50 INFO - 'LOGNAME': 'cltbld', 14:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:50 INFO - 'MOZ_NO_REMOTE': '1', 14:45:50 INFO - 'NO_EM_RESTART': '1', 14:45:50 INFO - 'PAGER': '/bin/cat', 14:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:50 INFO - 'PWD': '/builds/slave/test', 14:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:50 INFO - 'SHELL': '/bin/bash', 14:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:50 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:50 INFO - 'USER': 'cltbld', 14:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:50 INFO - 'XPC_FLAGS': '0x0', 14:45:50 INFO - 'XPC_SERVICE_NAME': '0', 14:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:50 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-8zhlno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:50 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5HtzVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:50 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-cBSLY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:50 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-u7sBBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-z1Aw5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IF2Fok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-h_EXL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-nJ776Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pItJE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-naePfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-M5oPip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-wpBt1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iuhH1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-7ixoup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-x8WfTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UF3fVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-t5ziJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:45:52 INFO - Running setup.py install for manifestparser 14:45:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:45:52 INFO - Running setup.py install for mozcrash 14:45:52 INFO - Running setup.py install for mozdebug 14:45:52 INFO - Running setup.py install for mozdevice 14:45:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Running setup.py install for mozfile 14:45:53 INFO - Running setup.py install for mozhttpd 14:45:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Running setup.py install for mozinfo 14:45:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Running setup.py install for mozInstall 14:45:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Running setup.py install for mozleak 14:45:53 INFO - Running setup.py install for mozlog 14:45:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:45:53 INFO - Running setup.py install for moznetwork 14:45:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:45:54 INFO - Running setup.py install for mozprocess 14:45:54 INFO - Running setup.py install for mozprofile 14:45:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:45:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:45:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:45:54 INFO - Running setup.py install for mozrunner 14:45:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:45:54 INFO - Running setup.py install for mozscreenshot 14:45:54 INFO - Running setup.py install for moztest 14:45:54 INFO - Running setup.py install for mozversion 14:45:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:45:55 INFO - Cleaning up... 14:45:55 INFO - Return code: 0 14:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:55 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')]} 14:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:55 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')]} 14:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:55 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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:45:55 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 14:45:55 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 14:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:55 INFO - 'HOME': '/Users/cltbld', 14:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:55 INFO - 'LOGNAME': 'cltbld', 14:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:55 INFO - 'MOZ_NO_REMOTE': '1', 14:45:55 INFO - 'NO_EM_RESTART': '1', 14:45:55 INFO - 'PAGER': '/bin/cat', 14:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:55 INFO - 'PWD': '/builds/slave/test', 14:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:55 INFO - 'SHELL': '/bin/bash', 14:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:45:55 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:55 INFO - 'USER': 'cltbld', 14:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:55 INFO - 'XPC_FLAGS': '0x0', 14:45:55 INFO - 'XPC_SERVICE_NAME': '0', 14:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-zpeG6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Z7Ow3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FAbI_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-mio56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ADTWQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Wj4Cf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:55 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)) 14:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FQmh32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-i4aylC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Mqnj3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-bStzue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ebcaQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-HVshV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-2ZIWvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-f9W_7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4G4EK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:56 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)) 14:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Qn4YMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:57 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)) 14:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gPuvUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:57 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)) 14:45:57 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)) 14:45:57 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)) 14:45:57 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)) 14:45:57 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)) 14:45:57 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)) 14:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:59 INFO - Downloading blessings-1.6.tar.gz 14:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:45:59 INFO - Installing collected packages: blessings 14:45:59 INFO - Running setup.py install for blessings 14:45:59 INFO - Successfully installed blessings 14:45:59 INFO - Cleaning up... 14:45:59 INFO - Return code: 0 14:45:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:00 INFO - Reading from file tmpfile_stdout 14:46:00 INFO - Current package versions: 14:46:00 INFO - blessings == 1.6 14:46:00 INFO - blobuploader == 1.2.4 14:46:00 INFO - docopt == 0.6.1 14:46:00 INFO - manifestparser == 1.1 14:46:00 INFO - mozInstall == 1.12 14:46:00 INFO - mozcrash == 0.17 14:46:00 INFO - mozdebug == 0.1 14:46:00 INFO - mozdevice == 0.48 14:46:00 INFO - mozfile == 1.2 14:46:00 INFO - mozhttpd == 0.7 14:46:00 INFO - mozinfo == 0.9 14:46:00 INFO - mozleak == 0.1 14:46:00 INFO - mozlog == 3.1 14:46:00 INFO - moznetwork == 0.27 14:46:00 INFO - mozprocess == 0.22 14:46:00 INFO - mozprofile == 0.28 14:46:00 INFO - mozrunner == 6.11 14:46:00 INFO - mozscreenshot == 0.1 14:46:00 INFO - mozsystemmonitor == 0.0 14:46:00 INFO - moztest == 0.7 14:46:00 INFO - mozversion == 1.4 14:46:00 INFO - psutil == 3.1.1 14:46:00 INFO - requests == 1.2.3 14:46:00 INFO - wsgiref == 0.1.2 14:46:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:00 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 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:46:00 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 14:46:00 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 14:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:46:00 INFO - 'HOME': '/Users/cltbld', 14:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:46:00 INFO - 'LOGNAME': 'cltbld', 14:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:00 INFO - 'MOZ_NO_REMOTE': '1', 14:46:00 INFO - 'NO_EM_RESTART': '1', 14:46:00 INFO - 'PAGER': '/bin/cat', 14:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:00 INFO - 'PWD': '/builds/slave/test', 14:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:46:00 INFO - 'SHELL': '/bin/bash', 14:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:46:00 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:46:00 INFO - 'USER': 'cltbld', 14:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:00 INFO - 'XPC_FLAGS': '0x0', 14:46:00 INFO - 'XPC_SERVICE_NAME': '0', 14:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 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)) 14:46:00 INFO - Cleaning up... 14:46:00 INFO - Return code: 0 14:46:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:46:00 INFO - 'HOME': '/Users/cltbld', 14:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:46:00 INFO - 'LOGNAME': 'cltbld', 14:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:00 INFO - 'MOZ_NO_REMOTE': '1', 14:46:00 INFO - 'NO_EM_RESTART': '1', 14:46:00 INFO - 'PAGER': '/bin/cat', 14:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:00 INFO - 'PWD': '/builds/slave/test', 14:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:46:00 INFO - 'SHELL': '/bin/bash', 14:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:46:00 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:46:00 INFO - 'USER': 'cltbld', 14:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:00 INFO - 'XPC_FLAGS': '0x0', 14:46:00 INFO - 'XPC_SERVICE_NAME': '0', 14:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:00 INFO - Downloading/unpacking jsonschema 14:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:46:02 INFO - Downloading/unpacking functools32 (from jsonschema) 14:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:03 INFO - Downloading functools32-3.2.3-2.tar.gz 14:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:46:03 INFO - warning: no files found matching '*.txt' 14:46:03 INFO - no previously-included directories found matching 'build' 14:46:03 INFO - no previously-included directories found matching 'dist' 14:46:03 INFO - no previously-included directories found matching '.git*' 14:46:03 INFO - Installing collected packages: jsonschema, functools32 14:46:03 INFO - Running setup.py install for functools32 14:46:03 INFO - warning: no files found matching '*.txt' 14:46:03 INFO - no previously-included directories found matching 'build' 14:46:03 INFO - no previously-included directories found matching 'dist' 14:46:03 INFO - no previously-included directories found matching '.git*' 14:46:03 INFO - Successfully installed jsonschema functools32 14:46:03 INFO - Cleaning up... 14:46:03 INFO - Return code: 0 14:46:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcad99f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, '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.LtuItADJ14/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.W5RWD4Pw4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 14:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:46:03 INFO - 'HOME': '/Users/cltbld', 14:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:46:03 INFO - 'LOGNAME': 'cltbld', 14:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:03 INFO - 'MOZ_NO_REMOTE': '1', 14:46:03 INFO - 'NO_EM_RESTART': '1', 14:46:03 INFO - 'PAGER': '/bin/cat', 14:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:03 INFO - 'PWD': '/builds/slave/test', 14:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:46:03 INFO - 'SHELL': '/bin/bash', 14:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:46:03 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:46:03 INFO - 'USER': 'cltbld', 14:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:03 INFO - 'XPC_FLAGS': '0x0', 14:46:03 INFO - 'XPC_SERVICE_NAME': '0', 14:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:04 INFO - Downloading/unpacking flake8 14:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:46:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:46:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 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 14:46:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:46:07 INFO - no previously-included directories found matching 'docs/_build' 14:46:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:46:07 INFO - Running setup.py install for pep8 14:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:46:07 INFO - no previously-included directories found matching 'docs/_build' 14:46:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:46:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:46:07 INFO - Cleaning up... 14:46:07 INFO - Return code: 0 14:46:07 INFO - Running post-action listener: _resource_record_post_action 14:46:07 INFO - Running post-action listener: _start_resource_monitoring 14:46:07 INFO - Starting resource monitoring. 14:46:07 INFO - ##### 14:46:07 INFO - ##### Running install step. 14:46:07 INFO - ##### 14:46:07 INFO - Running pre-action listener: _resource_record_pre_action 14:46:07 INFO - Running main action method: install 14:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:08 INFO - Reading from file tmpfile_stdout 14:46:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:46:08 INFO - Reading from file tmpfile_stdout 14:46:08 INFO - Output received: 14:46:08 INFO - Usage: mozinstall [options] installer 14:46:08 INFO - Options: 14:46:08 INFO - -h, --help show this help message and exit 14:46:08 INFO - -d DEST, --destination=DEST 14:46:08 INFO - Directory to install application into. [default: 14:46:08 INFO - "/builds/slave/test"] 14:46:08 INFO - --app=APP Application being installed. [default: firefox] 14:46:08 INFO - mkdir: /builds/slave/test/build/application 14:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:46:42 INFO - Reading from file tmpfile_stdout 14:46:42 INFO - Output received: 14:46:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:46:42 INFO - Running post-action listener: _resource_record_post_action 14:46:42 INFO - ##### 14:46:42 INFO - ##### Running run-tests step. 14:46:42 INFO - ##### 14:46:42 INFO - Running pre-action listener: _resource_record_pre_action 14:46:42 INFO - Running main action method: run_tests 14:46:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:46:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:46:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:46:42 INFO - 2016-03-31 14:46:42.101 screenresolution[2188:16590] starting screenresolution argv=screenresolution get 14:46:42 INFO - 2016-03-31 14:46:42.104 screenresolution[2188:16590] Display 0: 1600x1200x32@60 14:46:42 INFO - 2016-03-31 14:46:42.110 screenresolution[2189:16593] starting screenresolution argv=screenresolution list 14:46:42 INFO - Available Modes on Display 0 14:46:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:46:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:46:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:46:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:46:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:46:42 INFO - Intel Iris: 14:46:42 INFO - Chipset Model: Intel Iris 14:46:42 INFO - Type: GPU 14:46:42 INFO - Bus: Built-In 14:46:42 INFO - VRAM (Dynamic, Max): 1536 MB 14:46:42 INFO - Vendor: Intel (0x8086) 14:46:42 INFO - Device ID: 0x0a2e 14:46:42 INFO - Revision ID: 0x0009 14:46:42 INFO - Displays: 14:46:42 INFO - Display: 14:46:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:46:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:46:42 INFO - Display Serial Number: 1600x1200 60 14:46:42 INFO - Main Display: Yes 14:46:42 INFO - Mirror: Off 14:46:42 INFO - Online: Yes 14:46:42 INFO - Rotation: Supported 14:46:42 INFO - Return code: 0 14:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:46:42 INFO - Python 2.7.3 14:46:42 INFO - Return code: 0 14:46:42 INFO - grabbing minidump binary from tooltool 14:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:42 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 0x108cd8e00>, '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 0x108b01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cd3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:46:42 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 14:46:42 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 14:46:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:46:42 INFO - Return code: 0 14:46:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:46:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:46:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:46:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:46:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:46:43 INFO - Return code: 0 14:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 14:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 14:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtuItADJ14/Render', 14:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:46:43 INFO - 'HOME': '/Users/cltbld', 14:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:46:43 INFO - 'LOGNAME': 'cltbld', 14:46:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:46:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:43 INFO - 'MOZ_NO_REMOTE': '1', 14:46:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:46:43 INFO - 'NO_EM_RESTART': '1', 14:46:43 INFO - 'PAGER': '/bin/cat', 14:46:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:43 INFO - 'PWD': '/builds/slave/test', 14:46:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:46:43 INFO - 'SHELL': '/bin/bash', 14:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5RWD4Pw4p/Listeners', 14:46:43 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 14:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:46:43 INFO - 'USER': 'cltbld', 14:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:43 INFO - 'XPC_FLAGS': '0x0', 14:46:43 INFO - 'XPC_SERVICE_NAME': '0', 14:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:46:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 14:46:43 INFO - mozversion application_buildid: 20160331124731 14:46:43 INFO - mozversion application_changeset: 09f42355aa061bada9ab92056215d9cdae86a220 14:46:43 INFO - mozversion application_display_name: Nightly 14:46:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:46:43 INFO - mozversion application_name: Firefox 14:46:43 INFO - mozversion application_remotingname: firefox 14:46:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:46:43 INFO - mozversion application_vendor: Mozilla 14:46:43 INFO - mozversion application_version: 48.0a1 14:46:43 INFO - mozversion platform_buildid: 20160331124731 14:46:43 INFO - mozversion platform_changeset: 09f42355aa061bada9ab92056215d9cdae86a220 14:46:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:46:43 INFO - mozversion platform_version: 48.0a1 14:46:43 INFO - using testdate: 1459460803 14:46:43 INFO - actual date: 1459460803 14:46:43 INFO - starting webserver on 'localhost:50064' 14:46:43 INFO - SUITE-START | Running 2 tests 14:46:43 INFO - TEST-START | dromaeo_css 14:46:43 INFO - operating with platform_type : mac_ 14:46:43 INFO - Initialising browser for dromaeo_css test... 14:46:43 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpfQfK4u/profile http://localhost:50064/getInfo.html) 14:46:46 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 14:46:46 INFO - PROCESS | 2207 | colorDepth:24 14:46:46 INFO - PROCESS | 2207 | Browser inner width/height: 1024/689 14:46:46 INFO - PROCESS | 2207 | __metrics 14:46:46 INFO - PROCESS | 2207 | 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" 14:46:46 ERROR - PROCESS | 2207 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:46:46 INFO - TEST-INFO | 2207: exit 0 14:46:46 INFO - Browser initialized. 14:46:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:46:46 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpfQfK4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:58 INFO - PROCESS | 2210 | RSS: Main: 244064256 14:46:58 INFO - PROCESS | 2210 | 14:47:50 INFO - PROCESS | 2210 | 1459460870467 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] 14:49:59 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50064/tests/dromaeo/cssquery-ext.html) 14:50:00 INFO - PROCESS | 2210 | RSS: Main: 394702848 14:50:00 INFO - PROCESS | 2210 | 14:53:03 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-ext.html (next: http://localhost:50064/tests/dromaeo/cssquery-jquery.html) 14:53:04 INFO - PROCESS | 2210 | RSS: Main: 376565760 14:53:04 INFO - PROCESS | 2210 | 14:56:05 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50064/tests/dromaeo/cssquery-mootools.html) 14:56:06 INFO - PROCESS | 2210 | RSS: Main: 371408896 14:56:06 INFO - PROCESS | 2210 | 14:59:08 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50064/tests/dromaeo/cssquery-prototype.html) 14:59:09 INFO - PROCESS | 2210 | RSS: Main: 333135872 14:59:09 INFO - PROCESS | 2210 | 15:02:12 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50064/tests/dromaeo/cssquery-yui.html) 15:02:12 INFO - PROCESS | 2210 | RSS: Main: 333254656 15:02:12 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-yui.html (next: http://localhost:50064/tests/dromaeo/cssquery-dojo.html) 15:05:15 INFO - PROCESS | 2210 | RSS: Main: 413052928 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | __start_tp_report 15:05:15 INFO - PROCESS | 2210 | _x_x_mozilla_page_load 15:05:15 INFO - PROCESS | 2210 | _x_x_mozilla_page_load_details 15:05:15 INFO - PROCESS | 2210 | |i|pagename|runs| 15:05:15 INFO - PROCESS | 2210 | |0;dojo.html;2805.4950108980383;2929.7216764407376;3401.2007178313092;3425.09235052711;3434.450487921933;5415.268938693275;5491.066518691822;5511.9724401378035;5538.723063846812;5548.334199896013;4580.450345958489;5482.2873026506595;5545.77816887325;5675.404082571333;5677.233573467581;4993.325901003373;5023.321851550048;5032.144535428986;5042.647014708972;5198.636095473318;4220.029393239557;5108.64239503235;5144.151215049513;5162.509561591662;5215.217717342391;4963.3299504566785;4981.551660350549;5070.391553013662;5073.771680274396;5074.746262686869;5043.218301163325;5044.218146187347;5079.593632509427;5080.390353157608;5099.776053747111;4960.1567733485035;5013.523715247045;5018.5232402921665;5032.094223039851;5034.194528875399;4313.266744653416;5448.99999999996;5471.37079235889;5493.835184944458;5582.078956972095;6049.147457298247;6061.360569285839;6064.833730281331;6067.2719273687;6120.632762034248;6177.444030037318;6177.536684748662;6181.845453863644;6186.721597528122;6201.286852011986;5628.409017053233;5645.915311270334;5685.976524225638;5749.8275051748515;5753.51095156908;6183.567150299526;6189;6213.875722485525;6219.222597175353;6248.125262463259;5967.104934259809;5983.880322393527;5987.101934709828;5989.850253743604;6010.398960104042;6008.519318454513;6016.1878146450545;6087.299960504599;6096.481799047042;6100.023996160593;5954.374790647006;5999.910001349983;6011.218541589653;6011.308699499614;6024.548158888013;6023.518118550505;6047.244094488189;6068.241469816273;6104.898127493412;6107.227034499227;4799.208130658402;4820.30105634681;4830.758462076882;4832.589229915427;4851.417829860439;4343.174796788663;4351.456067991501;4353.25994580922;4366.126774645084;4367.519572846984;5226.719453733859;5257.842264732064;5493.450654934474;5606.018946684314;5608.327000759935;6202.937970620236;6205.007198848162;6212.161358216673;6215.875682486325;6248.343923888017;5547.750351234205;5630.986422444;5633.295838020247;5640.915386269209;5696.287964004499;5203.7918483261;5241.580673546107;5275.5515781158265;5308.46915308466;5315.495027972336;6212.81361559154;6234.470070044006;6235.033569796688;6245.156903818108;6246.968765156145;6173.969130154321;6186.381361863778;6192.473639740492;6196.504279657706;6218.160548325918;6117.583823141572;6130.398136742091;6202.317745048132;6202.379762023762;6212.658303793335;5936.317323507852;5998.904218757748;6036.154938308729;6044.879102418015;6110.69446527663;6043.456088952015;6197.318294987457;6197.752089916353;6205.162303089025;6231.1276421300145;5178.430372658929;5928.703564821828;5953.732082056405;6040.697965101639;6067.605605635619;5945.881082378415;5947.137665038632;5968.432998865101;5973.940260597338;5986.6707331097205;5686.061799802987;5819.0689489681445;5837.970810145922;5843.474087332161;5870.9432302186015;5882.764689412546;5901.085331773582;5930.822075337746;5947.851303717442;6031.668258245663;5793.594448388572;5818.214541036906;5820.097884827858;5862.149988251595;5886.028805247258 15:05:15 INFO - PROCESS | 2210 | |1;ext.html;511.82342091978256;514.8018013064969;570.6832707847143;646.3019938466457;646.6411141816293;24490.877545612268;30392.392152156943;30437.695623043764;37209.813950930205;38063;40777.38833917493;41126.17747645045;41252.79373603128;41371.37942930851;41376.58623413765;9608.279379046564;9784.412935223909;9785.804283914318;9792.853107203398;9799.461029643368;9563.043695630451;9733.075357840993;9737.756556086119;9740.318177727562;9746.171575416063;9797.853032204523;9870.259730520203;9877.950610246939;9882.110610045094;9882.654107106217;9763.804723905518;9843.261755368305;9859.802803943952;9861.950690246575;9864.556094975744;9686.70939871798;9833.4099954003;9845.212383009342;9853.556589953469;9879.06148915852;39815.60184398148;40133.59866401357;40141;40224.195516089516;40309.19381612381;3228.8547015384365;3354.312365964996;3441.500982357544;3638.872639457606;3823.1206822430718;27972.720272797214;29190;29246.70753292461;29248.70751292481;29269;2616.2151354593548;2620.868956552165;2773.88904443822;2786.6934637189893;2789.1632510246845;460410;463679;463904;464191;466570;60054.79890402168;60506.697466512385;60876;60947.390526095056;60991.390086098574;64087.35912640907;64118.67940660267;64294;64363.67818160973;64464;14676.339564719614;16730.49808505747;17128.486145415656;17135.828641713422;17153.82846171547;13065.085444018827;13107.541236056883;13153.73692526144;13156.40796164175;13162.473501060042;18227.36204232872;18892.811071889104;18958.95725735098;19027.33404330842;19039.904800476186;7752.573608451589;7928.0179955011245;7957.641906114239;8014.599270036475;8045.235702608243;921.4567792891668;926.7451450850936;1003.3377970539409;1011.6206422591529;1117.8602674665667;27805;28341.858290708413;28486.470118098023;28892.27769305784;28962;1048.3285425846136;1061.984070238947;1077.6120596585224;1178.7053236690826;1213.9939300303618;14052.380595710723;14232.359543820552;14565.344559494848;14611.415543378145;14622.780658290134;501102;507220;515096;515211;515407;56373;56490.87018259612;56544.43455565474;56636.43363566394;56825.60156785099;1344.287527610368;1372.6911444924813;1375.3192169875977;1463.3707505772406;1503.1056521369767;24294.27117186487;28814;28923;29078.854605726836;29159.48028055655;46090.308645369674;46440.30339544977;46478.53521464742;46515;46523.53476465192;335149;407901.96049019566;409554;410458.94770525955;410590;27699.446011079264;28217.71782282233;28259;31081.378372431973;31365;36936.26127477382;40941.91710412274;41510.79244603758;41574.792126039174;42017.36973945332;33842.830785845916;34260.601757876706;34579.65420345865;34899.47650785291;35327.823360883034;34495.310093798485;34812.47781283232;35847.46228806622;36090.63909360873;36582.08544786402;29147;29573.039983245217;31862.362752744353;35637;36095.27809443849;29583.408331833674;29645.110646680634;29761.404771904006;29832;30453;18635.254589816257;22593.757343346275;22948.885255573616;23564.175253866033;23728.762712373347 15:05:15 INFO - PROCESS | 2210 | |2;jquery.html;359.4267143905471;360.51690734415877;361.342356910423;367.86389036056664;374.6029209038418;18791.154398052087;19310.710339344903;20106.296279630216;20125.396238112862;20140.295089671865;18440.893546387226;19090.904545477253;19091.809081909178;19142.808571914276;19271.325503607375;5668.886622267552;5967.104934259853;6013.969930150343;6014.3985601439945;6017.638941663492;5678.063119585264;5850.941490585104;5969.791057312995;5983.491403230731;5987.9101813472835;5848.181254624356;5865.794697185599;5871.119332100197;5877.324107727602;5881.705914704247;5613.4386561343945;5811.217673917804;5822.97088514559;5862.413758624146;5879.88240235195;5005.2492126181;5058.342415486;5058.392992840846;5061.038402703474;5076.64463487556;25913.352166195808;28085.29786755327;29036.27409314763;29490.672919718665;29651.70348296511;2189.2228258968157;2236.8322375821876;2335.1142683739677;2367.9936027188546;2684.570468725014;14972.326245318987;15428.614284642974;15493.302801373966;15665.765013524806;16151.596210094724;1759.0676941221172;1812.3566134022365;1845.7877344105466;1859.460756380648;1879.4925370149983;106589.93410065878;113770.86229137603;113865;114081;114659.42670286678;14548.636284092983;14697;18256.809182897872;18358;18361.80648257859;22917.54164916726;28562.428751424854;28585.285367865552;28620.28449288743;28673.85304587835;10357.378557286436;10711.78576428467;10760.246782725291;10764.138868890626;10847.294925829796;9010.640930462756;9146.131117543822;9176.724698259062;9244;9268.814623707623;7200.603966781772;7418.479211761576;8328.25106727594;8495.66017359311;8561.82876342482;2639.0734763622663;2857.971420285812;3341.715954143925;3451.913702157466;3467.393206188907;768.4006474949437;911.8814554107923;966.4877614864133;972.6401231544232;1035.53400969564;17570.736438953427;18764.0617969101;19606.215751369786;20479.4880127998;20847.687284690743;888.1985103755935;937.7374335186022;940.1632547033146;984.7587341101475;984.8424252119627;10345.327553708985;10693.9465302673;10973.890261097447;10976.12191024716;11010.944945275221;622403;629042;636214;637639;642846;107290;109439;109708.4514577422;109937.45031274793;110856.4457177709;1011.2870426349406;1020.132887046005;1041.739565108723;1042.1766804224728;1044.5404022230193;14751.483698070517;17439.389621363192;17484.300627975248;17710.468685939442;18226.45320640383;29473.60022340564;30098.69901300959;47702;49688;50562.49437505578;63348.68325658342;63928;66053;67060.6646966762;67106.99339509814;6655.301193374626;7812.079198045076;7832.686692532235;7894.526328420084;8034.276915077671;9259.629614815332;11801.704957376134;12074.45664945062;12684.682882928;12723.300218488072;10084.84872726895;10601.787964240826;10945.507452164831;11058.336499810037;11339.206255562032;5238.926020165933;7389.593572353572;11131.165162612675;11140.498677559692;11384.430778460877;10902.945485272523;11078.446077695922;11341.886581134413;11435.199536032398;11624.18630695877;7744.917928032288;7836.92163078362;7912.0505539335645;8117.959410202911;8174.264316211569;10354.430506321924;10504.369737815756;10864.076553492725;10912.781744365227;11072.557097716324 15:05:15 INFO - PROCESS | 2210 | |3;mootools.html;1389.2012093046499;1435.6410897275682;1604.382312809568;1834.1746214203604;2015.546502037041;7868.17384174662;8057.556834374107;8059.314958228543;8065.717699880505;8090.676372945082;8271.172882711726;8564.74305770828;8577.185167409101;8580.356473264499;8622.180892815188;2418.141559746291;2484.3168128764646;2490.091116742385;2492.028109037477;2492.3021553964827;2147.2699282244034;2193.8135258502966;2194.3197608741343;2427.890744916483;2495.6381324707904;2189.255653077953;2225.4881377283236;2379.845310054841;2465.8767061646936;2467.617519284514;2383.5947888858936;2421.8546887186735;2428.259380888828;2430.1858877276136;2432.1487479382163;2413.710354757423;2415.0581273303424;2416;2418.3470462975074;2427.8421902576274;8496.447730897471;8504.064552899175;8557.957210213972;8576.742697719079;8580.656773729042;5304.469553044703;5324.1747529133045;5407.783688652449;5514.834554963358;5525.778968841241;3057.785954983152;3559.857605695769;3651.1967367179177;3663.7435379523445;3688.5758137814228;1041.9322744021615;1043.4521876015076;1067.8985496377832;1072.1583556907867;1076.6931424544046;11580.420978951019;11602.129840262014;11604.535818567247;11607.76784464306;11615.767684646344;4711.465882573494;4827.831025914076;4861.9027619447415;4886.462489126193;4889.926651100236;9900.207983361313;9973.900260997443;9986.650467233612;9992.200623950066;9997.650082247086;5353.678779273256;5359.008583412004;5475.233467314579;5493.423190565013;5499.395066542677;4789.760511974388;4859.708417494961;4952.232403977389;4960.851174464772;4990.750462476934;3832.4826148470156;3851.2105018471148;3885.55316138642;3905.6680182184264;3911.4328422379167;1219.3171823778712;1289.0589869395394;1308.6793735534663;1316.9192675572572;1321.9405126769318;973.3284034016506;987.5753426026733;1015.8679371681634;1018.0582960761415;1374;7848.725294614661;7886.763397098096;7894.486858354188;7938.126806051329;7940.6029698515995;1163.5229555882217;1179.2747460312019;1181.527389044389;1191.0531127753457;1203.1157099531838;6130.63216207029;6207.286162091327;6264.624122552661;6291.937080629226;6298;10268.281220314655;10639.840402393971;10661.360318380923;10672.306300090624;10685.83971240432;10146.086852183338;10427.530761115768;10446.268761186797;10492.422916739653;10507.054365107177;8100.311473524698;8246.752597421966;8298.460600060977;8303.418760686694;8314.251717345467;7613.162552119373;7770.728024519115;7797.961010195139;7826.491278066907;7856.764297071097;9182.95408522953;9447.480388578419;9452.810943780949;9535.952320238632;9550.808983820423;8232.34141268685;9652.889917659559;9872.802543949225;9976;9996.350237234556;7444.516106453063;7472.775816725507;7503.324700776956;7543.7736867894055;7570.9242907570215;8122.675092996214;8168.591570421337;8204.220599043081;8213.83572328562;8223.424360294723;6044.667543285162;7215.134183897966;7386.187519372972;7468.2158373372185;7511.699532018876;7077.752278670222;7155.069840920647;7174.928250717426;7194.89207661875;7201.567905925661;7509.324160825552;7610.657520411484;7611.3530349920875;7621.885671715039;7680.231976802275;6826.863462730618;6908.689108990007;6919.930800691928;6931;6951.478639102189;6828.624425656438;7008.334208250208;7029.718811247493;7053.188883278489;7053.4004609608755 15:05:15 INFO - PROCESS | 2210 | |4;prototype.html;322.64186752704495;326.4874147588286;331.3174859788835;331.83242462556404;337.64547225413327;6360.236771587411;6373.362663733625;6387.265464471587;6396.936030639698;6440.484761219103;6313.463355614766;6316.589421687599;6324.2727086385075;6333.936660633392;6349.174607301056;4489.910201795962;4577.038821847416;4584.724916505021;4626.097910907374;4735.289706544011;3880.9805950970203;4670.299455081731;4684.672072954894;4691.577758001779;4721.527847215285;4672.602828759559;4681.672282940195;4681.859544213679;4682.41469816273;4714.599259062984;4435.334699795057;4527.592516673482;4675.8363457279;4675.976620116911;4682.438107427097;4009.0779120802085;4028.637422631977;4033.6773058155572;4041.858534951292;4048.7570745755056;6114.174586430864;6175.042868355367;6278.968605156945;6285.4343109119945;6299.874002519924;5497.175423686439;5505.972470137664;5514.035043867307;5516.117421212587;5532.838103998165;5943.970280148615;6379.808605741835;6737.797866064026;6766.424853887425;6772.932270677279;4382.8904277393;4560.566746159143;4563.178627846986;4564.360989461478;4582.885427864297;7085.504014718972;7138.321859423347;7145.928540714578;7155.320244576809;7156.069710937597;3891.8248678809523;4619.445666520039;4627.236505976543;4630.69900456476;4648.140094082605;4193.832246710159;4442.244818380883;4711.0342379812055;4713.717176969393;4726.432828060655;5480.424555421703;5493.09363954943;5508.944910550923;5514.448555144453;5514.696691681996;5500.477454641803;6525.347465253437;6743;6768.120144381199;6821.113255276782;1616.4827255278199;1632.208378936215;1643.909584972838;1651.5210588929076;1663.193351224655;885.9557022148866;908.5911339897073;1006.1196453103535;1071.4214324264965;1090.9799337619352;6099.603525770811;6304.085907543381;6410.1987251593555;6429.357064293533;6429.38920802523;7062.540934839321;7071;7081.008658787774;7081.964590177016;7105.822354441077;6386.393292637192;6396.168498095218;6401.391867772554;6410.55126141175;6420.582662126947;3687.2625474905126;3738.140227747633;3745.232227393378;3749.7562658427114;3750.7562008469363;6966.686499107553;6975.511714179958;7419.629018549051;7430.405567554582;7444.367228785614;7264.491485596063;7314.451416143704;7314.670839812221;7318.194998550155;7325.2674732527385;7401.555906645618;7413.221611730691;7420.035395398563;7424.1462231844025;7427.405807535384;5827.329857066322;7068.964655176691;7074.71701131949;7081.256468070778;7088.468364872759;6751.56114852533;7037.1555413350725;7038.577685338896;7050.189228238818;7071.7878463646175;6126.448619624255;7385.150707668687;7398.408127349691;7491.9625401872645;7505.812354691177;3840.462335273008;4535.727856328631;4557.293619488984;4566.954330456786;4568.70303430276;6565.868682626417;7089.220185779664;7099.574025558483;7127.073480447509;7130.2869713028285;6205.410486003822;6520.413162815369;6781.220159681699;6837.145356830396;6847.520673552804;6778.017187507685;6845.041694162921;6856.41720453767;6856.554323968926;6869.553479023847;5135.589152867687;6681.198256209286;6689.163854518185;6699.799006029827;6703.29615390377;6065.999110146953;6376.362363763772;6816.147981502312;6829.52193346461;6836.623985680636;5321.893562128813;6429.54993150475;6465.870682586416;6572.934270657423;6669.4664426844765 15:05:15 INFO - PROCESS | 2210 | |5;yui.html;622.7384498510626;636.4908073541169;724.6159535446212;724.6304384763769;764.3006648916241;11678.532858685643;14824.481143159992;14826;14842.55472335829;14844.92577537112;15664.608384790386;15969.520914372559;15973.920130399332;15974;15986.440474583364;760.3954855889581;772.6638912073238;929.4191130543394;949.292776881221;955.9808803823919;811.427943299975;820.979475513111;823.2467292427422;830.6137645994611;830.887830142929;988.7478692933328;999.4552968632113;1001.43919405133;1001.5893483671696;1002.8846682631481;789.8973133492638;803.995980020102;809.3363441977581;994.2245048861863;995.5271246158089;734.5005396330494;743.6765007221876;744.5867543513348;745.5154149802618;746.1941103608144;15211;15268.541943741706;15284;15310.234488275653;15436.845631543652;12317.507299708;12363.320017399039;12636.81044784329;12735;12914;8074.959625201836;9389.812203755955;9499.952500237523;9792.90207097927;9838.262130340254;3305.5372247885316;3473.513708080871;3536.6993805526563;3558.804265765382;3575.2313252650547;81018;81270.59364703139;81365.59317203435;81375.59312203461;81417;9532.571034303473;9582.808343833085;9587.472689002172;9642.903570964201;9814.263930205121;22201.44496387603;22309.55380892373;22314.776852231593;22322.107115715513;22339.77660223377;7349.816254593571;7449.068866391701;7454.515456495419;7525.2098529654695;7586.848263034708;4026.697997650188;4059.106996460774;4083.571225021389;4125.092479654471;4374.12517496502;3583.587887392931;3625.927481450356;3631.1648320886343;3636.872709455209;3637.490751294768;567.9294529811253;588.8910551547978;593.1073734030343;687.6905392573262;716.5915428205873;516.2333934107846;550.6255746092615;594.7769586405099;612.461034289831;626.6647343671114;8405.453645513144;8643.740687779376;8655.48067115975;8760.518171500502;8825.249853762502;562.1960596347182;572.3544808675059;579.492943674285;597.5160120302569;628.4532456762646;3735.4210097434943;3901.726879118491;3911.5501717302873;3938.5667576566557;3955.627570734139;86911.13088869156;88130.11869881219;89653;89942.55028724814;89984.5500772492;57198.7140064297;74363;75897;76890;78435;66150.00774988379;66943;68179.65910170418;69022.65488672524;69181.61636767237;7771.455998080306;7806.0632724073475;7806.375489960676;7811.96094019549;8006.039275287003;45329.86675333143;45436;45681.771591141835;45863.77068114638;46362.76818615885;48607.75696121497;60926.69536652289;61633.767324652355;63086.68456657687;63165.68417157885;10127.493625318852;10150.289479736643;10212.489375531342;10291.485425728833;10599.046085852311;11152.63178929703;11178.27341222818;11257.21199516026;11343.262687925588;11603.6518904433;10474.162067034771;10748.247622666338;10818.783624327627;10827.458627068772;10828.079613232963;10358.274920755475;10433;10487.423191724529;10802;10841;7500.924990750241;10604.522796474022;10620.15038796879;10643.935606439294;10662.73343166427;8925.509096999467;9023.864642030243;9216.723498295061;9280.72157835266;9308.813823723623;7985.960070199611;8358.723141565635;8609.82780344402;9000.774980625536;9098.727038188865 15:05:15 INFO - PROCESS | 2210 | __end_tp_report 15:05:15 INFO - PROCESS | 2210 | __start_cc_report 15:05:15 INFO - PROCESS | 2210 | _x_x_mozilla_cycle_collect,1463 15:05:15 INFO - PROCESS | 2210 | __end_cc_report 15:05:15 INFO - PROCESS | 2210 | __startTimestamp1459461915809__endTimestamp 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | ------- Summary: start ------- 15:05:15 INFO - PROCESS | 2210 | Number of tests: 6 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#0] dojo.html Cycles:165 Average:5597.00 Median:5843.47 stddev:669.80 (11.5%) stddev-sans-first:635.05 15:05:15 INFO - PROCESS | 2210 | Values: 2805.5 2929.7 3401.2 3425.1 3434.5 5415.3 5491.1 5512.0 5538.7 5548.3 4580.5 5482.3 5545.8 5675.4 5677.2 4993.3 5023.3 5032.1 5042.6 5198.6 4220.0 5108.6 5144.2 5162.5 5215.2 4963.3 4981.6 5070.4 5073.8 5074.7 5043.2 5044.2 5079.6 5080.4 5099.8 4960.2 5013.5 5018.5 5032.1 5034.2 4313.3 5449.0 5471.4 5493.8 5582.1 6049.1 6061.4 6064.8 6067.3 6120.6 6177.4 6177.5 6181.8 6186.7 6201.3 5628.4 5645.9 5686.0 5749.8 5753.5 6183.6 6189.0 6213.9 6219.2 6248.1 5967.1 5983.9 5987.1 5989.9 6010.4 6008.5 6016.2 6087.3 6096.5 6100.0 5954.4 5999.9 6011.2 6011.3 6024.5 6023.5 6047.2 6068.2 6104.9 6107.2 4799.2 4820.3 4830.8 4832.6 4851.4 4343.2 4351.5 4353.3 4366.1 4367.5 5226.7 5257.8 5493.5 5606.0 5608.3 6202.9 6205.0 6212.2 6215.9 6248.3 5547.8 5631.0 5633.3 5640.9 5696.3 5203.8 5241.6 5275.6 5308.5 5315.5 6212.8 6234.5 6235.0 6245.2 6247.0 6174.0 6186.4 6192.5 6196.5 6218.2 6117.6 6130.4 6202.3 6202.4 6212.7 5936.3 5998.9 6036.2 6044.9 6110.7 6043.5 6197.3 6197.8 6205.2 6231.1 5178.4 5928.7 5953.7 6040.7 6067.6 5945.9 5947.1 5968.4 5973.9 5986.7 5686.1 5819.1 5838.0 5843.5 5870.9 5882.8 5901.1 5930.8 5947.9 6031.7 5793.6 5818.2 5820.1 5862.1 5886.0 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#1] ext.html Cycles:180 Average:59750.84 Median:36759.17 stddev:122038.12 (332.0%) stddev-sans-first:122299.42 15:05:15 INFO - PROCESS | 2210 | Values: 511.8 514.8 570.7 646.3 646.6 24490.9 30392.4 30437.7 37209.8 38063.0 40777.4 41126.2 41252.8 41371.4 41376.6 9608.3 9784.4 9785.8 9792.9 9799.5 9563.0 9733.1 9737.8 9740.3 9746.2 9797.9 9870.3 9878.0 9882.1 9882.7 9763.8 9843.3 9859.8 9862.0 9864.6 9686.7 9833.4 9845.2 9853.6 9879.1 39815.6 40133.6 40141.0 40224.2 40309.2 3228.9 3354.3 3441.5 3638.9 3823.1 27972.7 29190.0 29246.7 29248.7 29269.0 2616.2 2620.9 2773.9 2786.7 2789.2 460410.0 463679.0 463904.0 464191.0 466570.0 60054.8 60506.7 60876.0 60947.4 60991.4 64087.4 64118.7 64294.0 64363.7 64464.0 14676.3 16730.5 17128.5 17135.8 17153.8 13065.1 13107.5 13153.7 13156.4 13162.5 18227.4 18892.8 18959.0 19027.3 19039.9 7752.6 7928.0 7957.6 8014.6 8045.2 921.5 926.7 1003.3 1011.6 1117.9 27805.0 28341.9 28486.5 28892.3 28962.0 1048.3 1062.0 1077.6 1178.7 1214.0 14052.4 14232.4 14565.3 14611.4 14622.8 501102.0 507220.0 515096.0 515211.0 515407.0 56373.0 56490.9 56544.4 56636.4 56825.6 1344.3 1372.7 1375.3 1463.4 1503.1 24294.3 28814.0 28923.0 29078.9 29159.5 46090.3 46440.3 46478.5 46515.0 46523.5 335149.0 407902.0 409554.0 410458.9 410590.0 27699.4 28217.7 28259.0 31081.4 31365.0 36936.3 40941.9 41510.8 41574.8 42017.4 33842.8 34260.6 34579.7 34899.5 35327.8 34495.3 34812.5 35847.5 36090.6 36582.1 29147.0 29573.0 31862.4 35637.0 36095.3 29583.4 29645.1 29761.4 29832.0 30453.0 18635.3 22593.8 22948.9 23564.2 23728.8 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#2] jquery.html Cycles:180 Average:35374.06 Median:15384.93 stddev:104649.35 (680.2%) stddev-sans-first:104909.90 15:05:15 INFO - PROCESS | 2210 | Values: 359.4 360.5 361.3 367.9 374.6 18791.2 19310.7 20106.3 20125.4 20140.3 18440.9 19090.9 19091.8 19142.8 19271.3 5668.9 5967.1 6014.0 6014.4 6017.6 5678.1 5850.9 5969.8 5983.5 5987.9 5848.2 5865.8 5871.1 5877.3 5881.7 5613.4 5811.2 5823.0 5862.4 5879.9 5005.2 5058.3 5058.4 5061.0 5076.6 25913.4 28085.3 29036.3 29490.7 29651.7 2189.2 2236.8 2335.1 2368.0 2684.6 14972.3 15428.6 15493.3 15665.8 16151.6 1759.1 1812.4 1845.8 1859.5 1879.5 106589.9 113770.9 113865.0 114081.0 114659.4 14548.6 14697.0 18256.8 18358.0 18361.8 22917.5 28562.4 28585.3 28620.3 28673.9 10357.4 10711.8 10760.2 10764.1 10847.3 9010.6 9146.1 9176.7 9244.0 9268.8 7200.6 7418.5 8328.3 8495.7 8561.8 2639.1 2858.0 3341.7 3451.9 3467.4 768.4 911.9 966.5 972.6 1035.5 17570.7 18764.1 19606.2 20479.5 20847.7 888.2 937.7 940.2 984.8 984.8 10345.3 10693.9 10973.9 10976.1 11010.9 622403.0 629042.0 636214.0 637639.0 642846.0 107290.0 109439.0 109708.5 109937.5 110856.4 1011.3 1020.1 1041.7 1042.2 1044.5 14751.5 17439.4 17484.3 17710.5 18226.5 29473.6 30098.7 47702.0 49688.0 50562.5 63348.7 63928.0 66053.0 67060.7 67107.0 6655.3 7812.1 7832.7 7894.5 8034.3 9259.6 11801.7 12074.5 12684.7 12723.3 10084.8 10601.8 10945.5 11058.3 11339.2 5238.9 7389.6 11131.2 11140.5 11384.4 10902.9 11078.4 11341.9 11435.2 11624.2 7744.9 7836.9 7912.1 8118.0 8174.3 10354.4 10504.4 10864.1 10912.8 11072.6 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#3] mootools.html Cycles:180 Average:5958.47 Median:5507.11 stddev:3116.75 (56.6%) stddev-sans-first:3106.56 15:05:15 INFO - PROCESS | 2210 | Values: 1389.2 1435.6 1604.4 1834.2 2015.5 7868.2 8057.6 8059.3 8065.7 8090.7 8271.2 8564.7 8577.2 8580.4 8622.2 2418.1 2484.3 2490.1 2492.0 2492.3 2147.3 2193.8 2194.3 2427.9 2495.6 2189.3 2225.5 2379.8 2465.9 2467.6 2383.6 2421.9 2428.3 2430.2 2432.1 2413.7 2415.1 2416.0 2418.3 2427.8 8496.4 8504.1 8558.0 8576.7 8580.7 5304.5 5324.2 5407.8 5514.8 5525.8 3057.8 3559.9 3651.2 3663.7 3688.6 1041.9 1043.5 1067.9 1072.2 1076.7 11580.4 11602.1 11604.5 11607.8 11615.8 4711.5 4827.8 4861.9 4886.5 4889.9 9900.2 9973.9 9986.7 9992.2 9997.7 5353.7 5359.0 5475.2 5493.4 5499.4 4789.8 4859.7 4952.2 4960.9 4990.8 3832.5 3851.2 3885.6 3905.7 3911.4 1219.3 1289.1 1308.7 1316.9 1321.9 973.3 987.6 1015.9 1018.1 1374.0 7848.7 7886.8 7894.5 7938.1 7940.6 1163.5 1179.3 1181.5 1191.1 1203.1 6130.6 6207.3 6264.6 6291.9 6298.0 10268.3 10639.8 10661.4 10672.3 10685.8 10146.1 10427.5 10446.3 10492.4 10507.1 8100.3 8246.8 8298.5 8303.4 8314.3 7613.2 7770.7 7798.0 7826.5 7856.8 9183.0 9447.5 9452.8 9536.0 9550.8 8232.3 9652.9 9872.8 9976.0 9996.4 7444.5 7472.8 7503.3 7543.8 7570.9 8122.7 8168.6 8204.2 8213.8 8223.4 6044.7 7215.1 7386.2 7468.2 7511.7 7077.8 7155.1 7174.9 7194.9 7201.6 7509.3 7610.7 7611.4 7621.9 7680.2 6826.9 6908.7 6919.9 6931.0 6951.5 6828.6 7008.3 7029.7 7053.2 7053.4 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#4] prototype.html Cycles:180 Average:5548.84 Median:6329.10 stddev:1768.48 (27.9%) stddev-sans-first:1729.39 15:05:15 INFO - PROCESS | 2210 | Values: 322.6 326.5 331.3 331.8 337.6 6360.2 6373.4 6387.3 6396.9 6440.5 6313.5 6316.6 6324.3 6333.9 6349.2 4489.9 4577.0 4584.7 4626.1 4735.3 3881.0 4670.3 4684.7 4691.6 4721.5 4672.6 4681.7 4681.9 4682.4 4714.6 4435.3 4527.6 4675.8 4676.0 4682.4 4009.1 4028.6 4033.7 4041.9 4048.8 6114.2 6175.0 6279.0 6285.4 6299.9 5497.2 5506.0 5514.0 5516.1 5532.8 5944.0 6379.8 6737.8 6766.4 6772.9 4382.9 4560.6 4563.2 4564.4 4582.9 7085.5 7138.3 7145.9 7155.3 7156.1 3891.8 4619.4 4627.2 4630.7 4648.1 4193.8 4442.2 4711.0 4713.7 4726.4 5480.4 5493.1 5508.9 5514.4 5514.7 5500.5 6525.3 6743.0 6768.1 6821.1 1616.5 1632.2 1643.9 1651.5 1663.2 886.0 908.6 1006.1 1071.4 1091.0 6099.6 6304.1 6410.2 6429.4 6429.4 7062.5 7071.0 7081.0 7082.0 7105.8 6386.4 6396.2 6401.4 6410.6 6420.6 3687.3 3738.1 3745.2 3749.8 3750.8 6966.7 6975.5 7419.6 7430.4 7444.4 7264.5 7314.5 7314.7 7318.2 7325.3 7401.6 7413.2 7420.0 7424.1 7427.4 5827.3 7069.0 7074.7 7081.3 7088.5 6751.6 7037.2 7038.6 7050.2 7071.8 6126.4 7385.2 7398.4 7492.0 7505.8 3840.5 4535.7 4557.3 4567.0 4568.7 6565.9 7089.2 7099.6 7127.1 7130.3 6205.4 6520.4 6781.2 6837.1 6847.5 6778.0 6845.0 6856.4 6856.6 6869.6 5135.6 6681.2 6689.2 6699.8 6703.3 6066.0 6376.4 6816.1 6829.5 6836.6 5321.9 6429.5 6465.9 6572.9 6669.5 15:05:15 INFO - PROCESS | 2210 | 15:05:15 INFO - PROCESS | 2210 | [#5] yui.html Cycles:180 Average:17548.30 Median:31123.11 stddev:24523.64 (78.8%) stddev-sans-first:24559.50 15:05:15 INFO - PROCESS | 2210 | Values: 622.7 636.5 724.6 724.6 764.3 11678.5 14824.5 14826.0 14842.6 14844.9 15664.6 15969.5 15973.9 15974.0 15986.4 760.4 772.7 929.4 949.3 956.0 811.4 821.0 823.2 830.6 830.9 988.7 999.5 1001.4 1001.6 1002.9 789.9 804.0 809.3 994.2 995.5 734.5 743.7 744.6 745.5 746.2 15211.0 15268.5 15284.0 15310.2 15436.8 12317.5 12363.3 12636.8 12735.0 12914.0 8075.0 9389.8 9500.0 9792.9 9838.3 3305.5 3473.5 3536.7 3558.8 3575.2 81018.0 81270.6 81365.6 81375.6 81417.0 9532.6 9582.8 9587.5 9642.9 9814.3 22201.4 22309.6 22314.8 22322.1 22339.8 7349.8 7449.1 7454.5 7525.2 7586.8 4026.7 4059.1 4083.6 4125.1 4374.1 3583.6 3625.9 3631.2 3636.9 3637.5 567.9 588.9 593.1 687.7 716.6 516.2 550.6 594.8 612.5 626.7 8405.5 8643.7 8655.5 8760.5 8825.2 562.2 572.4 579.5 597.5 628.5 3735.4 3901.7 3911.6 3938.6 3955.6 86911.1 88130.1 89653.0 89942.6 89984.6 57198.7 74363.0 75897.0 76890.0 78435.0 66150.0 66943.0 68179.7 69022.7 69181.6 7771.5 7806.1 7806.4 7812.0 8006.0 45329.9 45436.0 45681.8 45863.8 46362.8 48607.8 60926.7 61633.8 63086.7 63165.7 10127.5 10150.3 10212.5 10291.5 10599.0 11152.6 11178.3 11257.2 11343.3 11603.7 10474.2 10748.2 10818.8 10827.5 10828.1 10358.3 10433.0 10487.4 10802.0 10841.0 7500.9 10604.5 10620.2 10643.9 10662.7 8925.5 9023.9 9216.7 9280.7 9308.8 7986.0 8358.7 8609.8 9000.8 9098.7 15:05:15 INFO - PROCESS | 2210 | -------- Summary: end -------- 15:05:15 INFO - PROCESS | 2210 | 15:05:16 INFO - TEST-INFO | 2210: exit 0 15:05:16 INFO - TEST-OK | dromaeo_css | took 1112625ms 15:05:16 INFO - TEST-START | kraken 15:05:16 INFO - operating with platform_type : mac_ 15:05:16 INFO - Initialising browser for kraken test... 15:05:16 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpXZuM4u/profile http://localhost:50064/getInfo.html) 15:05:18 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 15:05:18 INFO - PROCESS | 2213 | colorDepth:24 15:05:18 INFO - PROCESS | 2213 | Browser inner width/height: 1024/689 15:05:18 INFO - PROCESS | 2213 | __metrics 15:05:18 INFO - PROCESS | 2213 | 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" 15:05:18 ERROR - PROCESS | 2213 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:05:19 INFO - TEST-INFO | 2213: exit 0 15:05:19 INFO - Browser initialized. 15:05:19 INFO - Running cycle 1/1 for kraken test... 15:05:19 INFO - TEST-INFO | started process 2215 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpXZuM4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:31 INFO - PROCESS | 2215 | RSS: Main: 244432896 15:05:31 INFO - PROCESS | 2215 | 15:05:33 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-beat-detection) 15:05:34 INFO - PROCESS | 2215 | RSS: Main: 291385344 15:05:34 INFO - PROCESS | 2215 | 15:05:37 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-dft) 15:05:37 INFO - PROCESS | 2215 | RSS: Main: 300797952 15:05:37 INFO - PROCESS | 2215 | 15:05:41 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-fft) 15:05:41 INFO - PROCESS | 2215 | RSS: Main: 286216192 15:05:41 INFO - PROCESS | 2215 | 15:05:43 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-oscillator) 15:05:44 INFO - PROCESS | 2215 | RSS: Main: 288006144 15:05:44 INFO - PROCESS | 2215 | 15:05:46 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:05:46 INFO - PROCESS | 2215 | RSS: Main: 286826496 15:05:46 INFO - PROCESS | 2215 | 15:05:49 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-darkroom) 15:05:50 INFO - PROCESS | 2215 | RSS: Main: 288051200 15:05:50 INFO - PROCESS | 2215 | 15:05:53 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-desaturate) 15:05:53 INFO - PROCESS | 2215 | RSS: Main: 288280576 15:05:53 INFO - PROCESS | 2215 | 15:05:56 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50064/tests/kraken/driver.html?testName=json-parse-financial) 15:05:56 INFO - PROCESS | 2215 | RSS: Main: 288645120 15:05:56 INFO - PROCESS | 2215 | 15:05:58 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:05:59 INFO - PROCESS | 2215 | RSS: Main: 326246400 15:05:59 INFO - PROCESS | 2215 | 15:06:01 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:06:01 INFO - PROCESS | 2215 | RSS: Main: 324595712 15:06:01 INFO - PROCESS | 2215 | 15:06:03 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:06:04 INFO - PROCESS | 2215 | RSS: Main: 331104256 15:06:04 INFO - PROCESS | 2215 | 15:06:06 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:06:07 INFO - PROCESS | 2215 | RSS: Main: 332599296 15:06:07 INFO - PROCESS | 2215 | 15:06:09 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:06:10 INFO - PROCESS | 2215 | RSS: Main: 332197888 15:06:10 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50064/tests/kraken/driver.html?testName=ai-astar) 15:06:12 INFO - PROCESS | 2215 | RSS: Main: 396161024 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | __start_tp_report 15:06:12 INFO - PROCESS | 2215 | _x_x_mozilla_page_load 15:06:12 INFO - PROCESS | 2215 | _x_x_mozilla_page_load_details 15:06:12 INFO - PROCESS | 2215 | |i|pagename|runs| 15:06:12 INFO - PROCESS | 2215 | |0;ai-astar;112;110;112;111;112;109;117;112;112;111 15:06:12 INFO - PROCESS | 2215 | |1;audio-beat-detection;161;126;142;143;138;175;168;124;163;117 15:06:12 INFO - PROCESS | 2215 | |2;audio-dft;186;183;186;185;187;185;185;183;181;182 15:06:12 INFO - PROCESS | 2215 | |3;audio-fft;78;71;85;80;56;58;57;79;79;56 15:06:12 INFO - PROCESS | 2215 | |4;audio-oscillator;93;93;130;81;78;85;120;79;81;119 15:06:12 INFO - PROCESS | 2215 | |5;imaging-gaussian-blur;87;84;86;84;87;84;88;84;123;84 15:06:12 INFO - PROCESS | 2215 | |6;imaging-darkroom;91;93;93;94;93;92;92;92;93;115 15:06:12 INFO - PROCESS | 2215 | |7;imaging-desaturate;85;85;86;85;88;86;85;86;86;83 15:06:12 INFO - PROCESS | 2215 | |8;json-parse-financial;55;53;56;52;53;75;77;91;77;72 15:06:12 INFO - PROCESS | 2215 | |9;json-stringify-tinderbox;67;67;70;77;71;69;68;69;69;71 15:06:12 INFO - PROCESS | 2215 | |10;stanford-crypto-aes;83;84;84;84;83;83;83;84;83;84 15:06:12 INFO - PROCESS | 2215 | |11;stanford-crypto-ccm;132;134;124;126;121;126;122;125;133;124 15:06:12 INFO - PROCESS | 2215 | |12;stanford-crypto-pbkdf2;141;129;138;139;138;127;138;140;140;141 15:06:12 INFO - PROCESS | 2215 | |13;stanford-crypto-sha256-iterative;67;68;68;67;68;68;69;68;68;68 15:06:12 INFO - PROCESS | 2215 | __end_tp_report 15:06:12 INFO - PROCESS | 2215 | __start_cc_report 15:06:12 INFO - PROCESS | 2215 | _x_x_mozilla_cycle_collect,1236 15:06:12 INFO - PROCESS | 2215 | __end_cc_report 15:06:12 INFO - PROCESS | 2215 | __startTimestamp1459461972539__endTimestamp 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | ------- Summary: start ------- 15:06:12 INFO - PROCESS | 2215 | Number of tests: 14 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.10 (1.9%) stddev-sans-first:2.22 15:06:12 INFO - PROCESS | 2215 | Values: 112.0 110.0 112.0 111.0 112.0 109.0 117.0 112.0 112.0 111.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:20.14 (13.3%) stddev-sans-first:20.59 15:06:12 INFO - PROCESS | 2215 | Values: 161.0 126.0 142.0 143.0 138.0 175.0 168.0 124.0 163.0 117.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.95 (1.1%) stddev-sans-first:1.96 15:06:12 INFO - PROCESS | 2215 | Values: 186.0 183.0 186.0 185.0 187.0 185.0 185.0 183.0 181.0 182.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#3] audio-fft Cycles:10 Average:69.90 Median:78.50 stddev:11.82 (15.1%) stddev-sans-first:12.17 15:06:12 INFO - PROCESS | 2215 | Values: 78.0 71.0 85.0 80.0 56.0 58.0 57.0 79.0 79.0 56.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.00 stddev:19.62 (24.2%) stddev-sans-first:20.78 15:06:12 INFO - PROCESS | 2215 | Values: 93.0 93.0 130.0 81.0 78.0 85.0 120.0 79.0 81.0 119.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:85.00 stddev:12.01 (14.1%) stddev-sans-first:12.72 15:06:12 INFO - PROCESS | 2215 | Values: 87.0 84.0 86.0 84.0 87.0 84.0 88.0 84.0 123.0 84.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:93.00 stddev:7.15 (7.7%) stddev-sans-first:7.45 15:06:12 INFO - PROCESS | 2215 | Values: 91.0 93.0 93.0 94.0 93.0 92.0 92.0 92.0 93.0 115.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.27 (1.5%) stddev-sans-first:1.33 15:06:12 INFO - PROCESS | 2215 | Values: 85.0 85.0 86.0 85.0 88.0 86.0 85.0 86.0 86.0 83.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:73.50 stddev:13.90 (18.9%) stddev-sans-first:14.15 15:06:12 INFO - PROCESS | 2215 | Values: 55.0 53.0 56.0 52.0 53.0 75.0 77.0 91.0 77.0 72.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:2.90 (4.2%) stddev-sans-first:2.89 15:06:12 INFO - PROCESS | 2215 | Values: 67.0 67.0 70.0 77.0 71.0 69.0 68.0 69.0 69.0 71.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:06:12 INFO - PROCESS | 2215 | Values: 83.0 84.0 84.0 84.0 83.0 83.0 83.0 84.0 83.0 84.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:126.00 stddev:4.64 (3.7%) stddev-sans-first:4.51 15:06:12 INFO - PROCESS | 2215 | Values: 132.0 134.0 124.0 126.0 121.0 126.0 122.0 125.0 133.0 124.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:139.50 stddev:4.95 (3.6%) stddev-sans-first:5.05 15:06:12 INFO - PROCESS | 2215 | Values: 141.0 129.0 138.0 139.0 138.0 127.0 138.0 140.0 140.0 141.0 15:06:12 INFO - PROCESS | 2215 | 15:06:12 INFO - PROCESS | 2215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 15:06:12 INFO - PROCESS | 2215 | Values: 67.0 68.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 15:06:12 INFO - PROCESS | 2215 | -------- Summary: end -------- 15:06:12 INFO - PROCESS | 2215 | 15:06:13 INFO - TEST-INFO | 2215: exit 0 15:06:13 INFO - TEST-OK | kraken | took 56960ms 15:06:13 INFO - SUITE-END | took 1169s 15:06:13 INFO - Completed test suite (00:19:29) 15:06:13 INFO - javascript benchmark 15:06:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2805.4950108980383, 2929.7216764407376, 3401.2007178313092, 3425.09235052711, 3434.450487921933, 5415.268938693275, 5491.066518691822, 5511.9724401378035, 5538.723063846812, 5548.334199896013, 4580.450345958489, 5482.2873026506595, 5545.77816887325, 5675.404082571333, 5677.233573467581, 4993.325901003373, 5023.321851550048, 5032.144535428986, 5042.647014708972, 5198.636095473318, 4220.029393239557, 5108.64239503235, 5144.151215049513, 5162.509561591662, 5215.217717342391, 4963.3299504566785, 4981.551660350549, 5070.391553013662, 5073.771680274396, 5074.746262686869, 5043.218301163325, 5044.218146187347, 5079.593632509427, 5080.390353157608, 5099.776053747111, 4960.1567733485035, 5013.523715247045, 5018.5232402921665, 5032.094223039851, 5034.194528875399, 4313.266744653416, 5448.99999999996, 5471.37079235889, 5493.835184944458, 5582.078956972095, 6049.147457298247, 6061.360569285839, 6064.833730281331, 6067.2719273687, 6120.632762034248, 6177.444030037318, 6177.536684748662, 6181.845453863644, 6186.721597528122, 6201.286852011986, 5628.409017053233, 5645.915311270334, 5685.976524225638, 5749.8275051748515, 5753.51095156908, 6183.567150299526, 6189.0, 6213.875722485525, 6219.222597175353, 6248.125262463259, 5967.104934259809, 5983.880322393527, 5987.101934709828, 5989.850253743604, 6010.398960104042, 6008.519318454513, 6016.1878146450545, 6087.299960504599, 6096.481799047042, 6100.023996160593, 5954.374790647006, 5999.910001349983, 6011.218541589653, 6011.308699499614, 6024.548158888013, 6023.518118550505, 6047.244094488189, 6068.241469816273, 6104.898127493412, 6107.227034499227, 4799.208130658402, 4820.30105634681, 4830.758462076882, 4832.589229915427, 4851.417829860439, 4343.174796788663, 4351.456067991501, 4353.25994580922, 4366.126774645084, 4367.519572846984, 5226.719453733859, 5257.842264732064, 5493.450654934474, 5606.018946684314, 5608.327000759935, 6202.937970620236, 6205.007198848162, 6212.161358216673, 6215.875682486325, 6248.343923888017, 5547.750351234205, 5630.986422444, 5633.295838020247, 5640.915386269209, 5696.287964004499, 5203.7918483261, 5241.580673546107, 5275.5515781158265, 5308.46915308466, 5315.495027972336, 6212.81361559154, 6234.470070044006, 6235.033569796688, 6245.156903818108, 6246.968765156145, 6173.969130154321, 6186.381361863778, 6192.473639740492, 6196.504279657706, 6218.160548325918, 6117.583823141572, 6130.398136742091, 6202.317745048132, 6202.379762023762, 6212.658303793335, 5936.317323507852, 5998.904218757748, 6036.154938308729, 6044.879102418015, 6110.69446527663, 6043.456088952015, 6197.318294987457, 6197.752089916353, 6205.162303089025, 6231.1276421300145, 5178.430372658929, 5928.703564821828, 5953.732082056405, 6040.697965101639, 6067.605605635619, 5945.881082378415, 5947.137665038632, 5968.432998865101, 5973.940260597338, 5986.6707331097205, 5686.061799802987, 5819.0689489681445, 5837.970810145922, 5843.474087332161, 5870.9432302186015, 5882.764689412546, 5901.085331773582, 5930.822075337746, 5947.851303717442, 6031.668258245663, 5793.594448388572, 5818.214541036906, 5820.097884827858, 5862.149988251595, 5886.028805247258], "unit": "score", "name": "dojo.html", "value": 5552.258152562382}, {"lowerIsBetter": false, "replicates": [511.82342091978256, 514.8018013064969, 570.6832707847143, 646.3019938466457, 646.6411141816293, 24490.877545612268, 30392.392152156943, 30437.695623043764, 37209.813950930205, 38063.0, 40777.38833917493, 41126.17747645045, 41252.79373603128, 41371.37942930851, 41376.58623413765, 9608.279379046564, 9784.412935223909, 9785.804283914318, 9792.853107203398, 9799.461029643368, 9563.043695630451, 9733.075357840993, 9737.756556086119, 9740.318177727562, 9746.171575416063, 9797.853032204523, 9870.259730520203, 9877.950610246939, 9882.110610045094, 9882.654107106217, 9763.804723905518, 9843.261755368305, 9859.802803943952, 9861.950690246575, 9864.556094975744, 9686.70939871798, 9833.4099954003, 9845.212383009342, 9853.556589953469, 9879.06148915852, 39815.60184398148, 40133.59866401357, 40141.0, 40224.195516089516, 40309.19381612381, 3228.8547015384365, 3354.312365964996, 3441.500982357544, 3638.872639457606, 3823.1206822430718, 27972.720272797214, 29190.0, 29246.70753292461, 29248.70751292481, 29269.0, 2616.2151354593548, 2620.868956552165, 2773.88904443822, 2786.6934637189893, 2789.1632510246845, 460410.0, 463679.0, 463904.0, 464191.0, 466570.0, 60054.79890402168, 60506.697466512385, 60876.0, 60947.390526095056, 60991.390086098574, 64087.35912640907, 64118.67940660267, 64294.0, 64363.67818160973, 64464.0, 14676.339564719614, 16730.49808505747, 17128.486145415656, 17135.828641713422, 17153.82846171547, 13065.085444018827, 13107.541236056883, 13153.73692526144, 13156.40796164175, 13162.473501060042, 18227.36204232872, 18892.811071889104, 18958.95725735098, 19027.33404330842, 19039.904800476186, 7752.573608451589, 7928.0179955011245, 7957.641906114239, 8014.599270036475, 8045.235702608243, 921.4567792891668, 926.7451450850936, 1003.3377970539409, 1011.6206422591529, 1117.8602674665667, 27805.0, 28341.858290708413, 28486.470118098023, 28892.27769305784, 28962.0, 1048.3285425846136, 1061.984070238947, 1077.6120596585224, 1178.7053236690826, 1213.9939300303618, 14052.380595710723, 14232.359543820552, 14565.344559494848, 14611.415543378145, 14622.780658290134, 501102.0, 507220.0, 515096.0, 515211.0, 515407.0, 56373.0, 56490.87018259612, 56544.43455565474, 56636.43363566394, 56825.60156785099, 1344.287527610368, 1372.6911444924813, 1375.3192169875977, 1463.3707505772406, 1503.1056521369767, 24294.27117186487, 28814.0, 28923.0, 29078.854605726836, 29159.48028055655, 46090.308645369674, 46440.30339544977, 46478.53521464742, 46515.0, 46523.53476465192, 335149.0, 407901.96049019566, 409554.0, 410458.94770525955, 410590.0, 27699.446011079264, 28217.71782282233, 28259.0, 31081.378372431973, 31365.0, 36936.26127477382, 40941.91710412274, 41510.79244603758, 41574.792126039174, 42017.36973945332, 33842.830785845916, 34260.601757876706, 34579.65420345865, 34899.47650785291, 35327.823360883034, 34495.310093798485, 34812.47781283232, 35847.46228806622, 36090.63909360873, 36582.08544786402, 29147.0, 29573.039983245217, 31862.362752744353, 35637.0, 36095.27809443849, 29583.408331833674, 29645.110646680634, 29761.404771904006, 29832.0, 30453.0, 18635.254589816257, 22593.757343346275, 22948.885255573616, 23564.175253866033, 23728.762712373347], "unit": "score", "name": "ext.html", "value": 19121.502735459064}, {"lowerIsBetter": false, "replicates": [359.4267143905471, 360.51690734415877, 361.342356910423, 367.86389036056664, 374.6029209038418, 18791.154398052087, 19310.710339344903, 20106.296279630216, 20125.396238112862, 20140.295089671865, 18440.893546387226, 19090.904545477253, 19091.809081909178, 19142.808571914276, 19271.325503607375, 5668.886622267552, 5967.104934259853, 6013.969930150343, 6014.3985601439945, 6017.638941663492, 5678.063119585264, 5850.941490585104, 5969.791057312995, 5983.491403230731, 5987.9101813472835, 5848.181254624356, 5865.794697185599, 5871.119332100197, 5877.324107727602, 5881.705914704247, 5613.4386561343945, 5811.217673917804, 5822.97088514559, 5862.413758624146, 5879.88240235195, 5005.2492126181, 5058.342415486, 5058.392992840846, 5061.038402703474, 5076.64463487556, 25913.352166195808, 28085.29786755327, 29036.27409314763, 29490.672919718665, 29651.70348296511, 2189.2228258968157, 2236.8322375821876, 2335.1142683739677, 2367.9936027188546, 2684.570468725014, 14972.326245318987, 15428.614284642974, 15493.302801373966, 15665.765013524806, 16151.596210094724, 1759.0676941221172, 1812.3566134022365, 1845.7877344105466, 1859.460756380648, 1879.4925370149983, 106589.93410065878, 113770.86229137603, 113865.0, 114081.0, 114659.42670286678, 14548.636284092983, 14697.0, 18256.809182897872, 18358.0, 18361.80648257859, 22917.54164916726, 28562.428751424854, 28585.285367865552, 28620.28449288743, 28673.85304587835, 10357.378557286436, 10711.78576428467, 10760.246782725291, 10764.138868890626, 10847.294925829796, 9010.640930462756, 9146.131117543822, 9176.724698259062, 9244.0, 9268.814623707623, 7200.603966781772, 7418.479211761576, 8328.25106727594, 8495.66017359311, 8561.82876342482, 2639.0734763622663, 2857.971420285812, 3341.715954143925, 3451.913702157466, 3467.393206188907, 768.4006474949437, 911.8814554107923, 966.4877614864133, 972.6401231544232, 1035.53400969564, 17570.736438953427, 18764.0617969101, 19606.215751369786, 20479.4880127998, 20847.687284690743, 888.1985103755935, 937.7374335186022, 940.1632547033146, 984.7587341101475, 984.8424252119627, 10345.327553708985, 10693.9465302673, 10973.890261097447, 10976.12191024716, 11010.944945275221, 622403.0, 629042.0, 636214.0, 637639.0, 642846.0, 107290.0, 109439.0, 109708.4514577422, 109937.45031274793, 110856.4457177709, 1011.2870426349406, 1020.132887046005, 1041.739565108723, 1042.1766804224728, 1044.5404022230193, 14751.483698070517, 17439.389621363192, 17484.300627975248, 17710.468685939442, 18226.45320640383, 29473.60022340564, 30098.69901300959, 47702.0, 49688.0, 50562.49437505578, 63348.68325658342, 63928.0, 66053.0, 67060.6646966762, 67106.99339509814, 6655.301193374626, 7812.079198045076, 7832.686692532235, 7894.526328420084, 8034.276915077671, 9259.629614815332, 11801.704957376134, 12074.45664945062, 12684.682882928, 12723.300218488072, 10084.84872726895, 10601.787964240826, 10945.507452164831, 11058.336499810037, 11339.206255562032, 5238.926020165933, 7389.593572353572, 11131.165162612675, 11140.498677559692, 11384.430778460877, 10902.945485272523, 11078.446077695922, 11341.886581134413, 11435.199536032398, 11624.18630695877, 7744.917928032288, 7836.92163078362, 7912.0505539335645, 8117.959410202911, 8174.264316211569, 10354.430506321924, 10504.369737815756, 10864.076553492725, 10912.781744365227, 11072.557097716324], "unit": "score", "name": "jquery.html", "value": 10022.333984834966}, {"lowerIsBetter": false, "replicates": [1389.2012093046499, 1435.6410897275682, 1604.382312809568, 1834.1746214203604, 2015.546502037041, 7868.17384174662, 8057.556834374107, 8059.314958228543, 8065.717699880505, 8090.676372945082, 8271.172882711726, 8564.74305770828, 8577.185167409101, 8580.356473264499, 8622.180892815188, 2418.141559746291, 2484.3168128764646, 2490.091116742385, 2492.028109037477, 2492.3021553964827, 2147.2699282244034, 2193.8135258502966, 2194.3197608741343, 2427.890744916483, 2495.6381324707904, 2189.255653077953, 2225.4881377283236, 2379.845310054841, 2465.8767061646936, 2467.617519284514, 2383.5947888858936, 2421.8546887186735, 2428.259380888828, 2430.1858877276136, 2432.1487479382163, 2413.710354757423, 2415.0581273303424, 2416.0, 2418.3470462975074, 2427.8421902576274, 8496.447730897471, 8504.064552899175, 8557.957210213972, 8576.742697719079, 8580.656773729042, 5304.469553044703, 5324.1747529133045, 5407.783688652449, 5514.834554963358, 5525.778968841241, 3057.785954983152, 3559.857605695769, 3651.1967367179177, 3663.7435379523445, 3688.5758137814228, 1041.9322744021615, 1043.4521876015076, 1067.8985496377832, 1072.1583556907867, 1076.6931424544046, 11580.420978951019, 11602.129840262014, 11604.535818567247, 11607.76784464306, 11615.767684646344, 4711.465882573494, 4827.831025914076, 4861.9027619447415, 4886.462489126193, 4889.926651100236, 9900.207983361313, 9973.900260997443, 9986.650467233612, 9992.200623950066, 9997.650082247086, 5353.678779273256, 5359.008583412004, 5475.233467314579, 5493.423190565013, 5499.395066542677, 4789.760511974388, 4859.708417494961, 4952.232403977389, 4960.851174464772, 4990.750462476934, 3832.4826148470156, 3851.2105018471148, 3885.55316138642, 3905.6680182184264, 3911.4328422379167, 1219.3171823778712, 1289.0589869395394, 1308.6793735534663, 1316.9192675572572, 1321.9405126769318, 973.3284034016506, 987.5753426026733, 1015.8679371681634, 1018.0582960761415, 1374.0, 7848.725294614661, 7886.763397098096, 7894.486858354188, 7938.126806051329, 7940.6029698515995, 1163.5229555882217, 1179.2747460312019, 1181.527389044389, 1191.0531127753457, 1203.1157099531838, 6130.63216207029, 6207.286162091327, 6264.624122552661, 6291.937080629226, 6298.0, 10268.281220314655, 10639.840402393971, 10661.360318380923, 10672.306300090624, 10685.83971240432, 10146.086852183338, 10427.530761115768, 10446.268761186797, 10492.422916739653, 10507.054365107177, 8100.311473524698, 8246.752597421966, 8298.460600060977, 8303.418760686694, 8314.251717345467, 7613.162552119373, 7770.728024519115, 7797.961010195139, 7826.491278066907, 7856.764297071097, 9182.95408522953, 9447.480388578419, 9452.810943780949, 9535.952320238632, 9550.808983820423, 8232.34141268685, 9652.889917659559, 9872.802543949225, 9976.0, 9996.350237234556, 7444.516106453063, 7472.775816725507, 7503.324700776956, 7543.7736867894055, 7570.9242907570215, 8122.675092996214, 8168.591570421337, 8204.220599043081, 8213.83572328562, 8223.424360294723, 6044.667543285162, 7215.134183897966, 7386.187519372972, 7468.2158373372185, 7511.699532018876, 7077.752278670222, 7155.069840920647, 7174.928250717426, 7194.89207661875, 7201.567905925661, 7509.324160825552, 7610.657520411484, 7611.3530349920875, 7621.885671715039, 7680.231976802275, 6826.863462730618, 6908.689108990007, 6919.930800691928, 6931.0, 6951.478639102189, 6828.624425656438, 7008.334208250208, 7029.718811247493, 7053.188883278489, 7053.4004609608755], "unit": "score", "name": "mootools.html", "value": 4860.393890049323}, {"lowerIsBetter": false, "replicates": [322.64186752704495, 326.4874147588286, 331.3174859788835, 331.83242462556404, 337.64547225413327, 6360.236771587411, 6373.362663733625, 6387.265464471587, 6396.936030639698, 6440.484761219103, 6313.463355614766, 6316.589421687599, 6324.2727086385075, 6333.936660633392, 6349.174607301056, 4489.910201795962, 4577.038821847416, 4584.724916505021, 4626.097910907374, 4735.289706544011, 3880.9805950970203, 4670.299455081731, 4684.672072954894, 4691.577758001779, 4721.527847215285, 4672.602828759559, 4681.672282940195, 4681.859544213679, 4682.41469816273, 4714.599259062984, 4435.334699795057, 4527.592516673482, 4675.8363457279, 4675.976620116911, 4682.438107427097, 4009.0779120802085, 4028.637422631977, 4033.6773058155572, 4041.858534951292, 4048.7570745755056, 6114.174586430864, 6175.042868355367, 6278.968605156945, 6285.4343109119945, 6299.874002519924, 5497.175423686439, 5505.972470137664, 5514.035043867307, 5516.117421212587, 5532.838103998165, 5943.970280148615, 6379.808605741835, 6737.797866064026, 6766.424853887425, 6772.932270677279, 4382.8904277393, 4560.566746159143, 4563.178627846986, 4564.360989461478, 4582.885427864297, 7085.504014718972, 7138.321859423347, 7145.928540714578, 7155.320244576809, 7156.069710937597, 3891.8248678809523, 4619.445666520039, 4627.236505976543, 4630.69900456476, 4648.140094082605, 4193.832246710159, 4442.244818380883, 4711.0342379812055, 4713.717176969393, 4726.432828060655, 5480.424555421703, 5493.09363954943, 5508.944910550923, 5514.448555144453, 5514.696691681996, 5500.477454641803, 6525.347465253437, 6743.0, 6768.120144381199, 6821.113255276782, 1616.4827255278199, 1632.208378936215, 1643.909584972838, 1651.5210588929076, 1663.193351224655, 885.9557022148866, 908.5911339897073, 1006.1196453103535, 1071.4214324264965, 1090.9799337619352, 6099.603525770811, 6304.085907543381, 6410.1987251593555, 6429.357064293533, 6429.38920802523, 7062.540934839321, 7071.0, 7081.008658787774, 7081.964590177016, 7105.822354441077, 6386.393292637192, 6396.168498095218, 6401.391867772554, 6410.55126141175, 6420.582662126947, 3687.2625474905126, 3738.140227747633, 3745.232227393378, 3749.7562658427114, 3750.7562008469363, 6966.686499107553, 6975.511714179958, 7419.629018549051, 7430.405567554582, 7444.367228785614, 7264.491485596063, 7314.451416143704, 7314.670839812221, 7318.194998550155, 7325.2674732527385, 7401.555906645618, 7413.221611730691, 7420.035395398563, 7424.1462231844025, 7427.405807535384, 5827.329857066322, 7068.964655176691, 7074.71701131949, 7081.256468070778, 7088.468364872759, 6751.56114852533, 7037.1555413350725, 7038.577685338896, 7050.189228238818, 7071.7878463646175, 6126.448619624255, 7385.150707668687, 7398.408127349691, 7491.9625401872645, 7505.812354691177, 3840.462335273008, 4535.727856328631, 4557.293619488984, 4566.954330456786, 4568.70303430276, 6565.868682626417, 7089.220185779664, 7099.574025558483, 7127.073480447509, 7130.2869713028285, 6205.410486003822, 6520.413162815369, 6781.220159681699, 6837.145356830396, 6847.520673552804, 6778.017187507685, 6845.041694162921, 6856.41720453767, 6856.554323968926, 6869.553479023847, 5135.589152867687, 6681.198256209286, 6689.163854518185, 6699.799006029827, 6703.29615390377, 6065.999110146953, 6376.362363763772, 6816.147981502312, 6829.52193346461, 6836.623985680636, 5321.893562128813, 6429.54993150475, 6465.870682586416, 6572.934270657423, 6669.4664426844765], "unit": "score", "name": "prototype.html", "value": 4963.299246676447}, {"lowerIsBetter": false, "replicates": [622.7384498510626, 636.4908073541169, 724.6159535446212, 724.6304384763769, 764.3006648916241, 11678.532858685643, 14824.481143159992, 14826.0, 14842.55472335829, 14844.92577537112, 15664.608384790386, 15969.520914372559, 15973.920130399332, 15974.0, 15986.440474583364, 760.3954855889581, 772.6638912073238, 929.4191130543394, 949.292776881221, 955.9808803823919, 811.427943299975, 820.979475513111, 823.2467292427422, 830.6137645994611, 830.887830142929, 988.7478692933328, 999.4552968632113, 1001.43919405133, 1001.5893483671696, 1002.8846682631481, 789.8973133492638, 803.995980020102, 809.3363441977581, 994.2245048861863, 995.5271246158089, 734.5005396330494, 743.6765007221876, 744.5867543513348, 745.5154149802618, 746.1941103608144, 15211.0, 15268.541943741706, 15284.0, 15310.234488275653, 15436.845631543652, 12317.507299708, 12363.320017399039, 12636.81044784329, 12735.0, 12914.0, 8074.959625201836, 9389.812203755955, 9499.952500237523, 9792.90207097927, 9838.262130340254, 3305.5372247885316, 3473.513708080871, 3536.6993805526563, 3558.804265765382, 3575.2313252650547, 81018.0, 81270.59364703139, 81365.59317203435, 81375.59312203461, 81417.0, 9532.571034303473, 9582.808343833085, 9587.472689002172, 9642.903570964201, 9814.263930205121, 22201.44496387603, 22309.55380892373, 22314.776852231593, 22322.107115715513, 22339.77660223377, 7349.816254593571, 7449.068866391701, 7454.515456495419, 7525.2098529654695, 7586.848263034708, 4026.697997650188, 4059.106996460774, 4083.571225021389, 4125.092479654471, 4374.12517496502, 3583.587887392931, 3625.927481450356, 3631.1648320886343, 3636.872709455209, 3637.490751294768, 567.9294529811253, 588.8910551547978, 593.1073734030343, 687.6905392573262, 716.5915428205873, 516.2333934107846, 550.6255746092615, 594.7769586405099, 612.461034289831, 626.6647343671114, 8405.453645513144, 8643.740687779376, 8655.48067115975, 8760.518171500502, 8825.249853762502, 562.1960596347182, 572.3544808675059, 579.492943674285, 597.5160120302569, 628.4532456762646, 3735.4210097434943, 3901.726879118491, 3911.5501717302873, 3938.5667576566557, 3955.627570734139, 86911.13088869156, 88130.11869881219, 89653.0, 89942.55028724814, 89984.5500772492, 57198.7140064297, 74363.0, 75897.0, 76890.0, 78435.0, 66150.00774988379, 66943.0, 68179.65910170418, 69022.65488672524, 69181.61636767237, 7771.455998080306, 7806.0632724073475, 7806.375489960676, 7811.96094019549, 8006.039275287003, 45329.86675333143, 45436.0, 45681.771591141835, 45863.77068114638, 46362.76818615885, 48607.75696121497, 60926.69536652289, 61633.767324652355, 63086.68456657687, 63165.68417157885, 10127.493625318852, 10150.289479736643, 10212.489375531342, 10291.485425728833, 10599.046085852311, 11152.63178929703, 11178.27341222818, 11257.21199516026, 11343.262687925588, 11603.6518904433, 10474.162067034771, 10748.247622666338, 10818.783624327627, 10827.458627068772, 10828.079613232963, 10358.274920755475, 10433.0, 10487.423191724529, 10802.0, 10841.0, 7500.924990750241, 10604.522796474022, 10620.15038796879, 10643.935606439294, 10662.73343166427, 8925.509096999467, 9023.864642030243, 9216.723498295061, 9280.72157835266, 9308.813823723623, 7985.960070199611, 8358.723141565635, 8609.82780344402, 9000.774980625536, 9098.727038188865], "unit": "score", "name": "yui.html", "value": 6729.509952639717}], "name": "dromaeo_css", "value": 7462.833138585009}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 112.0, 111.0, 112.0, 109.0, 117.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 142.0, 143.0, 138.0, 175.0, 168.0, 124.0, 163.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 186.0, 185.0, 187.0, 185.0, 185.0, 183.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 85.0, 80.0, 56.0, 58.0, 57.0, 79.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 130.0, 81.0, 78.0, 85.0, 120.0, 79.0, 81.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 95.9}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 84.0, 88.0, 84.0, 123.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.1}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 93.0, 94.0, 93.0, 92.0, 92.0, 92.0, 93.0, 115.0], "unit": "score", "name": "imaging-darkroom", "value": 94.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 85.0, 88.0, 86.0, 85.0, 86.0, 86.0, 83.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 56.0, 52.0, 53.0, 75.0, 77.0, 91.0, 77.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 77.0, 71.0, 69.0, 68.0, 69.0, 69.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [132.0, 134.0, 124.0, 126.0, 121.0, 126.0, 122.0, 125.0, 133.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [141.0, 129.0, 138.0, 139.0, 138.0, 127.0, 138.0, 140.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1428.1000000000001}]} 15:06:13 INFO - Return code: 0 15:06:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:06:13 ERROR - # TBPL SUCCESS # 15:06:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:06:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:06:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:06:13 INFO - 2016-03-31 15:06:13.881 screenresolution[2219:18688] starting screenresolution argv=screenresolution get 15:06:13 INFO - 2016-03-31 15:06:13.883 screenresolution[2219:18688] Display 0: 1600x1200x32@60 15:06:13 INFO - 2016-03-31 15:06:13.889 screenresolution[2220:18691] starting screenresolution argv=screenresolution list 15:06:13 INFO - Available Modes on Display 0 15:06:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:06:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:06:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:06:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:06:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:06:14 INFO - Intel Iris: 15:06:14 INFO - Chipset Model: Intel Iris 15:06:14 INFO - Type: GPU 15:06:14 INFO - Bus: Built-In 15:06:14 INFO - VRAM (Dynamic, Max): 1536 MB 15:06:14 INFO - Vendor: Intel (0x8086) 15:06:14 INFO - Device ID: 0x0a2e 15:06:14 INFO - Revision ID: 0x0009 15:06:14 INFO - Displays: 15:06:14 INFO - Display: 15:06:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:06:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:06:14 INFO - Display Serial Number: 1600x1200 60 15:06:14 INFO - Main Display: Yes 15:06:14 INFO - Mirror: Off 15:06:14 INFO - Online: Yes 15:06:14 INFO - Rotation: Supported 15:06:14 INFO - Return code: 0 15:06:14 INFO - Running post-action listener: _resource_record_post_action 15:06:14 INFO - Running post-run listener: _resource_record_post_run 15:06:15 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 2449408; Write bytes: 705863680; Read time: 40; Write time: 2245 15:06:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403182080; Write bytes: 406116352; Read time: 30264; Write time: 743 15:06:15 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 2449408; Write bytes: 298899456; Read time: 40; Write time: 1500 15:06:15 INFO - Running post-run listener: _upload_blobber_files 15:06:15 INFO - Blob upload gear active. 15:06:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:06:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:06:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:06:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:16 INFO - (blobuploader) - INFO - Done attempting. 15:06:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:06:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:17 INFO - (blobuploader) - INFO - Done attempting. 15:06:17 INFO - (blobuploader) - INFO - Iteration through files over. 15:06:17 INFO - Return code: 0 15:06:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:06:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:06:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09ac353440dea60e8da2c634ce13413ea335f6ef46d201edfe93b31f646d03fbdde53c642eb53b52ed2b5b2c88d3886cc7de7c61627aa23cf06502ba91de11c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/113a7c6d3c744a2088f46c2020989f5d7fd61ade8c534a797f133096fa84ff88d91294b1b6e2ad7131b6483b16894d5afc02ff8a63129c2c343437657640f09d"} 15:06:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:06:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:06:17 INFO - Contents: 15:06:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09ac353440dea60e8da2c634ce13413ea335f6ef46d201edfe93b31f646d03fbdde53c642eb53b52ed2b5b2c88d3886cc7de7c61627aa23cf06502ba91de11c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/113a7c6d3c744a2088f46c2020989f5d7fd61ade8c534a797f133096fa84ff88d91294b1b6e2ad7131b6483b16894d5afc02ff8a63129c2c343437657640f09d"} 15:06:17 INFO - Running post-run listener: copy_logs_to_upload_dir 15:06:17 INFO - Copying logs to upload dir... 15:06:17 INFO - mkdir: /builds/slave/test/build/upload/logs 15:06:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.107675 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-31 15:06:17.614407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:17.619217) ========= 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.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/Firefox/sha512/09ac353440dea60e8da2c634ce13413ea335f6ef46d201edfe93b31f646d03fbdde53c642eb53b52ed2b5b2c88d3886cc7de7c61627aa23cf06502ba91de11c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/113a7c6d3c744a2088f46c2020989f5d7fd61ade8c534a797f133096fa84ff88d91294b1b6e2ad7131b6483b16894d5afc02ff8a63129c2c343437657640f09d"} build_url:https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/Ld_SNaf3QDGJODy6smfLLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09ac353440dea60e8da2c634ce13413ea335f6ef46d201edfe93b31f646d03fbdde53c642eb53b52ed2b5b2c88d3886cc7de7c61627aa23cf06502ba91de11c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/113a7c6d3c744a2088f46c2020989f5d7fd61ade8c534a797f133096fa84ff88d91294b1b6e2ad7131b6483b16894d5afc02ff8a63129c2c343437657640f09d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:17.650404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:17.650696) ========= 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.LtuItADJ14/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.W5RWD4Pw4p/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005623 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:17.699464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 15:06:17.699747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 15:06:17.700090) ========= ========= Total master_lag: 0.68 =========