builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0188 starttime: 1457574145.1 results: success (0) buildid: 20160309154625 builduid: eeb220edee3c4fa78e4ddb5f0a0f644d revision: 26e576786f9dbf101119be083c2743803e9ced5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.105222) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.105645) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.105946) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005477 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.134179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.134490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.151718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.152016) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005519 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.200739) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.201049) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.201395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.201667) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-09 17:42:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2016-03-09 17:42:25 (14.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.350119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.350437) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.026703 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:25.398500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 17:42:25.398879) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26e576786f9dbf101119be083c2743803e9ced5f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 26e576786f9dbf101119be083c2743803e9ced5f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-09 17:42:25,475 truncating revision to first 12 chars 2016-03-09 17:42:25,475 Setting DEBUG logging. 2016-03-09 17:42:25,475 attempt 1/10 2016-03-09 17:42:25,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26e576786f9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 17:42:26,704 unpacking tar archive at: fx-team-26e576786f9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.477216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 17:42:26.893101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:26.893527) ========= echo 26e576786f9dbf101119be083c2743803e9ced5f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'26e576786f9dbf101119be083c2743803e9ced5f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 26e576786f9dbf101119be083c2743803e9ced5f program finished with exit code 0 elapsedTime=0.005261 script_repo_revision: '26e576786f9dbf101119be083c2743803e9ced5f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:26.944554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:26.944922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 17:42:26.959112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-03-09 17:42:26.959515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:42:27 INFO - MultiFileLogger online at 20160309 17:42:27 in /builds/slave/test 17:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:27 INFO - {'append_to_log': False, 17:42:27 INFO - 'base_work_dir': '/builds/slave/test', 17:42:27 INFO - 'blob_upload_branch': 'Fx-Team', 17:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:27 INFO - 'branch': 'Fx-Team', 17:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:27 INFO - 'config_files': ('talos/mac_config.py',), 17:42:27 INFO - 'default_actions': ('clobber', 17:42:27 INFO - 'read-buildbot-config', 17:42:27 INFO - 'download-and-extract', 17:42:27 INFO - 'populate-webroot', 17:42:27 INFO - 'create-virtualenv', 17:42:27 INFO - 'install', 17:42:27 INFO - 'run-tests'), 17:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:27 INFO - 'download_minidump_stackwalk': True, 17:42:27 INFO - 'download_symbols': 'ondemand', 17:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:27 INFO - 'installer_path': 'installer.exe', 17:42:27 INFO - 'log_level': 'info', 17:42:27 INFO - 'log_name': 'talos', 17:42:27 INFO - 'log_to_console': True, 17:42:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:42:27 INFO - 'opt_config_files': (), 17:42:27 INFO - 'pip_index': False, 17:42:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:27 INFO - 'cmd': ('bash', 17:42:27 INFO - '-c', 17:42:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:27 INFO - 'enabled': True, 17:42:27 INFO - 'halt_on_failure': False, 17:42:27 INFO - 'name': 'check_screen_resolution'},), 17:42:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:27 INFO - 'cmd': ('bash', 17:42:27 INFO - '-c', 17:42:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:27 INFO - 'enabled': True, 17:42:27 INFO - 'halt_on_failure': False, 17:42:27 INFO - 'name': 'check_screen_resolution'},), 17:42:27 INFO - 'run_cmd_checks_enabled': True, 17:42:27 INFO - 'sps_profile': False, 17:42:27 INFO - 'sps_profile_interval': 0, 17:42:27 INFO - 'suite': 'dromaeojs', 17:42:27 INFO - 'system_bits': '32', 17:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:27 INFO - 'title': 't-yosemite-r7-0188', 17:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:27 INFO - 'use_talos_json': True, 17:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:27 INFO - 'work_dir': 'build'} 17:42:27 INFO - ##### 17:42:27 INFO - ##### Running clobber step. 17:42:27 INFO - ##### 17:42:27 INFO - Running pre-action listener: _resource_record_pre_action 17:42:27 INFO - Running main action method: clobber 17:42:27 INFO - rmtree: /builds/slave/test/build 17:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:28 INFO - Running post-action listener: _resource_record_post_action 17:42:28 INFO - ##### 17:42:28 INFO - ##### Running read-buildbot-config step. 17:42:28 INFO - ##### 17:42:28 INFO - Running pre-action listener: _resource_record_pre_action 17:42:28 INFO - Running main action method: read_buildbot_config 17:42:28 INFO - Using buildbot properties: 17:42:28 INFO - { 17:42:28 INFO - "project": "", 17:42:28 INFO - "product": "firefox", 17:42:28 INFO - "script_repo_revision": "production", 17:42:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:42:28 INFO - "repository": "", 17:42:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:42:28 INFO - "buildid": "20160309154625", 17:42:28 INFO - "pgo_build": "False", 17:42:28 INFO - "basedir": "/builds/slave/test", 17:42:28 INFO - "buildnumber": 480, 17:42:28 INFO - "slavename": "t-yosemite-r7-0188", 17:42:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:42:28 INFO - "platform": "yosemite_r7", 17:42:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:42:28 INFO - "branch": "fx-team", 17:42:28 INFO - "repo_path": "integration/fx-team", 17:42:28 INFO - "revision": "26e576786f9dbf101119be083c2743803e9ced5f", 17:42:28 INFO - "stage_platform": "macosx64", 17:42:28 INFO - "builduid": "eeb220edee3c4fa78e4ddb5f0a0f644d", 17:42:28 INFO - "slavebuilddir": "test" 17:42:28 INFO - } 17:42:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:42:28 INFO - Running post-action listener: _resource_record_post_action 17:42:28 INFO - ##### 17:42:28 INFO - ##### Running download-and-extract step. 17:42:28 INFO - ##### 17:42:28 INFO - Running pre-action listener: _resource_record_pre_action 17:42:28 INFO - Running main action method: download_and_extract 17:42:28 INFO - mkdir: /builds/slave/test/build/tests 17:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:28 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:29 INFO - Downloaded 1199 bytes. 17:42:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:42:29 INFO - Using the following test package requirements: 17:42:29 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:42:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:42:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:42:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'jsshell-mac.zip'], 17:42:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:42:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:42:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:42:29 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:42:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:42:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:42:29 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:42:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:29 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:30 INFO - Downloaded 17866293 bytes. 17:42:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:42:34 INFO - Return code: 0 17:42:34 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 17:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:34 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:35 INFO - Downloaded 17866293 bytes. 17:42:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:42:38 INFO - Return code: 0 17:42: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')]} 17:42:38 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:42:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:42:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:42:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:40 INFO - Downloaded 10845161 bytes. 17:42:40 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'] 17:42:40 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 17:42:40 INFO - Return code: 0 17:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:40 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:42:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:42:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:42:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:42:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 17:42:43 INFO - Downloaded 110926064 bytes. 17:42:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:42:43 INFO - mkdir: /builds/slave/test/properties 17:42:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:43 INFO - Contents: 17:42:43 INFO - build_url:https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:42:44 INFO - Running post-action listener: _resource_record_post_action 17:42:44 INFO - Running post-action listener: set_extra_try_arguments 17:42:44 INFO - ##### 17:42:44 INFO - ##### Running populate-webroot step. 17:42:44 INFO - ##### 17:42:44 INFO - Running pre-action listener: _resource_record_pre_action 17:42:44 INFO - Running main action method: populate_webroot 17:42:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:44 INFO - '--tppagecycles', 17:42:44 INFO - '7'], 17:42:44 INFO - 'tests': ['tsvgm']}}, 17:42:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:42:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:42:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'tests': ['damp', 'tps']}, 17:42:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['damp', 'tps']}, 17:42:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:42:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:44 INFO - 'other': {'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'other_l64': {'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'other_nol64': {'tests': ['a11yr', 17:42:44 INFO - 'ts_paint', 17:42:44 INFO - 'tpaint', 17:42:44 INFO - 'sessionrestore', 17:42:44 INFO - 'sessionrestore_no_auto_restore', 17:42:44 INFO - 'tabpaint']}, 17:42:44 INFO - 'svgr': {'tests': ['tsvgx', 17:42:44 INFO - 'tsvgr_opacity', 17:42:44 INFO - 'tart', 17:42:44 INFO - 'tscrollx', 17:42:44 INFO - 'cart']}, 17:42:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['tsvgx', 17:42:44 INFO - 'tsvgr_opacity', 17:42:44 INFO - 'tart', 17:42:44 INFO - 'tscrollx', 17:42:44 INFO - 'cart']}, 17:42:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'tests': ['tp5o']}, 17:42:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'talos_options': ['--e10s'], 17:42:44 INFO - 'tests': ['tp5o']}, 17:42:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'talos_options': ['--xperf_path', 17:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:44 INFO - 'tests': ['tp5n']}, 17:42:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:44 INFO - 'talos_options': ['--e10s', 17:42:44 INFO - '--xperf_path', 17:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:44 INFO - 'tests': ['tp5n']}}, 17:42:44 INFO - 'talos.zip': {'path': '', 17:42:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:44 INFO - Running post-action listener: _resource_record_post_action 17:42:44 INFO - ##### 17:42:44 INFO - ##### Running create-virtualenv step. 17:42:44 INFO - ##### 17:42:44 INFO - Running pre-action listener: _resource_record_pre_action 17:42:44 INFO - Running main action method: create_virtualenv 17:42:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:42:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:44 INFO - Using real prefix '/tools/python27' 17:42:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:48 INFO - Installing pip.................done. 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:48 INFO - 'HOME': '/Users/cltbld', 17:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PAGER': '/bin/cat', 17:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:42:48 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - 'XPC_FLAGS': '0x0', 17:42:48 INFO - 'XPC_SERVICE_NAME': '0', 17:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:42:48 INFO - Cleaning up... 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:48 INFO - 'HOME': '/Users/cltbld', 17:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PAGER': '/bin/cat', 17:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:42:48 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - 'XPC_FLAGS': '0x0', 17:42:48 INFO - 'XPC_SERVICE_NAME': '0', 17:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:48 INFO - Downloading/unpacking psutil>=0.7.1 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:51 INFO - Installing collected packages: psutil 17:42:51 INFO - Running setup.py install for psutil 17:42:51 INFO - building 'psutil._psutil_osx' extension 17:42:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:42:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:42:52 INFO - building 'psutil._psutil_posix' extension 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:42:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:42:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:42:52 INFO - ^ 17:42:52 INFO - 1 warning generated. 17:42:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:52 INFO - Successfully installed psutil 17:42:52 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:52 INFO - 'HOME': '/Users/cltbld', 17:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:52 INFO - 'LOGNAME': 'cltbld', 17:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:52 INFO - 'MOZ_NO_REMOTE': '1', 17:42:52 INFO - 'NO_EM_RESTART': '1', 17:42:52 INFO - 'PAGER': '/bin/cat', 17:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:52 INFO - 'PWD': '/builds/slave/test', 17:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:52 INFO - 'SHELL': '/bin/bash', 17:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:42:52 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:52 INFO - 'USER': 'cltbld', 17:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:52 INFO - 'XPC_FLAGS': '0x0', 17:42:52 INFO - 'XPC_SERVICE_NAME': '0', 17:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:42:55 INFO - Installing collected packages: mozsystemmonitor 17:42:55 INFO - Running setup.py install for mozsystemmonitor 17:42:55 INFO - Successfully installed mozsystemmonitor 17:42:55 INFO - Cleaning up... 17:42:55 INFO - Return code: 0 17:42:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:55 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:55 INFO - 'HOME': '/Users/cltbld', 17:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:55 INFO - 'LOGNAME': 'cltbld', 17:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:55 INFO - 'MOZ_NO_REMOTE': '1', 17:42:55 INFO - 'NO_EM_RESTART': '1', 17:42:55 INFO - 'PAGER': '/bin/cat', 17:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:55 INFO - 'PWD': '/builds/slave/test', 17:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:55 INFO - 'SHELL': '/bin/bash', 17:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:42:55 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:55 INFO - 'USER': 'cltbld', 17:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:55 INFO - 'XPC_FLAGS': '0x0', 17:42:55 INFO - 'XPC_SERVICE_NAME': '0', 17:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:59 INFO - Downloading docopt-0.6.1.tar.gz 17:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:59 INFO - Running setup.py install for blobuploader 17:42:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:59 INFO - Running setup.py install for requests 17:43:00 INFO - Running setup.py install for docopt 17:43:00 INFO - Successfully installed blobuploader requests docopt 17:43:00 INFO - Cleaning up... 17:43:00 INFO - Return code: 0 17:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:00 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:00 INFO - 'HOME': '/Users/cltbld', 17:43:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:00 INFO - 'LOGNAME': 'cltbld', 17:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:00 INFO - 'MOZ_NO_REMOTE': '1', 17:43:00 INFO - 'NO_EM_RESTART': '1', 17:43:00 INFO - 'PAGER': '/bin/cat', 17:43:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:00 INFO - 'PWD': '/builds/slave/test', 17:43:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:00 INFO - 'SHELL': '/bin/bash', 17:43:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:00 INFO - 'USER': 'cltbld', 17:43:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:00 INFO - 'XPC_FLAGS': '0x0', 17:43:00 INFO - 'XPC_SERVICE_NAME': '0', 17:43:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:00 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-vApz2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:00 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-GCTgkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:00 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-TDLBTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-GTYcB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-CvOgVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-yASfHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-slY0lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-EhP4SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-TA17xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-NllJVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kur_MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-A3Qhs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:01 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-DXUdX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-J0gCHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-G51xB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-8DdEWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:02 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-dGDZBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:02 INFO - Running setup.py install for manifestparser 17:43:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:02 INFO - Running setup.py install for mozcrash 17:43:02 INFO - Running setup.py install for mozdebug 17:43:02 INFO - Running setup.py install for mozdevice 17:43:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Running setup.py install for mozfile 17:43:03 INFO - Running setup.py install for mozhttpd 17:43:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Running setup.py install for mozinfo 17:43:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Running setup.py install for mozInstall 17:43:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Running setup.py install for mozleak 17:43:03 INFO - Running setup.py install for mozlog 17:43:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:03 INFO - Running setup.py install for moznetwork 17:43:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:04 INFO - Running setup.py install for mozprocess 17:43:04 INFO - Running setup.py install for mozprofile 17:43:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:04 INFO - Running setup.py install for mozrunner 17:43:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:04 INFO - Running setup.py install for mozscreenshot 17:43:04 INFO - Running setup.py install for moztest 17:43:04 INFO - Running setup.py install for mozversion 17:43:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:05 INFO - Cleaning up... 17:43:05 INFO - Return code: 0 17:43:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:05 INFO - 'HOME': '/Users/cltbld', 17:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:05 INFO - 'LOGNAME': 'cltbld', 17:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:05 INFO - 'MOZ_NO_REMOTE': '1', 17:43:05 INFO - 'NO_EM_RESTART': '1', 17:43:05 INFO - 'PAGER': '/bin/cat', 17:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:05 INFO - 'PWD': '/builds/slave/test', 17:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:05 INFO - 'SHELL': '/bin/bash', 17:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:05 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:05 INFO - 'USER': 'cltbld', 17:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:05 INFO - 'XPC_FLAGS': '0x0', 17:43:05 INFO - 'XPC_SERVICE_NAME': '0', 17:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-VDgDUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-jRwiqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-N0OUv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gHt7c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-92C2bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-CEPDJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:05 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-D7HSAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-FcCF7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-cvdJcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-M8i9rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-uIMSII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-GmlpWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-m9ECOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-89J_Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gsMN1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:06 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5U1Nnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:07 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-8pvEvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:09 INFO - Downloading blessings-1.6.tar.gz 17:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:09 INFO - Installing collected packages: blessings 17:43:09 INFO - Running setup.py install for blessings 17:43:09 INFO - Successfully installed blessings 17:43:09 INFO - Cleaning up... 17:43:09 INFO - Return code: 0 17:43:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:10 INFO - Reading from file tmpfile_stdout 17:43:10 INFO - Current package versions: 17:43:10 INFO - blessings == 1.6 17:43:10 INFO - blobuploader == 1.2.4 17:43:10 INFO - docopt == 0.6.1 17:43:10 INFO - manifestparser == 1.1 17:43:10 INFO - mozInstall == 1.12 17:43:10 INFO - mozcrash == 0.17 17:43:10 INFO - mozdebug == 0.1 17:43:10 INFO - mozdevice == 0.48 17:43:10 INFO - mozfile == 1.2 17:43:10 INFO - mozhttpd == 0.7 17:43:10 INFO - mozinfo == 0.9 17:43:10 INFO - mozleak == 0.1 17:43:10 INFO - mozlog == 3.1 17:43:10 INFO - moznetwork == 0.27 17:43:10 INFO - mozprocess == 0.22 17:43:10 INFO - mozprofile == 0.28 17:43:10 INFO - mozrunner == 6.11 17:43:10 INFO - mozscreenshot == 0.1 17:43:10 INFO - mozsystemmonitor == 0.0 17:43:10 INFO - moztest == 0.7 17:43:10 INFO - mozversion == 1.4 17:43:10 INFO - psutil == 3.1.1 17:43:10 INFO - requests == 1.2.3 17:43:10 INFO - wsgiref == 0.1.2 17:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:10 INFO - 'HOME': '/Users/cltbld', 17:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:10 INFO - 'LOGNAME': 'cltbld', 17:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:10 INFO - 'MOZ_NO_REMOTE': '1', 17:43:10 INFO - 'NO_EM_RESTART': '1', 17:43:10 INFO - 'PAGER': '/bin/cat', 17:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:10 INFO - 'PWD': '/builds/slave/test', 17:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:10 INFO - 'SHELL': '/bin/bash', 17:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:10 INFO - 'USER': 'cltbld', 17:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:10 INFO - 'XPC_FLAGS': '0x0', 17:43:10 INFO - 'XPC_SERVICE_NAME': '0', 17:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:10 INFO - Cleaning up... 17:43:10 INFO - Return code: 0 17:43:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:10 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 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:10 INFO - 'HOME': '/Users/cltbld', 17:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:10 INFO - 'LOGNAME': 'cltbld', 17:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:10 INFO - 'MOZ_NO_REMOTE': '1', 17:43:10 INFO - 'NO_EM_RESTART': '1', 17:43:10 INFO - 'PAGER': '/bin/cat', 17:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:10 INFO - 'PWD': '/builds/slave/test', 17:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:10 INFO - 'SHELL': '/bin/bash', 17:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:10 INFO - 'USER': 'cltbld', 17:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:10 INFO - 'XPC_FLAGS': '0x0', 17:43:10 INFO - 'XPC_SERVICE_NAME': '0', 17:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:10 INFO - Downloading/unpacking jsonschema 17:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:12 INFO - Downloading/unpacking functools32 (from jsonschema) 17:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:13 INFO - warning: no files found matching '*.txt' 17:43:13 INFO - no previously-included directories found matching 'build' 17:43:13 INFO - no previously-included directories found matching 'dist' 17:43:13 INFO - no previously-included directories found matching '.git*' 17:43:13 INFO - Installing collected packages: jsonschema, functools32 17:43:13 INFO - Running setup.py install for functools32 17:43:13 INFO - warning: no files found matching '*.txt' 17:43:13 INFO - no previously-included directories found matching 'build' 17:43:13 INFO - no previously-included directories found matching 'dist' 17:43:13 INFO - no previously-included directories found matching '.git*' 17:43:13 INFO - Successfully installed jsonschema functools32 17:43:13 INFO - Cleaning up... 17:43:13 INFO - Return code: 0 17:43:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd93c98b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, '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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:13 INFO - 'HOME': '/Users/cltbld', 17:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:13 INFO - 'LOGNAME': 'cltbld', 17:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:13 INFO - 'MOZ_NO_REMOTE': '1', 17:43:13 INFO - 'NO_EM_RESTART': '1', 17:43:13 INFO - 'PAGER': '/bin/cat', 17:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:13 INFO - 'PWD': '/builds/slave/test', 17:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:13 INFO - 'SHELL': '/bin/bash', 17:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:13 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:13 INFO - 'USER': 'cltbld', 17:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:13 INFO - 'XPC_FLAGS': '0x0', 17:43:13 INFO - 'XPC_SERVICE_NAME': '0', 17:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:13 INFO - Downloading/unpacking flake8 17:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:43:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:43:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:43:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:43:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:43:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:43:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:43:17 INFO - no previously-included directories found matching 'docs/_build' 17:43:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:43:17 INFO - Running setup.py install for pep8 17:43:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:43:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:43:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:43:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:43:17 INFO - no previously-included directories found matching 'docs/_build' 17:43:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:43:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:43:17 INFO - Cleaning up... 17:43:17 INFO - Return code: 0 17:43:17 INFO - Running post-action listener: _resource_record_post_action 17:43:17 INFO - Running post-action listener: _start_resource_monitoring 17:43:17 INFO - Starting resource monitoring. 17:43:17 INFO - ##### 17:43:17 INFO - ##### Running install step. 17:43:17 INFO - ##### 17:43:17 INFO - Running pre-action listener: _resource_record_pre_action 17:43:17 INFO - Running main action method: install 17:43:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:18 INFO - Reading from file tmpfile_stdout 17:43:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:18 INFO - Reading from file tmpfile_stdout 17:43:18 INFO - Output received: 17:43:18 INFO - Usage: mozinstall [options] installer 17:43:18 INFO - Options: 17:43:18 INFO - -h, --help show this help message and exit 17:43:18 INFO - -d DEST, --destination=DEST 17:43:18 INFO - Directory to install application into. [default: 17:43:18 INFO - "/builds/slave/test"] 17:43:18 INFO - --app=APP Application being installed. [default: firefox] 17:43:18 INFO - mkdir: /builds/slave/test/build/application 17:43:18 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'] 17:43:18 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 17:43:52 INFO - Reading from file tmpfile_stdout 17:43:52 INFO - Output received: 17:43:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - ##### 17:43:52 INFO - ##### Running run-tests step. 17:43:52 INFO - ##### 17:43:52 INFO - Running pre-action listener: _resource_record_pre_action 17:43:52 INFO - Running main action method: run_tests 17:43:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:43:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:43:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:43:52 INFO - 2016-03-09 17:43:52.347 screenresolution[1636:7387] starting screenresolution argv=screenresolution get 17:43:52 INFO - 2016-03-09 17:43:52.350 screenresolution[1636:7387] Display 0: 1600x1200x32@60 17:43:52 INFO - 2016-03-09 17:43:52.356 screenresolution[1637:7389] starting screenresolution argv=screenresolution list 17:43:52 INFO - Available Modes on Display 0 17:43:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:43:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:43:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:43:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:43:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:43:52 INFO - Intel Iris: 17:43:52 INFO - Chipset Model: Intel Iris 17:43:52 INFO - Type: GPU 17:43:52 INFO - Bus: Built-In 17:43:52 INFO - VRAM (Dynamic, Max): 1536 MB 17:43:52 INFO - Vendor: Intel (0x8086) 17:43:52 INFO - Device ID: 0x0a2e 17:43:52 INFO - Revision ID: 0x0009 17:43:52 INFO - Displays: 17:43:52 INFO - Display: 17:43:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:43:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:43:52 INFO - Display Serial Number: 1600x1200 60 17:43:52 INFO - Main Display: Yes 17:43:52 INFO - Mirror: Off 17:43:52 INFO - Online: Yes 17:43:52 INFO - Rotation: Supported 17:43:52 INFO - Return code: 0 17:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:52 INFO - Python 2.7.3 17:43:52 INFO - Return code: 0 17:43:52 INFO - grabbing minidump binary from tooltool 17:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107562d30>, '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 0x107386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107559b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:43:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:43:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:52 INFO - Return code: 0 17:43:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:43:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:43:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:43:53 INFO - Return code: 0 17:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 17:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vU7PvNWLa0/Render', 17:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:53 INFO - 'HOME': '/Users/cltbld', 17:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PAGER': '/bin/cat', 17:43:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWh2A7a6fs/Listeners', 17:43:53 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - 'XPC_FLAGS': '0x0', 17:43:53 INFO - 'XPC_SERVICE_NAME': '0', 17:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 17:43:54 INFO - mozversion application_buildid: 20160309154625 17:43:54 INFO - mozversion application_changeset: 26e576786f9dbf101119be083c2743803e9ced5f 17:43:54 INFO - mozversion application_display_name: Nightly 17:43:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:54 INFO - mozversion application_name: Firefox 17:43:54 INFO - mozversion application_remotingname: firefox 17:43:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:43:54 INFO - mozversion application_vendor: Mozilla 17:43:54 INFO - mozversion application_version: 48.0a1 17:43:54 INFO - mozversion platform_buildid: 20160309154625 17:43:54 INFO - mozversion platform_changeset: 26e576786f9dbf101119be083c2743803e9ced5f 17:43:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:43:54 INFO - mozversion platform_version: 48.0a1 17:43:54 INFO - using testdate: 1457574234 17:43:54 INFO - actual date: 1457574234 17:43:54 INFO - starting webserver on 'localhost:49270' 17:43:54 INFO - SUITE-START | Running 2 tests 17:43:54 INFO - TEST-START | dromaeo_css 17:43:54 INFO - operating with platform_type : mac_ 17:43:54 INFO - Initialising browser for dromaeo_css test... 17:43:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp8LVESu/profile http://localhost:49270/getInfo.html) 17:43:56 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 17:43:56 INFO - PROCESS | 1655 | colorDepth:24 17:43:56 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 17:43:56 INFO - PROCESS | 1655 | __metrics 17:43:56 INFO - PROCESS | 1655 | 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" 17:43:56 ERROR - PROCESS | 1655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:43:57 INFO - TEST-INFO | 1655: exit 0 17:43:57 INFO - Browser initialized. 17:43:57 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:57 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp8LVESu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:09 INFO - PROCESS | 1658 | RSS: Main: 242753536 17:44:09 INFO - PROCESS | 1658 | 17:45:00 INFO - PROCESS | 1658 | 1457574300399 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:47:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:47:12 INFO - PROCESS | 1658 | RSS: Main: 424296448 17:47:12 INFO - PROCESS | 1658 | 17:50:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:50:15 INFO - PROCESS | 1658 | RSS: Main: 380514304 17:50:15 INFO - PROCESS | 1658 | 17:53:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:53:18 INFO - PROCESS | 1658 | RSS: Main: 375828480 17:53:18 INFO - PROCESS | 1658 | 17:56:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:56:20 INFO - PROCESS | 1658 | RSS: Main: 336650240 17:56:20 INFO - PROCESS | 1658 | 17:59:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:59:24 INFO - PROCESS | 1658 | RSS: Main: 336461824 17:59:24 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:02:27 INFO - PROCESS | 1658 | RSS: Main: 382017536 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | __start_tp_report 18:02:27 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:02:27 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:02:27 INFO - PROCESS | 1658 | |i|pagename|runs| 18:02:27 INFO - PROCESS | 1658 | |0;dojo.html;3430.125318043899;3484.5470088888455;3498.0555250082493;3517.98241008795;3565.589957154926;5646.463585959337;5688.516476099531;5690.943090569093;5702.486776190142;5702.885942281152;5697.544196464283;5699.943000569993;5702.429757024295;5828.2423284973;5832.212651292074;5098.56662183713;5122.8207012754565;5158.097332966735;5165.9225111623355;5263.921041184385;5243.2659427680155;5264.026155161288;5294.894102117955;5321.627486075976;5351.652142610737;5113.156329205676;5144.17693169093;5223.138182199932;5244.947550524484;5268.051750684895;5170.482951704837;5177.767000484987;5197.662151960149;5203.609729270282;5261.579073674096;5111.412187598399;5134.306868572769;5168.121419358718;5195.272661827347;5195.350581177353;5487.6158668893195;5585.413531579207;5609.3268807742925;5625.915611265835;5723.198752174657;6239.095331176954;6239.65681887496;6246.937530624727;6261.217347831521;6284.497240220771;5711.628744131618;6273.529485288622;6285.497160227171;6286.779962701284;6286.842828929268;5671.7731290748325;5739.856503587402;5757.625754326039;5758.769649214027;5865.120231965154;6272.780452684134;6276.089966954857;6292.46514046302;6301.495880329563;6301.590396624205;6059.272887253558;6114.57197996136;6188.938110618927;6189.442950134509;6193.349698281616;6095.7708482108;6166.321704612489;6256.593321434092;6291;6296.622202667854;6217.316095229521;6217.316095229521;6222.066689996536;6226.25284965807;6233;6223.408776166257;6233.532485063638;6265.310815810257;6266.091416744546;6268.373162683695;4807.326974223612;4851.611871050308;4872.756362181876;4899.559039686445;4907.386576677915;4379.912401751947;4434.689571729948;4470.575295346936;4471.038726673781;4541.591256786905;5655.293088363955;5694;5695.943040569624;5713.22871412354;5727.284089488814;6161.7535298588455;6187.504999600022;6254.405831446005;6300.30696623371;6310;5514.035043867388;5687.7156142192725;5727.570432217601;5836.066229403275;5861.5603829712945;5388.380336261302;5390.0836857734275;5395.838124856261;5403.648762830403;5405.648632838853;6404.263509696351;6408.743650253938;6429.292777794439;6436.195475565554;6436.903446448307;5503.752331145028;5832.62087964281;6132.477886260874;6232.8130156095385;6274.1843560336865;6327.746890124344;6351.428371446592;6360.109584658059;6379.74481020754;6385.489160867212;6182;6192.876142477216;6195.938040619716;6197.628142311476;6200.410960958701;6127.0673618518995;6131.386861313833;6177.876442471035;6185.567010309415;6238.719257633326;4818.71087734737;6001.879962400815;6015.187949626745;6017.187679663364;6022.337542870368;5017.874553136201;5916.940830591639;6017.428344307284;6022.36765139654;6041.728122234422;5842.123681447817;5860.706964651836;5877.617954833093;5879;5882.1470886722045;6077.4226448487325;6086.02623580225;6087.208662873798;6095.634261944298;6098.26820781509;5915.08316210988;5917.585768996301;5918.141869428822;5934.6142500737315;5988 18:02:27 INFO - PROCESS | 1658 | |1;ext.html;438.7367579452329;485.3908345026993;574.4456599381597;597.345906232675;639.8272466434063;29127.854360728168;39608.80195599022;40439;40592.59407405925;42748.07633656485;41880;42636.573634263645;42763.14473710524;42768;42812.35781463281;9463.053694630533;9678.225741940629;9679.854802177973;9696.321257511978;9698.369605975624;9641.084097010773;9777.90222097777;9779.804403911918;9789.510524473784;9791.16775074116;9753.804923901518;9838.803223935516;9840.458774767385;9840.852387214161;9850.753731156743;9729.173020293283;9792.853107203398;9800.068993445611;9808.803823923552;9811;9383.24934005278;9522.0954009369;9527.38072025316;9534.141927226514;9541.809163816684;38819.805900970314;39275;39293.088363954506;39341.606583934365;39352.409713854315;3203.3112880730755;3220.4525230710838;3331.602803458413;3362.495625656147;3434.347473979961;29281;29367;29932.102036938708;30396.088117356514;30624.08127756171;2750.821196622213;2777.4306267215175;2790.4279622677304;2900.8694608742444;2934.501134807088;489069;490408;490785;491138.54430727975;491383;46513;68131.3186868135;68693;68975.31024689789;69227.3077269231;48068;48235.517644823805;48298;48308.5169148311;48311.792205195154;16239.431619893247;16465.423710170326;16474.588135296475;16480.587985300463;16493.505194844172;12889.935550322189;12952.287624180572;12974.675633109247;12977.41601627929;12981;15188.848111518744;15199.620009499851;15212.619684507754;15220.847791521943;15348.309326080353;6433.517486188554;6465.64438955862;6548.607083575001;6549.705263263165;6559.639219842955;927.096081320707;960.7502049467189;1069.2889228662852;1105.2318638546133;1185.988140118605;29782.55326170109;31008.379832403676;31348.216294592363;31392.529112063337;31980.68019319777;1017.5827910556784;1044.6082718980383;1077.7736675298117;1115.4422788605698;1149.252985559393;14747.410103595736;15060.623484412758;15123.924380378028;15500.5349839505;15517;646114;650761;653979;659195;661397;50689.493105068475;60720.696396518615;61168;61194.08208876781;61286.080708789406;1319.960401187966;1346.2461021827808;1435.5621535431794;1451.5427640293274;1476.5865557643876;22881.88559057194;28966.565501517074;29468.11595652134;29718.257043574085;29733.851330743208;43146;45666.08667826691;48013.7996550089;48642.5135748638;48713.782155446395;387707;394285;394799;395090;396519.0174049111;28161.859190703915;33082.66917330796;33522.32955340831;33617;34140.82929585435;41822.16355672809;42170.57829421666;42297.73106806801;42472.93817654583;42618.57381426146;34411.82794086014;34729.65270347365;35171.82414087913;35860.282794343446;35968.10079748027;34337.65662343444;34623.13442163865;34856;35528.64471355253;35551.11122221965;31426.84286578644;35166.472502911965;36756;37843.81078094592;37993.62006380012;26191.083312083985;28436;30917.782790075325;31024.914128006316;31173.53239701361;23569.41076473102;27896.58155127715;28686.139415817557;32670.673293266762;32692.50961235631 18:02:27 INFO - PROCESS | 1658 | |2;jquery.html;360.2057463293438;363.714484129958;365.96706296433314;367.53139746822796;373.2609433322021;20378.6943195852;20986.05562749676;22111.889440552794;22340.664890026663;22650.207242746506;20716.89641551794;21193.894030529864;21463.463413414673;21939.122435102618;22048;5703.657780533161;5856.150858125569;5862.853428664296;5906.084556893688;5910.586258961875;3934.0951581136355;4094.488188976378;4094.672426205911;4098.8360465581345;5729.598928075036;4093.079057212118;4095.856645017425;5810.5932584719085;6055.818325450222;6070;6018.2778066631845;6024.427679370453;6155.384461553854;6679.632620205887;6683.7660681875905;3817.9236415271816;5836.124581312794;5848.2689663792025;5858.912116318259;5868.823935281948;27546.035888743798;27978.860105699543;28262.576061359097;29933;29965.700342996508;2381.630847218684;2531.6835395575554;2570.4859028194437;2618.4370360372614;2865.1077887677307;15713.92143039289;15795.842041579552;16130.12741143103;16185.919070404572;16513.422030228885;1851.3057603398724;1882.0683761538126;1892.9053547322717;1901.3820508334848;1904.476269026015;127315.36342318321;129671.35164324212;130440.34779826135;130690;130872.99999999905;16056.876018678813;17454.690898182685;19912.805132381516;19948.30180943689;20393.796062039488;29295.414091718045;29346.853265733534;29438.705612943595;29458.674359653865;29479.410411791643;10704.518296676513;11094.778104437866;11167.492388527446;11176;11183.32900026001;9320.906790932004;9344.112309330603;9346.299027572959;9447.90552094484;9494.955554888957;8037.995250593675;8629;9022.413543119676;9034.774130646787;9206.26349892007;2828.6181365515804;3055.4652935736603;3461.594192036561;3464.878729244515;3586.318599466093;877.3551439691821;918.9770255743526;920.231606608476;960.6493629825063;1048.5596049659162;16595.6680866382;20771.584568308852;20877.58244835095;20879.373618791462;20987.685184722242;904.6788390121412;935.4854829843558;942.7784470649392;944.6363150187227;955.5126885288414;9070.501122438329;11033.613823516138;11232.382218978035;11287.435628218556;11338.03626691724;611106;629199;629481;635756;645737;89690.10309896948;122805;122910.38544807398;125099;131148.34425828;983.4246965525248;1001.1290177545727;1003.5484032185545;1012.7670635753818;1018.8217062014118;18813.623727525646;18929.716054259472;18952.24191032343;19120.23519059222;19214;52359.73820130875;52889.735551321995;54234.72882635562;55079;56349.71825140848;77466.4506709874;77820;78031.6098419527;78728.21271787208;78767.60616196883;8097.635606397608;8205.220504052106;8246.05170405411;8366.790830229293;8633.56832158377;7952.880706789519;12890.935545322214;13279.734405312032;13524.59426217215;13855;11469.827952580885;11570.537178513101;11678;11799.52801887915;11832.230904991147;9559;10147.49262536885;11484.36835973996;11503.137264705349;11614.419279036183;11420.657380278604;11740.236884602473;11792.705182370166;11795.35125568102;12094.516219351479;8079.757607271791;8091.06952700447;8175.877361839458;8260.297874680478;8544.530050847263;8689.6089675966;11114.777704446027;11519.654410367702;11636.41817909118;11854 18:02:27 INFO - PROCESS | 1658 | |3;mootools.html;1447.3559266126579;1557.5872393815641;1596.7604859271112;1864.3474783825664;2009.2666176845446;8121.187881211883;8753.693620723276;8943.32925030622;8947.731568052952;8948.821023579525;7476.439267054965;7795.220477952202;8798.428102173355;8805.075467075962;8805.119488051208;2187.059564387313;2245.4274160089153;2248.2580748353084;2481.677381940345;2504.561701702204;2476.9628455573093;2544.605586134152;2547.8089143314232;2549.6048112542585;2557.1305756042943;2449.8162637802147;2486.105002199207;2486.589712697412;2502.1117503286346;2511.359603301156;2456.1649039326717;2488.8382255153447;2494.787943024845;2507.009731156183;2512.321673148258;2481.5905375613;2494.1395218649536;2495.6007038873877;2498.7626175513296;2506.7618576235227;8912;8955.9252889653;8956.8656470153;8974.820503589957;8976.685815996409;5542.224088627595;5636.464535869086;5666;5693.003724348223;5697.202391665171;3623.9094022649383;3694.556653201633;3763.6612704856693;3780.773153610792;3794.430835374716;1040.6305761454726;1056.8361903904906;1059.3537941855461;1073.291627525837;1078.3152698036724;10274.280800343979;12384.81422778659;12408.255504669658;12433.440495177649;12474;4975;4996.625253106032;5071.340725705634;5078.263651770547;5109.259157422153;10480.790384192274;10495.580176792995;10500.947495262628;10512.264141510173;10524.26330156897;5571.192177134374;5592.412796656374;5606.271184746039;5609.607327487037;5610.214569960209;4449.310356894686;4665.976670116627;4862.562369386772;5084.2627818966785;5094.465081166498;3832.5209348831395;3975.185087057146;3997.0806714455257;4058.411530328145;4058.939115913264;1176.9352685602373;1321.5837011341396;1321.9801702974464;1333.1268019447084;1337.9264140472173;1331.8867896228928;1341.7584834729648;1362.5980335800962;1379.951701690436;1381.7927310903444;8348.165183481604;8532;8533.487990720576;8552.786180345416;8559.144085591392;510.8595136337537;522.3914140026902;525.2069375243334;526.1345087331318;531.4207513809965;5305.867353316121;6265.749370025148;6286.088517165077;6320.051992201206;6325.272593651789;10691.09125724322;11118.888811111947;11237.887621123848;11249.268797528135;11250.943745281222;10668.253222274521;11037.172212084126;11038.613648522263;11078.169137314733;11102.2783519071;7151.7854464366155;8463.51888419524;8580.613872375634;8644.524551149621;8647.351448641377;7900.723474678359;8116.391270654843;8136.918630813616;8152.225538573826;8161.632726527202;9392.765180870532;9405.952970235105;9829.066238707312;9905.306628535933;9913.851292230478;7448;10201.795964080826;10286.742831429274;10353.482325883526;10356.844647330145;6217.689115544295;6748.493862960199;6890.896636550356;7125.82185445368;7566.697332106654;7969.3226075784205;8369.874451883348;8387.07742148351;8391.622376993171;8408.2432581068;7439.367653749492;7519.586422746802;7616.9879267070055;7625.389968802593;7654.923450765421;7365.337119659256;7387.667554960147;7400.814979625552;7510.211427800003;7547.28300811422;7801.726939557088;7831.804204894923;7867.134615192439;7869.527828330319;7899.881501777363;7049.612271325126;7055.435565154673;7118.25258347866;7142.142942846892;7150.5352152109945;7205.531640443354;7206.963965180141;7256.9274307256255;7270.272972702687;7277.090363704537 18:02:27 INFO - PROCESS | 1658 | |4;prototype.html;320.20269528873104;325.0378878519582;329.6555099920583;331.97012268895804;334.6519619595619;5431.484009019142;6409.3590640935945;6444.935550644486;6455.967045272757;6543.934560654392;6355.078513615523;6389;6399.456046236064;6428.100065990765;6444.677766111688;4604.217283061871;4664.603508701764;4727.267273572585;4806.879828004293;4848.757562121907;4769.99830035693;4795.376601041859;4806.495317991613;4808.567228949394;4825.034993001396;4792.137415265251;4799.424069111711;4808.278758186282;4811.652737233563;4811.855644330676;3705.5923848376656;3898.610138986107;4644.6516511261625;4735.455422626407;4830.444498882638;3336.916577085568;4093.5906409359122;4109.815058322382;4114.897127571805;4116.567760385146;6155.63066216024;6179.16581261533;6193.194884664965;6195.876082478325;6198.473129783929;5552.888942221173;5560.193771903092;5570.582206334541;5572.637778544382;5603.131514615241;6814.250432452426;6833.487488438387;6838.452923766136;6847.383735463832;6849.2465828758795;4283.250431174532;4430.534793846632;4430.889227769331;4430.933535996963;4444.755538445384;5370.5435038021815;7251.818704532376;7267.273272672744;7267.709291628382;7297.3432391084525;4518.638508919278;4519.977400112978;4520.434945631796;4522.412086428809;4529.048899731093;4550.0217453247715;4584.312353147055;4585.12882552314;4587.931181032221;4602.838900638461;4512.481064677539;5444.128939369682;5445.618806683494;5453.291072160594;5488.4785945335125;6660.270405216262;6757.391834734897;6895.310468953065;6901.171859376806;6906.482013848981;1558.8285288618242;1586.698527279813;1592.33122088723;1594.593378688427;1598.9200539972956;962.4514027004681;1013.3514550687565;1015.6394479959656;1028.927975041755;1044.3551406534739;4825.613950883921;5684.033714268584;6383.393577610213;6499.642519661369;6502.869942601122;7223.530470519399;7235.819104522324;7245.9275407246305;7249.601271930094;7249.782506524813;6457.225132984072;6457.483401327882;6465.4827613790785;6470.676466176672;6479.1901012373455;3058.938821223563;3741.569719482294;3769.1142581493327;3785.09157802131;3785.356489396809;7255.56466612005;7480.0649918760155;7551.207123252089;7557.962210188914;7585.962070189614;7384.418556999851;7418.183999760022;7422.109346878409;7442.627868606656;7445.441591880631;7501.624918754041;7514.098308203051;7515.398768098539;7515.774526764206;7562;7183.245759195209;7207.0630817995425;7209.855802884018;7210.242924493063;7213.71145154188;6755.763548275787;6986.336298051677;6999.8950015750825;7052.400545953651;7097.6451177439885;7467.253274672489;7500.887486687813;7505.737299194502;7520.661570229244;7531.774046778605;4505.256632655575;4538.137753826894;4540.682152249311;4540.977295113504;4550.588188260227;7120.60836653989;7125.216226215216;7129.893051604334;7138.571685698875;7139.607321597362;6613.206415230203;6833.624150671761;6857.314268573103;6870.45036397097;6875.5530890491955;6791.320867913169;6834.521583489108;6841.110655614738;6846.520743547904;6865.897011544931;6697.531172817856;6697.732090716317;6700.262971073275;6707.228668703162;6720.428763555153;5545.279113715191;6816.829579260559;6821.181458224846;6835.69239384219;6847.07564478789;6503;6565.901511477236;6732.091167692299;6741.629210393476;6746.325367463214 18:02:27 INFO - PROCESS | 1658 | |5;yui.html;662.7315937045498;681.5365551425032;746.5184955703571;772.0889350566331;815.6574238819693;15187.316570754316;15667.608309792233;15731.370745170194;15740.449084282052;15753.684926301481;14259.930505212125;14458.277086145677;14569.27153642319;15081.039464869578;15298.69402611947;913.2648218184376;922.9353945223837;930.9255259579218;931.7577429868215;932.7994481186544;725.941924646027;739.8668239716849;912.9315301352392;934.6121359635742;936.8126374725048;983.2723784399565;985.9556319965583;986.8075725233582;987.5407935310079;988.8912219655832;773.1109224391938;972.9951350243203;976.6484065736329;978.1783302026297;978.5351957820014;712.2948281201625;725.2602345607504;725.9237780033073;726.8001299642588;726.8001299642588;15542.611434714223;15597;15604;15638.732383804398;15653.608659783482;12809.167404118796;12917.22496650204;12994.350282485932;13062;13133.540326088636;10162.847557286646;10320.638777642747;10332.431716255604;10699.83950240747;11235.045021173128;3609.855605775766;3664.8350824212976;3672.3573374659327;3767.2088861339153;3792.2984247913946;88513.55743221307;89531.55234223853;89640.10359896383;89665.55167224187;89934;9558.90441095594;9831.950840245896;9849.60601575929;9896.950515247378;9914.80170396588;21297.36107916765;21369.931503424767;21370.57258854814;21378.78621213799;21429.82135982536;7512.511686740344;7516.398688104939;7528.360089392463;7551.622418879034;7610.885836712454;4145.3781932709735;4170.16596680665;4182.53992060873;4204.642605378516;4211.368294755811;3691.9630803692157;3745.606711295329;3747.5877653458097;3747.662710356081;3750.4561838533805;654.6105067484839;659.7031335898769;668.8027032025564;674.578388507183;685.5235611250133;540.9486098820606;582.6416753696446;594.5659668442062;602.1599868183858;618.2766163588612;8280.875786863202;8306.335493160532;8390.538520381439;8435.367347448966;8624.310055195569;539.8839249561363;597.4964897081215;600.2646757721756;600.5195843325322;600.9338972712998;3815.9427608585893;3837.347650899354;3904.4143378493454;3929.842806287774;3993.5207775066597;89556;89954;92328;94363;94422.58366124514;81371.5931420339;81706;82162.76755848667;82234.58882705668;82829;58490.70754646199;71028.51400200969;73441;73780.63109684417;74199.17705349135;7762.7671169865;7860.489068210548;7989.053628232888;8053.919460805317;8127.634256458356;51021;51457.71355716137;51954.74022629863;51974.48025519696;52092.8617490956;68526.314736854;68993.27516811919;69483;69523.65238173777;69607;9890.208783297463;10079.949600251952;10106.545205465918;10792;11039.282446641264;12064.215825971283;12225.572104976283;12281.570145044881;12463.376831158586;13032.54386096482;9358.29812764059;11929.224600400947;11939.343336116597;12015.75968480608;12038.03695704359;11493.252938558968;11820.23168494045;11841.5855445059;11869.287842729464;12024.33866137371;11520.654380368602;11575.247608905394;11735.706607334885;11802.409879505818;12045.277283363026;9811.803763924825;10039.849402259119;10049.849252261076;10317.123044541298;10534.42060686639;9727.9027209727;9753.414795112032;9915.603375865174;9934.850977235203;9963.50182490887 18:02:27 INFO - PROCESS | 1658 | __end_tp_report 18:02:27 INFO - PROCESS | 1658 | __start_cc_report 18:02:27 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1999 18:02:27 INFO - PROCESS | 1658 | __end_cc_report 18:02:27 INFO - PROCESS | 1658 | __startTimestamp1457575347968__endTimestamp 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:02:27 INFO - PROCESS | 1658 | Number of tests: 6 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5723.72 Median:5877.62 stddev:628.97 (10.7%) stddev-sans-first:604.61 18:02:27 INFO - PROCESS | 1658 | Values: 3430.1 3484.5 3498.1 3518.0 3565.6 5646.5 5688.5 5690.9 5702.5 5702.9 5697.5 5699.9 5702.4 5828.2 5832.2 5098.6 5122.8 5158.1 5165.9 5263.9 5243.3 5264.0 5294.9 5321.6 5351.7 5113.2 5144.2 5223.1 5244.9 5268.1 5170.5 5177.8 5197.7 5203.6 5261.6 5111.4 5134.3 5168.1 5195.3 5195.4 5487.6 5585.4 5609.3 5625.9 5723.2 6239.1 6239.7 6246.9 6261.2 6284.5 5711.6 6273.5 6285.5 6286.8 6286.8 5671.8 5739.9 5757.6 5758.8 5865.1 6272.8 6276.1 6292.5 6301.5 6301.6 6059.3 6114.6 6188.9 6189.4 6193.3 6095.8 6166.3 6256.6 6291.0 6296.6 6217.3 6217.3 6222.1 6226.3 6233.0 6223.4 6233.5 6265.3 6266.1 6268.4 4807.3 4851.6 4872.8 4899.6 4907.4 4379.9 4434.7 4470.6 4471.0 4541.6 5655.3 5694.0 5695.9 5713.2 5727.3 6161.8 6187.5 6254.4 6300.3 6310.0 5514.0 5687.7 5727.6 5836.1 5861.6 5388.4 5390.1 5395.8 5403.6 5405.6 6404.3 6408.7 6429.3 6436.2 6436.9 5503.8 5832.6 6132.5 6232.8 6274.2 6327.7 6351.4 6360.1 6379.7 6385.5 6182.0 6192.9 6195.9 6197.6 6200.4 6127.1 6131.4 6177.9 6185.6 6238.7 4818.7 6001.9 6015.2 6017.2 6022.3 5017.9 5916.9 6017.4 6022.4 6041.7 5842.1 5860.7 5877.6 5879.0 5882.1 6077.4 6086.0 6087.2 6095.6 6098.3 5915.1 5917.6 5918.1 5934.6 5988.0 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:64748.13 Median:39047.40 stddev:140069.63 (358.7%) stddev-sans-first:140379.34 18:02:27 INFO - PROCESS | 1658 | Values: 438.7 485.4 574.4 597.3 639.8 29127.9 39608.8 40439.0 40592.6 42748.1 41880.0 42636.6 42763.1 42768.0 42812.4 9463.1 9678.2 9679.9 9696.3 9698.4 9641.1 9777.9 9779.8 9789.5 9791.2 9753.8 9838.8 9840.5 9840.9 9850.8 9729.2 9792.9 9800.1 9808.8 9811.0 9383.2 9522.1 9527.4 9534.1 9541.8 38819.8 39275.0 39293.1 39341.6 39352.4 3203.3 3220.5 3331.6 3362.5 3434.3 29281.0 29367.0 29932.1 30396.1 30624.1 2750.8 2777.4 2790.4 2900.9 2934.5 489069.0 490408.0 490785.0 491138.5 491383.0 46513.0 68131.3 68693.0 68975.3 69227.3 48068.0 48235.5 48298.0 48308.5 48311.8 16239.4 16465.4 16474.6 16480.6 16493.5 12889.9 12952.3 12974.7 12977.4 12981.0 15188.8 15199.6 15212.6 15220.8 15348.3 6433.5 6465.6 6548.6 6549.7 6559.6 927.1 960.8 1069.3 1105.2 1186.0 29782.6 31008.4 31348.2 31392.5 31980.7 1017.6 1044.6 1077.8 1115.4 1149.3 14747.4 15060.6 15123.9 15500.5 15517.0 646114.0 650761.0 653979.0 659195.0 661397.0 50689.5 60720.7 61168.0 61194.1 61286.1 1320.0 1346.2 1435.6 1451.5 1476.6 22881.9 28966.6 29468.1 29718.3 29733.9 43146.0 45666.1 48013.8 48642.5 48713.8 387707.0 394285.0 394799.0 395090.0 396519.0 28161.9 33082.7 33522.3 33617.0 34140.8 41822.2 42170.6 42297.7 42472.9 42618.6 34411.8 34729.7 35171.8 35860.3 35968.1 34337.7 34623.1 34856.0 35528.6 35551.1 31426.8 35166.5 36756.0 37843.8 37993.6 26191.1 28436.0 30917.8 31024.9 31173.5 23569.4 27896.6 28686.1 32670.7 32692.5 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:37173.82 Median:29392.78 stddev:104788.53 (356.5%) stddev-sans-first:105046.03 18:02:27 INFO - PROCESS | 1658 | Values: 360.2 363.7 366.0 367.5 373.3 20378.7 20986.1 22111.9 22340.7 22650.2 20716.9 21193.9 21463.5 21939.1 22048.0 5703.7 5856.2 5862.9 5906.1 5910.6 3934.1 4094.5 4094.7 4098.8 5729.6 4093.1 4095.9 5810.6 6055.8 6070.0 6018.3 6024.4 6155.4 6679.6 6683.8 3817.9 5836.1 5848.3 5858.9 5868.8 27546.0 27978.9 28262.6 29933.0 29965.7 2381.6 2531.7 2570.5 2618.4 2865.1 15713.9 15795.8 16130.1 16185.9 16513.4 1851.3 1882.1 1892.9 1901.4 1904.5 127315.4 129671.4 130440.3 130690.0 130873.0 16056.9 17454.7 19912.8 19948.3 20393.8 29295.4 29346.9 29438.7 29458.7 29479.4 10704.5 11094.8 11167.5 11176.0 11183.3 9320.9 9344.1 9346.3 9447.9 9495.0 8038.0 8629.0 9022.4 9034.8 9206.3 2828.6 3055.5 3461.6 3464.9 3586.3 877.4 919.0 920.2 960.6 1048.6 16595.7 20771.6 20877.6 20879.4 20987.7 904.7 935.5 942.8 944.6 955.5 9070.5 11033.6 11232.4 11287.4 11338.0 611106.0 629199.0 629481.0 635756.0 645737.0 89690.1 122805.0 122910.4 125099.0 131148.3 983.4 1001.1 1003.5 1012.8 1018.8 18813.6 18929.7 18952.2 19120.2 19214.0 52359.7 52889.7 54234.7 55079.0 56349.7 77466.5 77820.0 78031.6 78728.2 78767.6 8097.6 8205.2 8246.1 8366.8 8633.6 7952.9 12890.9 13279.7 13524.6 13855.0 11469.8 11570.5 11678.0 11799.5 11832.2 9559.0 10147.5 11484.4 11503.1 11614.4 11420.7 11740.2 11792.7 11795.4 12094.5 8079.8 8091.1 8175.9 8260.3 8544.5 8689.6 11114.8 11519.7 11636.4 11854.0 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:6127.51 Median:523.80 stddev:3270.27 (624.3%) stddev-sans-first:3260.53 18:02:27 INFO - PROCESS | 1658 | Values: 1447.4 1557.6 1596.8 1864.3 2009.3 8121.2 8753.7 8943.3 8947.7 8948.8 7476.4 7795.2 8798.4 8805.1 8805.1 2187.1 2245.4 2248.3 2481.7 2504.6 2477.0 2544.6 2547.8 2549.6 2557.1 2449.8 2486.1 2486.6 2502.1 2511.4 2456.2 2488.8 2494.8 2507.0 2512.3 2481.6 2494.1 2495.6 2498.8 2506.8 8912.0 8955.9 8956.9 8974.8 8976.7 5542.2 5636.5 5666.0 5693.0 5697.2 3623.9 3694.6 3763.7 3780.8 3794.4 1040.6 1056.8 1059.4 1073.3 1078.3 10274.3 12384.8 12408.3 12433.4 12474.0 4975.0 4996.6 5071.3 5078.3 5109.3 10480.8 10495.6 10500.9 10512.3 10524.3 5571.2 5592.4 5606.3 5609.6 5610.2 4449.3 4666.0 4862.6 5084.3 5094.5 3832.5 3975.2 3997.1 4058.4 4058.9 1176.9 1321.6 1322.0 1333.1 1337.9 1331.9 1341.8 1362.6 1380.0 1381.8 8348.2 8532.0 8533.5 8552.8 8559.1 510.9 522.4 525.2 526.1 531.4 5305.9 6265.7 6286.1 6320.1 6325.3 10691.1 11118.9 11237.9 11249.3 11250.9 10668.3 11037.2 11038.6 11078.2 11102.3 7151.8 8463.5 8580.6 8644.5 8647.4 7900.7 8116.4 8136.9 8152.2 8161.6 9392.8 9406.0 9829.1 9905.3 9913.9 7448.0 10201.8 10286.7 10353.5 10356.8 6217.7 6748.5 6890.9 7125.8 7566.7 7969.3 8369.9 8387.1 8391.6 8408.2 7439.4 7519.6 7617.0 7625.4 7654.9 7365.3 7387.7 7400.8 7510.2 7547.3 7801.7 7831.8 7867.1 7869.5 7899.9 7049.6 7055.4 7118.3 7142.1 7150.5 7205.5 7207.0 7256.9 7270.3 7277.1 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5611.30 Median:6444.81 stddev:1823.31 (28.3%) stddev-sans-first:1784.65 18:02:27 INFO - PROCESS | 1658 | Values: 320.2 325.0 329.7 332.0 334.7 5431.5 6409.4 6444.9 6456.0 6543.9 6355.1 6389.0 6399.5 6428.1 6444.7 4604.2 4664.6 4727.3 4806.9 4848.8 4770.0 4795.4 4806.5 4808.6 4825.0 4792.1 4799.4 4808.3 4811.7 4811.9 3705.6 3898.6 4644.7 4735.5 4830.4 3336.9 4093.6 4109.8 4114.9 4116.6 6155.6 6179.2 6193.2 6195.9 6198.5 5552.9 5560.2 5570.6 5572.6 5603.1 6814.3 6833.5 6838.5 6847.4 6849.2 4283.3 4430.5 4430.9 4430.9 4444.8 5370.5 7251.8 7267.3 7267.7 7297.3 4518.6 4520.0 4520.4 4522.4 4529.0 4550.0 4584.3 4585.1 4587.9 4602.8 4512.5 5444.1 5445.6 5453.3 5488.5 6660.3 6757.4 6895.3 6901.2 6906.5 1558.8 1586.7 1592.3 1594.6 1598.9 962.5 1013.4 1015.6 1028.9 1044.4 4825.6 5684.0 6383.4 6499.6 6502.9 7223.5 7235.8 7245.9 7249.6 7249.8 6457.2 6457.5 6465.5 6470.7 6479.2 3058.9 3741.6 3769.1 3785.1 3785.4 7255.6 7480.1 7551.2 7558.0 7586.0 7384.4 7418.2 7422.1 7442.6 7445.4 7501.6 7514.1 7515.4 7515.8 7562.0 7183.2 7207.1 7209.9 7210.2 7213.7 6755.8 6986.3 6999.9 7052.4 7097.6 7467.3 7500.9 7505.7 7520.7 7531.8 4505.3 4538.1 4540.7 4541.0 4550.6 7120.6 7125.2 7129.9 7138.6 7139.6 6613.2 6833.6 6857.3 6870.5 6875.6 6791.3 6834.5 6841.1 6846.5 6865.9 6697.5 6697.7 6700.3 6707.2 6720.4 5545.3 6816.8 6821.2 6835.7 6847.1 6503.0 6565.9 6732.1 6741.6 6746.3 18:02:27 INFO - PROCESS | 1658 | 18:02:27 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18879.52 Median:601.55 stddev:26683.89 (4435.9%) stddev-sans-first:26723.69 18:02:27 INFO - PROCESS | 1658 | Values: 662.7 681.5 746.5 772.1 815.7 15187.3 15667.6 15731.4 15740.4 15753.7 14259.9 14458.3 14569.3 15081.0 15298.7 913.3 922.9 930.9 931.8 932.8 725.9 739.9 912.9 934.6 936.8 983.3 986.0 986.8 987.5 988.9 773.1 973.0 976.6 978.2 978.5 712.3 725.3 725.9 726.8 726.8 15542.6 15597.0 15604.0 15638.7 15653.6 12809.2 12917.2 12994.4 13062.0 13133.5 10162.8 10320.6 10332.4 10699.8 11235.0 3609.9 3664.8 3672.4 3767.2 3792.3 88513.6 89531.6 89640.1 89665.6 89934.0 9558.9 9832.0 9849.6 9897.0 9914.8 21297.4 21369.9 21370.6 21378.8 21429.8 7512.5 7516.4 7528.4 7551.6 7610.9 4145.4 4170.2 4182.5 4204.6 4211.4 3692.0 3745.6 3747.6 3747.7 3750.5 654.6 659.7 668.8 674.6 685.5 540.9 582.6 594.6 602.2 618.3 8280.9 8306.3 8390.5 8435.4 8624.3 539.9 597.5 600.3 600.5 600.9 3815.9 3837.3 3904.4 3929.8 3993.5 89556.0 89954.0 92328.0 94363.0 94422.6 81371.6 81706.0 82162.8 82234.6 82829.0 58490.7 71028.5 73441.0 73780.6 74199.2 7762.8 7860.5 7989.1 8053.9 8127.6 51021.0 51457.7 51954.7 51974.5 52092.9 68526.3 68993.3 69483.0 69523.7 69607.0 9890.2 10079.9 10106.5 10792.0 11039.3 12064.2 12225.6 12281.6 12463.4 13032.5 9358.3 11929.2 11939.3 12015.8 12038.0 11493.3 11820.2 11841.6 11869.3 12024.3 11520.7 11575.2 11735.7 11802.4 12045.3 9811.8 10039.8 10049.8 10317.1 10534.4 9727.9 9753.4 9915.6 9934.9 9963.5 18:02:27 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:02:27 INFO - PROCESS | 1658 | 18:02:28 INFO - TEST-INFO | 1658: exit 0 18:02:28 INFO - TEST-OK | dromaeo_css | took 1114464ms 18:02:28 INFO - TEST-START | kraken 18:02:28 INFO - operating with platform_type : mac_ 18:02:28 INFO - Initialising browser for kraken test... 18:02:28 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpDTq5ar/profile http://localhost:49270/getInfo.html) 18:02:30 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 18:02:30 INFO - PROCESS | 1670 | colorDepth:24 18:02:30 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 18:02:30 INFO - PROCESS | 1670 | __metrics 18:02:30 INFO - PROCESS | 1670 | 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" 18:02:30 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:02:31 INFO - TEST-INFO | 1670: exit 0 18:02:31 INFO - Browser initialized. 18:02:31 INFO - Running cycle 1/1 for kraken test... 18:02:31 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpDTq5ar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:43 INFO - PROCESS | 1672 | RSS: Main: 241217536 18:02:43 INFO - PROCESS | 1672 | 18:02:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:46 INFO - PROCESS | 1672 | RSS: Main: 290484224 18:02:46 INFO - PROCESS | 1672 | 18:02:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 18:02:49 INFO - PROCESS | 1672 | RSS: Main: 299794432 18:02:49 INFO - PROCESS | 1672 | 18:02:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 18:02:53 INFO - PROCESS | 1672 | RSS: Main: 287510528 18:02:53 INFO - PROCESS | 1672 | 18:02:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 18:02:56 INFO - PROCESS | 1672 | RSS: Main: 290369536 18:02:56 INFO - PROCESS | 1672 | 18:02:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:59 INFO - PROCESS | 1672 | RSS: Main: 290304000 18:02:59 INFO - PROCESS | 1672 | 18:03:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:02 INFO - PROCESS | 1672 | RSS: Main: 292515840 18:03:02 INFO - PROCESS | 1672 | 18:03:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:05 INFO - PROCESS | 1672 | RSS: Main: 291172352 18:03:05 INFO - PROCESS | 1672 | 18:03:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 18:03:09 INFO - PROCESS | 1672 | RSS: Main: 292552704 18:03:09 INFO - PROCESS | 1672 | 18:03:10 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:11 INFO - PROCESS | 1672 | RSS: Main: 324464640 18:03:11 INFO - PROCESS | 1672 | 18:03:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:13 INFO - PROCESS | 1672 | RSS: Main: 325730304 18:03:13 INFO - PROCESS | 1672 | 18:03:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:16 INFO - PROCESS | 1672 | RSS: Main: 331083776 18:03:16 INFO - PROCESS | 1672 | 18:03:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:19 INFO - PROCESS | 1672 | RSS: Main: 332148736 18:03:19 INFO - PROCESS | 1672 | 18:03:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:22 INFO - PROCESS | 1672 | RSS: Main: 332103680 18:03:22 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 18:03:24 INFO - PROCESS | 1672 | RSS: Main: 392609792 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | __start_tp_report 18:03:24 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 18:03:24 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 18:03:24 INFO - PROCESS | 1672 | |i|pagename|runs| 18:03:24 INFO - PROCESS | 1672 | |0;ai-astar;109;108;110;110;114;110;116;111;111;110 18:03:24 INFO - PROCESS | 1672 | |1;audio-beat-detection;177;197;142;155;118;144;137;118;159;118 18:03:24 INFO - PROCESS | 1672 | |2;audio-dft;187;186;184;186;205;266;189;185;187;185 18:03:24 INFO - PROCESS | 1672 | |3;audio-fft;73;75;88;77;56;56;59;73;75;55 18:03:24 INFO - PROCESS | 1672 | |4;audio-oscillator;98;96;126;80;79;80;117;76;79;111 18:03:24 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;89;84;87;85;86;85;87;85;87;84 18:03:24 INFO - PROCESS | 1672 | |6;imaging-darkroom;136;148;93;94;92;92;93;93;101;92 18:03:24 INFO - PROCESS | 1672 | |7;imaging-desaturate;85;84;85;85;85;85;84;83;84;91 18:03:24 INFO - PROCESS | 1672 | |8;json-parse-financial;55;55;55;54;54;54;55;64;55;53 18:03:24 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;62;67;79;91;100;67;65;66;67;67 18:03:24 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;85;83;82;90;83;82;84;81;83;80 18:03:24 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;129;134;130;123;129;135;113;117;121;124 18:03:24 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;141;128;137;142;138;126;138;141;136;137 18:03:24 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;67;67;66;67;65;67;67;67;66;67 18:03:24 INFO - PROCESS | 1672 | __end_tp_report 18:03:24 INFO - PROCESS | 1672 | __start_cc_report 18:03:24 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1226 18:03:24 INFO - PROCESS | 1672 | __end_cc_report 18:03:24 INFO - PROCESS | 1672 | __startTimestamp1457575404678__endTimestamp 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | ------- Summary: start ------- 18:03:24 INFO - PROCESS | 1672 | Number of tests: 14 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.50 stddev:2.38 (2.2%) stddev-sans-first:2.42 18:03:24 INFO - PROCESS | 1672 | Values: 109.0 108.0 110.0 110.0 114.0 110.0 116.0 111.0 111.0 110.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:149.50 stddev:26.38 (17.6%) stddev-sans-first:25.57 18:03:24 INFO - PROCESS | 1672 | Values: 177.0 197.0 142.0 155.0 118.0 144.0 137.0 118.0 159.0 118.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:196.00 Median:187.00 stddev:25.34 (13.5%) stddev-sans-first:26.66 18:03:24 INFO - PROCESS | 1672 | Values: 187.0 186.0 184.0 186.0 205.0 266.0 189.0 185.0 187.0 185.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:68.70 Median:74.00 stddev:11.36 (15.4%) stddev-sans-first:11.95 18:03:24 INFO - PROCESS | 1672 | Values: 73.0 75.0 88.0 77.0 56.0 56.0 59.0 73.0 75.0 55.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.50 stddev:18.34 (23.1%) stddev-sans-first:19.40 18:03:24 INFO - PROCESS | 1672 | Values: 98.0 96.0 126.0 80.0 79.0 80.0 117.0 76.0 79.0 111.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.60 (1.8%) stddev-sans-first:1.24 18:03:24 INFO - PROCESS | 1672 | Values: 89.0 84.0 87.0 85.0 86.0 85.0 87.0 85.0 87.0 84.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:92.50 stddev:20.71 (22.4%) stddev-sans-first:18.30 18:03:24 INFO - PROCESS | 1672 | Values: 136.0 148.0 93.0 94.0 92.0 92.0 93.0 93.0 101.0 92.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:2.18 (2.6%) stddev-sans-first:2.32 18:03:24 INFO - PROCESS | 1672 | Values: 85.0 84.0 85.0 85.0 85.0 85.0 84.0 83.0 84.0 91.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.10 (5.6%) stddev-sans-first:3.28 18:03:24 INFO - PROCESS | 1672 | Values: 55.0 55.0 55.0 54.0 54.0 54.0 55.0 64.0 55.0 53.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:67.00 stddev:12.77 (19.1%) stddev-sans-first:12.89 18:03:24 INFO - PROCESS | 1672 | Values: 62.0 67.0 79.0 91.0 100.0 67.0 65.0 66.0 67.0 67.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.75 (3.3%) stddev-sans-first:2.85 18:03:24 INFO - PROCESS | 1672 | Values: 85.0 83.0 82.0 90.0 83.0 82.0 84.0 81.0 83.0 80.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:129.00 stddev:7.18 (5.6%) stddev-sans-first:7.51 18:03:24 INFO - PROCESS | 1672 | Values: 129.0 134.0 130.0 123.0 129.0 135.0 113.0 117.0 121.0 124.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:138.00 stddev:5.36 (3.9%) stddev-sans-first:5.42 18:03:24 INFO - PROCESS | 1672 | Values: 141.0 128.0 137.0 142.0 138.0 126.0 138.0 141.0 136.0 137.0 18:03:24 INFO - PROCESS | 1672 | 18:03:24 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 18:03:24 INFO - PROCESS | 1672 | Values: 67.0 67.0 66.0 67.0 65.0 67.0 67.0 67.0 66.0 67.0 18:03:24 INFO - PROCESS | 1672 | -------- Summary: end -------- 18:03:24 INFO - PROCESS | 1672 | 18:03:25 INFO - TEST-INFO | 1672: exit 0 18:03:25 INFO - TEST-OK | kraken | took 56951ms 18:03:25 INFO - SUITE-END | took 1171s 18:03:25 INFO - Completed test suite (00:19:31) 18:03:25 INFO - javascript benchmark 18:03:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3430.125318043899, 3484.5470088888455, 3498.0555250082493, 3517.98241008795, 3565.589957154926, 5646.463585959337, 5688.516476099531, 5690.943090569093, 5702.486776190142, 5702.885942281152, 5697.544196464283, 5699.943000569993, 5702.429757024295, 5828.2423284973, 5832.212651292074, 5098.56662183713, 5122.8207012754565, 5158.097332966735, 5165.9225111623355, 5263.921041184385, 5243.2659427680155, 5264.026155161288, 5294.894102117955, 5321.627486075976, 5351.652142610737, 5113.156329205676, 5144.17693169093, 5223.138182199932, 5244.947550524484, 5268.051750684895, 5170.482951704837, 5177.767000484987, 5197.662151960149, 5203.609729270282, 5261.579073674096, 5111.412187598399, 5134.306868572769, 5168.121419358718, 5195.272661827347, 5195.350581177353, 5487.6158668893195, 5585.413531579207, 5609.3268807742925, 5625.915611265835, 5723.198752174657, 6239.095331176954, 6239.65681887496, 6246.937530624727, 6261.217347831521, 6284.497240220771, 5711.628744131618, 6273.529485288622, 6285.497160227171, 6286.779962701284, 6286.842828929268, 5671.7731290748325, 5739.856503587402, 5757.625754326039, 5758.769649214027, 5865.120231965154, 6272.780452684134, 6276.089966954857, 6292.46514046302, 6301.495880329563, 6301.590396624205, 6059.272887253558, 6114.57197996136, 6188.938110618927, 6189.442950134509, 6193.349698281616, 6095.7708482108, 6166.321704612489, 6256.593321434092, 6291.0, 6296.622202667854, 6217.316095229521, 6217.316095229521, 6222.066689996536, 6226.25284965807, 6233.0, 6223.408776166257, 6233.532485063638, 6265.310815810257, 6266.091416744546, 6268.373162683695, 4807.326974223612, 4851.611871050308, 4872.756362181876, 4899.559039686445, 4907.386576677915, 4379.912401751947, 4434.689571729948, 4470.575295346936, 4471.038726673781, 4541.591256786905, 5655.293088363955, 5694.0, 5695.943040569624, 5713.22871412354, 5727.284089488814, 6161.7535298588455, 6187.504999600022, 6254.405831446005, 6300.30696623371, 6310.0, 5514.035043867388, 5687.7156142192725, 5727.570432217601, 5836.066229403275, 5861.5603829712945, 5388.380336261302, 5390.0836857734275, 5395.838124856261, 5403.648762830403, 5405.648632838853, 6404.263509696351, 6408.743650253938, 6429.292777794439, 6436.195475565554, 6436.903446448307, 5503.752331145028, 5832.62087964281, 6132.477886260874, 6232.8130156095385, 6274.1843560336865, 6327.746890124344, 6351.428371446592, 6360.109584658059, 6379.74481020754, 6385.489160867212, 6182.0, 6192.876142477216, 6195.938040619716, 6197.628142311476, 6200.410960958701, 6127.0673618518995, 6131.386861313833, 6177.876442471035, 6185.567010309415, 6238.719257633326, 4818.71087734737, 6001.879962400815, 6015.187949626745, 6017.187679663364, 6022.337542870368, 5017.874553136201, 5916.940830591639, 6017.428344307284, 6022.36765139654, 6041.728122234422, 5842.123681447817, 5860.706964651836, 5877.617954833093, 5879.0, 5882.1470886722045, 6077.4226448487325, 6086.02623580225, 6087.208662873798, 6095.634261944298, 6098.26820781509, 5915.08316210988, 5917.585768996301, 5918.141869428822, 5934.6142500737315, 5988.0], "unit": "score", "name": "dojo.html", "value": 5685.548200939806}, {"lowerIsBetter": false, "replicates": [438.7367579452329, 485.3908345026993, 574.4456599381597, 597.345906232675, 639.8272466434063, 29127.854360728168, 39608.80195599022, 40439.0, 40592.59407405925, 42748.07633656485, 41880.0, 42636.573634263645, 42763.14473710524, 42768.0, 42812.35781463281, 9463.053694630533, 9678.225741940629, 9679.854802177973, 9696.321257511978, 9698.369605975624, 9641.084097010773, 9777.90222097777, 9779.804403911918, 9789.510524473784, 9791.16775074116, 9753.804923901518, 9838.803223935516, 9840.458774767385, 9840.852387214161, 9850.753731156743, 9729.173020293283, 9792.853107203398, 9800.068993445611, 9808.803823923552, 9811.0, 9383.24934005278, 9522.0954009369, 9527.38072025316, 9534.141927226514, 9541.809163816684, 38819.805900970314, 39275.0, 39293.088363954506, 39341.606583934365, 39352.409713854315, 3203.3112880730755, 3220.4525230710838, 3331.602803458413, 3362.495625656147, 3434.347473979961, 29281.0, 29367.0, 29932.102036938708, 30396.088117356514, 30624.08127756171, 2750.821196622213, 2777.4306267215175, 2790.4279622677304, 2900.8694608742444, 2934.501134807088, 489069.0, 490408.0, 490785.0, 491138.54430727975, 491383.0, 46513.0, 68131.3186868135, 68693.0, 68975.31024689789, 69227.3077269231, 48068.0, 48235.517644823805, 48298.0, 48308.5169148311, 48311.792205195154, 16239.431619893247, 16465.423710170326, 16474.588135296475, 16480.587985300463, 16493.505194844172, 12889.935550322189, 12952.287624180572, 12974.675633109247, 12977.41601627929, 12981.0, 15188.848111518744, 15199.620009499851, 15212.619684507754, 15220.847791521943, 15348.309326080353, 6433.517486188554, 6465.64438955862, 6548.607083575001, 6549.705263263165, 6559.639219842955, 927.096081320707, 960.7502049467189, 1069.2889228662852, 1105.2318638546133, 1185.988140118605, 29782.55326170109, 31008.379832403676, 31348.216294592363, 31392.529112063337, 31980.68019319777, 1017.5827910556784, 1044.6082718980383, 1077.7736675298117, 1115.4422788605698, 1149.252985559393, 14747.410103595736, 15060.623484412758, 15123.924380378028, 15500.5349839505, 15517.0, 646114.0, 650761.0, 653979.0, 659195.0, 661397.0, 50689.493105068475, 60720.696396518615, 61168.0, 61194.08208876781, 61286.080708789406, 1319.960401187966, 1346.2461021827808, 1435.5621535431794, 1451.5427640293274, 1476.5865557643876, 22881.88559057194, 28966.565501517074, 29468.11595652134, 29718.257043574085, 29733.851330743208, 43146.0, 45666.08667826691, 48013.7996550089, 48642.5135748638, 48713.782155446395, 387707.0, 394285.0, 394799.0, 395090.0, 396519.0174049111, 28161.859190703915, 33082.66917330796, 33522.32955340831, 33617.0, 34140.82929585435, 41822.16355672809, 42170.57829421666, 42297.73106806801, 42472.93817654583, 42618.57381426146, 34411.82794086014, 34729.65270347365, 35171.82414087913, 35860.282794343446, 35968.10079748027, 34337.65662343444, 34623.13442163865, 34856.0, 35528.64471355253, 35551.11122221965, 31426.84286578644, 35166.472502911965, 36756.0, 37843.81078094592, 37993.62006380012, 26191.083312083985, 28436.0, 30917.782790075325, 31024.914128006316, 31173.53239701361, 23569.41076473102, 27896.58155127715, 28686.139415817557, 32670.673293266762, 32692.50961235631], "unit": "score", "name": "ext.html", "value": 19366.68425740155}, {"lowerIsBetter": false, "replicates": [360.2057463293438, 363.714484129958, 365.96706296433314, 367.53139746822796, 373.2609433322021, 20378.6943195852, 20986.05562749676, 22111.889440552794, 22340.664890026663, 22650.207242746506, 20716.89641551794, 21193.894030529864, 21463.463413414673, 21939.122435102618, 22048.0, 5703.657780533161, 5856.150858125569, 5862.853428664296, 5906.084556893688, 5910.586258961875, 3934.0951581136355, 4094.488188976378, 4094.672426205911, 4098.8360465581345, 5729.598928075036, 4093.079057212118, 4095.856645017425, 5810.5932584719085, 6055.818325450222, 6070.0, 6018.2778066631845, 6024.427679370453, 6155.384461553854, 6679.632620205887, 6683.7660681875905, 3817.9236415271816, 5836.124581312794, 5848.2689663792025, 5858.912116318259, 5868.823935281948, 27546.035888743798, 27978.860105699543, 28262.576061359097, 29933.0, 29965.700342996508, 2381.630847218684, 2531.6835395575554, 2570.4859028194437, 2618.4370360372614, 2865.1077887677307, 15713.92143039289, 15795.842041579552, 16130.12741143103, 16185.919070404572, 16513.422030228885, 1851.3057603398724, 1882.0683761538126, 1892.9053547322717, 1901.3820508334848, 1904.476269026015, 127315.36342318321, 129671.35164324212, 130440.34779826135, 130690.0, 130872.99999999905, 16056.876018678813, 17454.690898182685, 19912.805132381516, 19948.30180943689, 20393.796062039488, 29295.414091718045, 29346.853265733534, 29438.705612943595, 29458.674359653865, 29479.410411791643, 10704.518296676513, 11094.778104437866, 11167.492388527446, 11176.0, 11183.32900026001, 9320.906790932004, 9344.112309330603, 9346.299027572959, 9447.90552094484, 9494.955554888957, 8037.995250593675, 8629.0, 9022.413543119676, 9034.774130646787, 9206.26349892007, 2828.6181365515804, 3055.4652935736603, 3461.594192036561, 3464.878729244515, 3586.318599466093, 877.3551439691821, 918.9770255743526, 920.231606608476, 960.6493629825063, 1048.5596049659162, 16595.6680866382, 20771.584568308852, 20877.58244835095, 20879.373618791462, 20987.685184722242, 904.6788390121412, 935.4854829843558, 942.7784470649392, 944.6363150187227, 955.5126885288414, 9070.501122438329, 11033.613823516138, 11232.382218978035, 11287.435628218556, 11338.03626691724, 611106.0, 629199.0, 629481.0, 635756.0, 645737.0, 89690.10309896948, 122805.0, 122910.38544807398, 125099.0, 131148.34425828, 983.4246965525248, 1001.1290177545727, 1003.5484032185545, 1012.7670635753818, 1018.8217062014118, 18813.623727525646, 18929.716054259472, 18952.24191032343, 19120.23519059222, 19214.0, 52359.73820130875, 52889.735551321995, 54234.72882635562, 55079.0, 56349.71825140848, 77466.4506709874, 77820.0, 78031.6098419527, 78728.21271787208, 78767.60616196883, 8097.635606397608, 8205.220504052106, 8246.05170405411, 8366.790830229293, 8633.56832158377, 7952.880706789519, 12890.935545322214, 13279.734405312032, 13524.59426217215, 13855.0, 11469.827952580885, 11570.537178513101, 11678.0, 11799.52801887915, 11832.230904991147, 9559.0, 10147.49262536885, 11484.36835973996, 11503.137264705349, 11614.419279036183, 11420.657380278604, 11740.236884602473, 11792.705182370166, 11795.35125568102, 12094.516219351479, 8079.757607271791, 8091.06952700447, 8175.877361839458, 8260.297874680478, 8544.530050847263, 8689.6089675966, 11114.777704446027, 11519.654410367702, 11636.41817909118, 11854.0], "unit": "score", "name": "jquery.html", "value": 10513.967580383058}, {"lowerIsBetter": false, "replicates": [1447.3559266126579, 1557.5872393815641, 1596.7604859271112, 1864.3474783825664, 2009.2666176845446, 8121.187881211883, 8753.693620723276, 8943.32925030622, 8947.731568052952, 8948.821023579525, 7476.439267054965, 7795.220477952202, 8798.428102173355, 8805.075467075962, 8805.119488051208, 2187.059564387313, 2245.4274160089153, 2248.2580748353084, 2481.677381940345, 2504.561701702204, 2476.9628455573093, 2544.605586134152, 2547.8089143314232, 2549.6048112542585, 2557.1305756042943, 2449.8162637802147, 2486.105002199207, 2486.589712697412, 2502.1117503286346, 2511.359603301156, 2456.1649039326717, 2488.8382255153447, 2494.787943024845, 2507.009731156183, 2512.321673148258, 2481.5905375613, 2494.1395218649536, 2495.6007038873877, 2498.7626175513296, 2506.7618576235227, 8912.0, 8955.9252889653, 8956.8656470153, 8974.820503589957, 8976.685815996409, 5542.224088627595, 5636.464535869086, 5666.0, 5693.003724348223, 5697.202391665171, 3623.9094022649383, 3694.556653201633, 3763.6612704856693, 3780.773153610792, 3794.430835374716, 1040.6305761454726, 1056.8361903904906, 1059.3537941855461, 1073.291627525837, 1078.3152698036724, 10274.280800343979, 12384.81422778659, 12408.255504669658, 12433.440495177649, 12474.0, 4975.0, 4996.625253106032, 5071.340725705634, 5078.263651770547, 5109.259157422153, 10480.790384192274, 10495.580176792995, 10500.947495262628, 10512.264141510173, 10524.26330156897, 5571.192177134374, 5592.412796656374, 5606.271184746039, 5609.607327487037, 5610.214569960209, 4449.310356894686, 4665.976670116627, 4862.562369386772, 5084.2627818966785, 5094.465081166498, 3832.5209348831395, 3975.185087057146, 3997.0806714455257, 4058.411530328145, 4058.939115913264, 1176.9352685602373, 1321.5837011341396, 1321.9801702974464, 1333.1268019447084, 1337.9264140472173, 1331.8867896228928, 1341.7584834729648, 1362.5980335800962, 1379.951701690436, 1381.7927310903444, 8348.165183481604, 8532.0, 8533.487990720576, 8552.786180345416, 8559.144085591392, 510.8595136337537, 522.3914140026902, 525.2069375243334, 526.1345087331318, 531.4207513809965, 5305.867353316121, 6265.749370025148, 6286.088517165077, 6320.051992201206, 6325.272593651789, 10691.09125724322, 11118.888811111947, 11237.887621123848, 11249.268797528135, 11250.943745281222, 10668.253222274521, 11037.172212084126, 11038.613648522263, 11078.169137314733, 11102.2783519071, 7151.7854464366155, 8463.51888419524, 8580.613872375634, 8644.524551149621, 8647.351448641377, 7900.723474678359, 8116.391270654843, 8136.918630813616, 8152.225538573826, 8161.632726527202, 9392.765180870532, 9405.952970235105, 9829.066238707312, 9905.306628535933, 9913.851292230478, 7448.0, 10201.795964080826, 10286.742831429274, 10353.482325883526, 10356.844647330145, 6217.689115544295, 6748.493862960199, 6890.896636550356, 7125.82185445368, 7566.697332106654, 7969.3226075784205, 8369.874451883348, 8387.07742148351, 8391.622376993171, 8408.2432581068, 7439.367653749492, 7519.586422746802, 7616.9879267070055, 7625.389968802593, 7654.923450765421, 7365.337119659256, 7387.667554960147, 7400.814979625552, 7510.211427800003, 7547.28300811422, 7801.726939557088, 7831.804204894923, 7867.134615192439, 7869.527828330319, 7899.881501777363, 7049.612271325126, 7055.435565154673, 7118.25258347866, 7142.142942846892, 7150.5352152109945, 7205.531640443354, 7206.963965180141, 7256.9274307256255, 7270.272972702687, 7277.090363704537], "unit": "score", "name": "mootools.html", "value": 4909.3150334737775}, {"lowerIsBetter": false, "replicates": [320.20269528873104, 325.0378878519582, 329.6555099920583, 331.97012268895804, 334.6519619595619, 5431.484009019142, 6409.3590640935945, 6444.935550644486, 6455.967045272757, 6543.934560654392, 6355.078513615523, 6389.0, 6399.456046236064, 6428.100065990765, 6444.677766111688, 4604.217283061871, 4664.603508701764, 4727.267273572585, 4806.879828004293, 4848.757562121907, 4769.99830035693, 4795.376601041859, 4806.495317991613, 4808.567228949394, 4825.034993001396, 4792.137415265251, 4799.424069111711, 4808.278758186282, 4811.652737233563, 4811.855644330676, 3705.5923848376656, 3898.610138986107, 4644.6516511261625, 4735.455422626407, 4830.444498882638, 3336.916577085568, 4093.5906409359122, 4109.815058322382, 4114.897127571805, 4116.567760385146, 6155.63066216024, 6179.16581261533, 6193.194884664965, 6195.876082478325, 6198.473129783929, 5552.888942221173, 5560.193771903092, 5570.582206334541, 5572.637778544382, 5603.131514615241, 6814.250432452426, 6833.487488438387, 6838.452923766136, 6847.383735463832, 6849.2465828758795, 4283.250431174532, 4430.534793846632, 4430.889227769331, 4430.933535996963, 4444.755538445384, 5370.5435038021815, 7251.818704532376, 7267.273272672744, 7267.709291628382, 7297.3432391084525, 4518.638508919278, 4519.977400112978, 4520.434945631796, 4522.412086428809, 4529.048899731093, 4550.0217453247715, 4584.312353147055, 4585.12882552314, 4587.931181032221, 4602.838900638461, 4512.481064677539, 5444.128939369682, 5445.618806683494, 5453.291072160594, 5488.4785945335125, 6660.270405216262, 6757.391834734897, 6895.310468953065, 6901.171859376806, 6906.482013848981, 1558.8285288618242, 1586.698527279813, 1592.33122088723, 1594.593378688427, 1598.9200539972956, 962.4514027004681, 1013.3514550687565, 1015.6394479959656, 1028.927975041755, 1044.3551406534739, 4825.613950883921, 5684.033714268584, 6383.393577610213, 6499.642519661369, 6502.869942601122, 7223.530470519399, 7235.819104522324, 7245.9275407246305, 7249.601271930094, 7249.782506524813, 6457.225132984072, 6457.483401327882, 6465.4827613790785, 6470.676466176672, 6479.1901012373455, 3058.938821223563, 3741.569719482294, 3769.1142581493327, 3785.09157802131, 3785.356489396809, 7255.56466612005, 7480.0649918760155, 7551.207123252089, 7557.962210188914, 7585.962070189614, 7384.418556999851, 7418.183999760022, 7422.109346878409, 7442.627868606656, 7445.441591880631, 7501.624918754041, 7514.098308203051, 7515.398768098539, 7515.774526764206, 7562.0, 7183.245759195209, 7207.0630817995425, 7209.855802884018, 7210.242924493063, 7213.71145154188, 6755.763548275787, 6986.336298051677, 6999.8950015750825, 7052.400545953651, 7097.6451177439885, 7467.253274672489, 7500.887486687813, 7505.737299194502, 7520.661570229244, 7531.774046778605, 4505.256632655575, 4538.137753826894, 4540.682152249311, 4540.977295113504, 4550.588188260227, 7120.60836653989, 7125.216226215216, 7129.893051604334, 7138.571685698875, 7139.607321597362, 6613.206415230203, 6833.624150671761, 6857.314268573103, 6870.45036397097, 6875.5530890491955, 6791.320867913169, 6834.521583489108, 6841.110655614738, 6846.520743547904, 6865.897011544931, 6697.531172817856, 6697.732090716317, 6700.262971073275, 6707.228668703162, 6720.428763555153, 5545.279113715191, 6816.829579260559, 6821.181458224846, 6835.69239384219, 6847.07564478789, 6503.0, 6565.901511477236, 6732.091167692299, 6741.629210393476, 6746.325367463214], "unit": "score", "name": "prototype.html", "value": 5004.618058742097}, {"lowerIsBetter": false, "replicates": [662.7315937045498, 681.5365551425032, 746.5184955703571, 772.0889350566331, 815.6574238819693, 15187.316570754316, 15667.608309792233, 15731.370745170194, 15740.449084282052, 15753.684926301481, 14259.930505212125, 14458.277086145677, 14569.27153642319, 15081.039464869578, 15298.69402611947, 913.2648218184376, 922.9353945223837, 930.9255259579218, 931.7577429868215, 932.7994481186544, 725.941924646027, 739.8668239716849, 912.9315301352392, 934.6121359635742, 936.8126374725048, 983.2723784399565, 985.9556319965583, 986.8075725233582, 987.5407935310079, 988.8912219655832, 773.1109224391938, 972.9951350243203, 976.6484065736329, 978.1783302026297, 978.5351957820014, 712.2948281201625, 725.2602345607504, 725.9237780033073, 726.8001299642588, 726.8001299642588, 15542.611434714223, 15597.0, 15604.0, 15638.732383804398, 15653.608659783482, 12809.167404118796, 12917.22496650204, 12994.350282485932, 13062.0, 13133.540326088636, 10162.847557286646, 10320.638777642747, 10332.431716255604, 10699.83950240747, 11235.045021173128, 3609.855605775766, 3664.8350824212976, 3672.3573374659327, 3767.2088861339153, 3792.2984247913946, 88513.55743221307, 89531.55234223853, 89640.10359896383, 89665.55167224187, 89934.0, 9558.90441095594, 9831.950840245896, 9849.60601575929, 9896.950515247378, 9914.80170396588, 21297.36107916765, 21369.931503424767, 21370.57258854814, 21378.78621213799, 21429.82135982536, 7512.511686740344, 7516.398688104939, 7528.360089392463, 7551.622418879034, 7610.885836712454, 4145.3781932709735, 4170.16596680665, 4182.53992060873, 4204.642605378516, 4211.368294755811, 3691.9630803692157, 3745.606711295329, 3747.5877653458097, 3747.662710356081, 3750.4561838533805, 654.6105067484839, 659.7031335898769, 668.8027032025564, 674.578388507183, 685.5235611250133, 540.9486098820606, 582.6416753696446, 594.5659668442062, 602.1599868183858, 618.2766163588612, 8280.875786863202, 8306.335493160532, 8390.538520381439, 8435.367347448966, 8624.310055195569, 539.8839249561363, 597.4964897081215, 600.2646757721756, 600.5195843325322, 600.9338972712998, 3815.9427608585893, 3837.347650899354, 3904.4143378493454, 3929.842806287774, 3993.5207775066597, 89556.0, 89954.0, 92328.0, 94363.0, 94422.58366124514, 81371.5931420339, 81706.0, 82162.76755848667, 82234.58882705668, 82829.0, 58490.70754646199, 71028.51400200969, 73441.0, 73780.63109684417, 74199.17705349135, 7762.7671169865, 7860.489068210548, 7989.053628232888, 8053.919460805317, 8127.634256458356, 51021.0, 51457.71355716137, 51954.74022629863, 51974.48025519696, 52092.8617490956, 68526.314736854, 68993.27516811919, 69483.0, 69523.65238173777, 69607.0, 9890.208783297463, 10079.949600251952, 10106.545205465918, 10792.0, 11039.282446641264, 12064.215825971283, 12225.572104976283, 12281.570145044881, 12463.376831158586, 13032.54386096482, 9358.29812764059, 11929.224600400947, 11939.343336116597, 12015.75968480608, 12038.03695704359, 11493.252938558968, 11820.23168494045, 11841.5855445059, 11869.287842729464, 12024.33866137371, 11520.654380368602, 11575.247608905394, 11735.706607334885, 11802.409879505818, 12045.277283363026, 9811.803763924825, 10039.849402259119, 10049.849252261076, 10317.123044541298, 10534.42060686639, 9727.9027209727, 9753.414795112032, 9915.603375865174, 9934.850977235203, 9963.50182490887], "unit": "score", "name": "yui.html", "value": 7064.1584430954845}], "name": "dromaeo_css", "value": 7653.271950534057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 110.0, 114.0, 110.0, 116.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [177.0, 197.0, 142.0, 155.0, 118.0, 144.0, 137.0, 118.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 184.0, 186.0, 205.0, 266.0, 189.0, 185.0, 187.0, 185.0], "unit": "score", "name": "audio-dft", "value": 196.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 88.0, 77.0, 56.0, 56.0, 59.0, 73.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 68.7}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 126.0, 80.0, 79.0, 80.0, 117.0, 76.0, 79.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [89.0, 84.0, 87.0, 85.0, 86.0, 85.0, 87.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 101.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 83.0, 84.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [62.0, 67.0, 79.0, 91.0, 100.0, 67.0, 65.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.1}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 82.0, 90.0, 83.0, 82.0, 84.0, 81.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [129.0, 134.0, 130.0, 123.0, 129.0, 135.0, 113.0, 117.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 137.0, 142.0, 138.0, 126.0, 138.0, 141.0, 136.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 65.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1431.0}]} 18:03:25 INFO - Return code: 0 18:03:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:03:25 ERROR - # TBPL SUCCESS # 18:03:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:03:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:03:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:03:25 INFO - 2016-03-09 18:03:25.983 screenresolution[1676:9701] starting screenresolution argv=screenresolution get 18:03:25 INFO - 2016-03-09 18:03:25.985 screenresolution[1676:9701] Display 0: 1600x1200x32@60 18:03:25 INFO - 2016-03-09 18:03:25.991 screenresolution[1677:9704] starting screenresolution argv=screenresolution list 18:03:25 INFO - Available Modes on Display 0 18:03:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:03:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:03:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:03:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:03:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:03:26 INFO - Intel Iris: 18:03:26 INFO - Chipset Model: Intel Iris 18:03:26 INFO - Type: GPU 18:03:26 INFO - Bus: Built-In 18:03:26 INFO - VRAM (Dynamic, Max): 1536 MB 18:03:26 INFO - Vendor: Intel (0x8086) 18:03:26 INFO - Device ID: 0x0a2e 18:03:26 INFO - Revision ID: 0x0009 18:03:26 INFO - Displays: 18:03:26 INFO - Display: 18:03:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:03:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:03:26 INFO - Display Serial Number: 1600x1200 60 18:03:26 INFO - Main Display: Yes 18:03:26 INFO - Mirror: Off 18:03:26 INFO - Online: Yes 18:03:26 INFO - Rotation: Supported 18:03:26 INFO - Return code: 0 18:03:26 INFO - Running post-action listener: _resource_record_post_action 18:03:26 INFO - Running post-run listener: _resource_record_post_run 18:03:27 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39130624; Write bytes: 702741504; Read time: 436; Write time: 2023 18:03:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395309568; Write bytes: 389101056; Read time: 29533; Write time: 636 18:03:27 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 37303808; Write bytes: 298464768; Read time: 414; Write time: 1348 18:03:27 INFO - Running post-run listener: _upload_blobber_files 18:03:27 INFO - Blob upload gear active. 18:03:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:03:27 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 18:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:03:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:28 INFO - (blobuploader) - INFO - Done attempting. 18:03:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:03:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:30 INFO - (blobuploader) - INFO - Done attempting. 18:03:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:03:30 INFO - Return code: 0 18:03:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:03:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:03:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f8b1c04fcd752f3a6d03dfd7bf873706fdbf1bb05108ffedb7d0ae1a83c54b8a1cd1d159345249fe30ccde18850bad46108f50b90730d23e3cb0d30a5ead7d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/689554d32a6dac54f5a10c5ecae45aa9f98957f19b0418f2399b3b017f170ad3bc7f783e6a1152920e1e64ca6bb285be5a232114364a929d19085ef6ef91c63a"} 18:03:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:03:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:03:30 INFO - Contents: 18:03:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f8b1c04fcd752f3a6d03dfd7bf873706fdbf1bb05108ffedb7d0ae1a83c54b8a1cd1d159345249fe30ccde18850bad46108f50b90730d23e3cb0d30a5ead7d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/689554d32a6dac54f5a10c5ecae45aa9f98957f19b0418f2399b3b017f170ad3bc7f783e6a1152920e1e64ca6bb285be5a232114364a929d19085ef6ef91c63a"} 18:03:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:03:30 INFO - Copying logs to upload dir... 18:03:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:03:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.255844 ========= master_lag: 34.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-03-09 18:04:04.707403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-09 18:04:04.714502) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f8b1c04fcd752f3a6d03dfd7bf873706fdbf1bb05108ffedb7d0ae1a83c54b8a1cd1d159345249fe30ccde18850bad46108f50b90730d23e3cb0d30a5ead7d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/689554d32a6dac54f5a10c5ecae45aa9f98957f19b0418f2399b3b017f170ad3bc7f783e6a1152920e1e64ca6bb285be5a232114364a929d19085ef6ef91c63a"} build_url:https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f8b1c04fcd752f3a6d03dfd7bf873706fdbf1bb05108ffedb7d0ae1a83c54b8a1cd1d159345249fe30ccde18850bad46108f50b90730d23e3cb0d30a5ead7d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/689554d32a6dac54f5a10c5ecae45aa9f98957f19b0418f2399b3b017f170ad3bc7f783e6a1152920e1e64ca6bb285be5a232114364a929d19085ef6ef91c63a"}' ========= master_lag: 1.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-09 18:04:06.101587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-09 18:04:06.101985) ========= 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.vU7PvNWLa0/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.YWh2A7a6fs/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005005 ========= master_lag: 10.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-09 18:04:17.033579) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-09 18:04:17.033885) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-09 18:04:20.557514) ========= ========= Total master_lag: 46.96 =========