builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1460130924.57 results: success (0) buildid: 20160408075804 builduid: 24f4692b59ad443b8b745a78d84c7b44 revision: 1ea84d818c7d58b4bde2766fa9f6e64818d6822d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:24.571111) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:24.571587) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:24.572214) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005436 basedir: '/builds/slave/test' ========= master_lag: 0.18 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:24.762449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:24.762800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.000128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.000432) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.004992 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.062433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.062742) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.063147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.063458) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-08 08:55: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% 15.1M=0.001s 2016-04-08 08:55:25 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.470803 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.581144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.581466) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.025727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:25.633625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 08:55:25.633988) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ea84d818c7d58b4bde2766fa9f6e64818d6822d --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 1ea84d818c7d58b4bde2766fa9f6e64818d6822d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-08 08:55:25,710 truncating revision to first 12 chars 2016-04-08 08:55:25,710 Setting DEBUG logging. 2016-04-08 08:55:25,710 attempt 1/10 2016-04-08 08:55:25,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ea84d818c7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 08:55:27,808 unpacking tar archive at: fx-team-1ea84d818c7d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.338184 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 08:55:27.988698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:27.992146) ========= echo 1ea84d818c7d58b4bde2766fa9f6e64818d6822d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1ea84d818c7d58b4bde2766fa9f6e64818d6822d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 1ea84d818c7d58b4bde2766fa9f6e64818d6822d program finished with exit code 0 elapsedTime=0.005312 script_repo_revision: '1ea84d818c7d58b4bde2766fa9f6e64818d6822d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:28.045004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:28.045363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 08:55:28.056954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-08 08:55:28.057277) ========= /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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:55:28 INFO - MultiFileLogger online at 20160408 08:55:28 in /builds/slave/test 08:55:28 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 08:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:28 INFO - {'append_to_log': False, 08:55:28 INFO - 'base_work_dir': '/builds/slave/test', 08:55:28 INFO - 'blob_upload_branch': 'Fx-Team', 08:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:28 INFO - 'branch': 'Fx-Team', 08:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:28 INFO - 'config_files': ('talos/mac_config.py',), 08:55:28 INFO - 'default_actions': ('clobber', 08:55:28 INFO - 'read-buildbot-config', 08:55:28 INFO - 'download-and-extract', 08:55:28 INFO - 'populate-webroot', 08:55:28 INFO - 'create-virtualenv', 08:55:28 INFO - 'install', 08:55:28 INFO - 'run-tests'), 08:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:28 INFO - 'download_minidump_stackwalk': True, 08:55:28 INFO - 'download_symbols': 'ondemand', 08:55:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:28 INFO - 'installer_path': 'installer.exe', 08:55:28 INFO - 'log_level': 'info', 08:55:28 INFO - 'log_name': 'talos', 08:55:28 INFO - 'log_to_console': True, 08:55:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:28 INFO - 'opt_config_files': (), 08:55:28 INFO - 'pip_index': False, 08:55:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:28 INFO - 'cmd': ('bash', 08:55:28 INFO - '-c', 08:55:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:28 INFO - 'enabled': True, 08:55:28 INFO - 'halt_on_failure': False, 08:55:28 INFO - 'name': 'check_screen_resolution'},), 08:55:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:28 INFO - 'cmd': ('bash', 08:55:28 INFO - '-c', 08:55:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:28 INFO - 'enabled': True, 08:55:28 INFO - 'halt_on_failure': False, 08:55:28 INFO - 'name': 'check_screen_resolution'},), 08:55:28 INFO - 'run_cmd_checks_enabled': True, 08:55:28 INFO - 'sps_profile': False, 08:55:28 INFO - 'sps_profile_interval': 0, 08:55:28 INFO - 'suite': 'dromaeojs', 08:55:28 INFO - 'system_bits': '32', 08:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:28 INFO - 'title': 't-yosemite-r7-0005', 08:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:28 INFO - 'use_talos_json': True, 08:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:28 INFO - 'work_dir': 'build'} 08:55:28 INFO - ##### 08:55:28 INFO - ##### Running clobber step. 08:55:28 INFO - ##### 08:55:28 INFO - Running pre-action listener: _resource_record_pre_action 08:55:28 INFO - Running main action method: clobber 08:55:28 INFO - rmtree: /builds/slave/test/build 08:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:29 INFO - Running post-action listener: _resource_record_post_action 08:55:29 INFO - ##### 08:55:29 INFO - ##### Running read-buildbot-config step. 08:55:29 INFO - ##### 08:55:29 INFO - Running pre-action listener: _resource_record_pre_action 08:55:29 INFO - Running main action method: read_buildbot_config 08:55:29 INFO - Using buildbot properties: 08:55:29 INFO - { 08:55:29 INFO - "project": "", 08:55:29 INFO - "product": "firefox", 08:55:29 INFO - "script_repo_revision": "production", 08:55:29 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:55:29 INFO - "repository": "", 08:55:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:55:29 INFO - "buildid": "20160408075804", 08:55:29 INFO - "pgo_build": "False", 08:55:29 INFO - "basedir": "/builds/slave/test", 08:55:29 INFO - "buildnumber": 591, 08:55:29 INFO - "slavename": "t-yosemite-r7-0005", 08:55:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:55:29 INFO - "platform": "yosemite_r7", 08:55:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:55:29 INFO - "branch": "fx-team", 08:55:29 INFO - "repo_path": "integration/fx-team", 08:55:29 INFO - "revision": "1ea84d818c7d58b4bde2766fa9f6e64818d6822d", 08:55:29 INFO - "stage_platform": "macosx64", 08:55:29 INFO - "builduid": "24f4692b59ad443b8b745a78d84c7b44", 08:55:29 INFO - "slavebuilddir": "test" 08:55:29 INFO - } 08:55:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:55:29 INFO - Running post-action listener: _resource_record_post_action 08:55:29 INFO - ##### 08:55:29 INFO - ##### Running download-and-extract step. 08:55:29 INFO - ##### 08:55:29 INFO - Running pre-action listener: _resource_record_pre_action 08:55:29 INFO - Running main action method: download_and_extract 08:55:29 INFO - mkdir: /builds/slave/test/build/tests 08:55: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')]} 08:55:29 INFO - https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:31 INFO - Downloaded 1199 bytes. 08:55:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:55:31 INFO - Using the following test package requirements: 08:55:31 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:55:31 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:55:31 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:55:31 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'jsshell-mac.zip'], 08:55:31 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:55:31 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:55:31 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:55:31 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:55:31 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:55:31 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:55:31 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:55:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:55:31 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')]} 08:55:31 INFO - https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:55:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:55:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:32 INFO - Downloaded 18014531 bytes. 08:55:32 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'] 08:55:32 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 08:55:35 INFO - Return code: 0 08:55:35 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 08:55:35 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')]} 08:55:35 INFO - https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:36 INFO - Downloaded 18014531 bytes. 08:55:36 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'] 08:55:36 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 08:55:40 INFO - Return code: 0 08:55: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')]} 08:55:40 INFO - https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:41 INFO - Downloaded 10847693 bytes. 08:55:41 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'] 08:55:41 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 08:55:41 INFO - Return code: 0 08:55:41 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')]} 08:55:41 INFO - https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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 08:55:46 INFO - Downloaded 108786308 bytes. 08:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:55:46 INFO - mkdir: /builds/slave/test/properties 08:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:46 INFO - Contents: 08:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:55:47 INFO - Running post-action listener: _resource_record_post_action 08:55:47 INFO - Running post-action listener: set_extra_try_arguments 08:55:47 INFO - ##### 08:55:47 INFO - ##### Running populate-webroot step. 08:55:47 INFO - ##### 08:55:47 INFO - Running pre-action listener: _resource_record_pre_action 08:55:47 INFO - Running main action method: populate_webroot 08:55:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:47 INFO - '--tppagecycles', 08:55:47 INFO - '7'], 08:55:47 INFO - 'tests': ['tsvgm']}}, 08:55:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['damp', 'tps']}, 08:55:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'tests': ['damp', 'tps']}, 08:55:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['dromaeo_dom']}, 08:55:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['a11yr', 08:55:47 INFO - 'ts_paint', 08:55:47 INFO - 'tpaint', 08:55:47 INFO - 'sessionrestore', 08:55:47 INFO - 'sessionrestore_no_auto_restore', 08:55:47 INFO - 'tabpaint']}, 08:55:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['tsvgx', 08:55:47 INFO - 'tsvgr_opacity', 08:55:47 INFO - 'tart', 08:55:47 INFO - 'tscrollx', 08:55:47 INFO - 'cart']}, 08:55:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:47 INFO - 'tsvgr_opacity', 08:55:47 INFO - 'tart', 08:55:47 INFO - 'tscrollx', 08:55:47 INFO - 'cart']}, 08:55:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'talos_options': ['--disable-e10s'], 08:55:47 INFO - 'tests': ['tp5o']}, 08:55:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'tests': ['tp5o']}, 08:55:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'talos_options': ['--disable-e10s', 08:55:47 INFO - '--xperf_path', 08:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:47 INFO - 'tests': ['tp5n']}, 08:55:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:47 INFO - 'talos_options': ['--xperf_path', 08:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:47 INFO - 'tests': ['tp5n']}}, 08:55:47 INFO - 'talos.zip': {'path': '', 08:55:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:47 INFO - Running post-action listener: _resource_record_post_action 08:55:47 INFO - ##### 08:55:47 INFO - ##### Running create-virtualenv step. 08:55:47 INFO - ##### 08:55:47 INFO - Running pre-action listener: _resource_record_pre_action 08:55:47 INFO - Running main action method: create_virtualenv 08:55:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:47 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 08:55:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:47 INFO - Using real prefix '/tools/python27' 08:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:51 INFO - Installing pip.................done. 08:55:51 INFO - Return code: 0 08:55:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:51 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:55:51 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 08:55:51 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 08:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:51 INFO - 'HOME': '/Users/cltbld', 08:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:51 INFO - 'LOGNAME': 'cltbld', 08:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:51 INFO - 'MOZ_NO_REMOTE': '1', 08:55:51 INFO - 'NO_EM_RESTART': '1', 08:55:51 INFO - 'PAGER': '/bin/cat', 08:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:51 INFO - 'PWD': '/builds/slave/test', 08:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:51 INFO - 'SHELL': '/bin/bash', 08:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:55:51 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:51 INFO - 'USER': 'cltbld', 08:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:51 INFO - 'XPC_FLAGS': '0x0', 08:55:51 INFO - 'XPC_SERVICE_NAME': '0', 08:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:51 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 08:55:51 INFO - Cleaning up... 08:55:51 INFO - Return code: 0 08:55:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:51 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:55:51 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 08:55:51 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 08:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:51 INFO - 'HOME': '/Users/cltbld', 08:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:51 INFO - 'LOGNAME': 'cltbld', 08:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:51 INFO - 'MOZ_NO_REMOTE': '1', 08:55:51 INFO - 'NO_EM_RESTART': '1', 08:55:51 INFO - 'PAGER': '/bin/cat', 08:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:51 INFO - 'PWD': '/builds/slave/test', 08:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:51 INFO - 'SHELL': '/bin/bash', 08:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:55:51 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:51 INFO - 'USER': 'cltbld', 08:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:51 INFO - 'XPC_FLAGS': '0x0', 08:55:51 INFO - 'XPC_SERVICE_NAME': '0', 08:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:51 INFO - Downloading/unpacking psutil>=0.7.1 08:55:51 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 08:55:51 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 08:55:51 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 08:55:51 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 08:55:51 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 08:55:51 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 08:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:54 INFO - Installing collected packages: psutil 08:55:54 INFO - Running setup.py install for psutil 08:55:54 INFO - building 'psutil._psutil_osx' extension 08:55:54 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 08:55:55 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 08:55:55 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 08:55:55 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 08:55:55 INFO - building 'psutil._psutil_posix' extension 08:55:55 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 08:55:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:55:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:55:55 INFO - ^ 08:55:55 INFO - 1 warning generated. 08:55:55 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 08:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:55 INFO - Successfully installed psutil 08:55:55 INFO - Cleaning up... 08:55:55 INFO - Return code: 0 08:55:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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', '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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:55: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:55: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 mozsystemmonitor==0.0.0 08:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:55 INFO - 'HOME': '/Users/cltbld', 08:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:55 INFO - 'LOGNAME': 'cltbld', 08:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:55 INFO - 'MOZ_NO_REMOTE': '1', 08:55:55 INFO - 'NO_EM_RESTART': '1', 08:55:55 INFO - 'PAGER': '/bin/cat', 08:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:55 INFO - 'PWD': '/builds/slave/test', 08:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:55 INFO - 'SHELL': '/bin/bash', 08:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:55:55 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:55 INFO - 'USER': 'cltbld', 08:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:55 INFO - 'XPC_FLAGS': '0x0', 08:55:55 INFO - 'XPC_SERVICE_NAME': '0', 08:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:55:58 INFO - Installing collected packages: mozsystemmonitor 08:55:58 INFO - Running setup.py install for mozsystemmonitor 08:55:58 INFO - Successfully installed mozsystemmonitor 08:55:58 INFO - Cleaning up... 08:55:58 INFO - Return code: 0 08:55:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:58 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')]} 08:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:58 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')]} 08:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:58 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:55:58 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 08:55:58 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 08:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:58 INFO - 'HOME': '/Users/cltbld', 08:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:58 INFO - 'LOGNAME': 'cltbld', 08:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:58 INFO - 'MOZ_NO_REMOTE': '1', 08:55:58 INFO - 'NO_EM_RESTART': '1', 08:55:58 INFO - 'PAGER': '/bin/cat', 08:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:58 INFO - 'PWD': '/builds/slave/test', 08:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:58 INFO - 'SHELL': '/bin/bash', 08:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:55:58 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:58 INFO - 'USER': 'cltbld', 08:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:58 INFO - 'XPC_FLAGS': '0x0', 08:55:58 INFO - 'XPC_SERVICE_NAME': '0', 08:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:56:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:01 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 08:56:01 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 08:56:01 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 08:56:01 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 08:56:01 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 08:56:01 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 08:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:02 INFO - Downloading docopt-0.6.1.tar.gz 08:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:02 INFO - Running setup.py install for blobuploader 08:56:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:02 INFO - Running setup.py install for requests 08:56:03 INFO - Running setup.py install for docopt 08:56:03 INFO - Successfully installed blobuploader requests docopt 08:56:03 INFO - Cleaning up... 08:56:03 INFO - Return code: 0 08:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:03 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:03 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 08:56:03 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 08:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:03 INFO - 'HOME': '/Users/cltbld', 08:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:03 INFO - 'LOGNAME': 'cltbld', 08:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:03 INFO - 'MOZ_NO_REMOTE': '1', 08:56:03 INFO - 'NO_EM_RESTART': '1', 08:56:03 INFO - 'PAGER': '/bin/cat', 08:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:03 INFO - 'PWD': '/builds/slave/test', 08:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:03 INFO - 'SHELL': '/bin/bash', 08:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:03 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:03 INFO - 'USER': 'cltbld', 08:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:03 INFO - 'XPC_FLAGS': '0x0', 08:56:03 INFO - 'XPC_SERVICE_NAME': '0', 08:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:03 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-amy15i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:03 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ZMACwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8LRkxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-iH0o3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yr51VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PDdZRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-HdtoeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6aBnp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OMUMyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-v3oDZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:04 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Hq59Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-2jIFpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-vKOlv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-i2byQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-x2jZPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ttu5Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:05 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-WwruYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:05 INFO - Running setup.py install for manifestparser 08:56:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:05 INFO - Running setup.py install for mozcrash 08:56:05 INFO - Running setup.py install for mozdebug 08:56:06 INFO - Running setup.py install for mozdevice 08:56:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozfile 08:56:06 INFO - Running setup.py install for mozhttpd 08:56:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozinfo 08:56:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozInstall 08:56:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozleak 08:56:06 INFO - Running setup.py install for mozlog 08:56:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for moznetwork 08:56:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for mozprocess 08:56:07 INFO - Running setup.py install for mozprofile 08:56:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for mozrunner 08:56:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for mozscreenshot 08:56:07 INFO - Running setup.py install for moztest 08:56:08 INFO - Running setup.py install for mozversion 08:56:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:08 INFO - Cleaning up... 08:56:08 INFO - Return code: 0 08:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:08 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:08 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 08:56:08 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 08:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:08 INFO - 'HOME': '/Users/cltbld', 08:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:08 INFO - 'LOGNAME': 'cltbld', 08:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:08 INFO - 'MOZ_NO_REMOTE': '1', 08:56:08 INFO - 'NO_EM_RESTART': '1', 08:56:08 INFO - 'PAGER': '/bin/cat', 08:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:08 INFO - 'PWD': '/builds/slave/test', 08:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:08 INFO - 'SHELL': '/bin/bash', 08:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:08 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:08 INFO - 'USER': 'cltbld', 08:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:08 INFO - 'XPC_FLAGS': '0x0', 08:56:08 INFO - 'XPC_SERVICE_NAME': '0', 08:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Fb2bXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OFsBwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ZQjjuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RWh3ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wzmVMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-EyMetm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3ad1ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-GVMLuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zhTmO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pGpsKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-us6W6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-_q2mnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jwxe52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-SzbnNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jQzwuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:10 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)) 08:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8YYpxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:10 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)) 08:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wSSgIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:10 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)) 08:56:10 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)) 08:56:10 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)) 08:56:10 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)) 08:56:10 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)) 08:56:10 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)) 08:56:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:12 INFO - Downloading blessings-1.6.tar.gz 08:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:12 INFO - Installing collected packages: blessings 08:56:12 INFO - Running setup.py install for blessings 08:56:12 INFO - Successfully installed blessings 08:56:12 INFO - Cleaning up... 08:56:13 INFO - Return code: 0 08:56:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:13 INFO - Reading from file tmpfile_stdout 08:56:13 INFO - Current package versions: 08:56:13 INFO - blessings == 1.6 08:56:13 INFO - blobuploader == 1.2.4 08:56:13 INFO - docopt == 0.6.1 08:56:13 INFO - manifestparser == 1.1 08:56:13 INFO - mozInstall == 1.12 08:56:13 INFO - mozcrash == 0.17 08:56:13 INFO - mozdebug == 0.1 08:56:13 INFO - mozdevice == 0.48 08:56:13 INFO - mozfile == 1.2 08:56:13 INFO - mozhttpd == 0.7 08:56:13 INFO - mozinfo == 0.9 08:56:13 INFO - mozleak == 0.1 08:56:13 INFO - mozlog == 3.1 08:56:13 INFO - moznetwork == 0.27 08:56:13 INFO - mozprocess == 0.22 08:56:13 INFO - mozprofile == 0.28 08:56:13 INFO - mozrunner == 6.11 08:56:13 INFO - mozscreenshot == 0.1 08:56:13 INFO - mozsystemmonitor == 0.0 08:56:13 INFO - moztest == 0.7 08:56:13 INFO - mozversion == 1.4 08:56:13 INFO - psutil == 3.1.1 08:56:13 INFO - requests == 1.2.3 08:56:13 INFO - wsgiref == 0.1.2 08:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:13 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:13 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 08:56:13 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 08:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:13 INFO - 'HOME': '/Users/cltbld', 08:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:13 INFO - 'LOGNAME': 'cltbld', 08:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:13 INFO - 'MOZ_NO_REMOTE': '1', 08:56:13 INFO - 'NO_EM_RESTART': '1', 08:56:13 INFO - 'PAGER': '/bin/cat', 08:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:13 INFO - 'PWD': '/builds/slave/test', 08:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:13 INFO - 'SHELL': '/bin/bash', 08:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:13 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:13 INFO - 'USER': 'cltbld', 08:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:13 INFO - 'XPC_FLAGS': '0x0', 08:56:13 INFO - 'XPC_SERVICE_NAME': '0', 08:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 INFO - Cleaning up... 08:56:13 INFO - Return code: 0 08:56:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56: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', 'jsonschema'] in /builds/slave/test/build 08:56: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 jsonschema 08:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:13 INFO - 'HOME': '/Users/cltbld', 08:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:13 INFO - 'LOGNAME': 'cltbld', 08:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:13 INFO - 'MOZ_NO_REMOTE': '1', 08:56:13 INFO - 'NO_EM_RESTART': '1', 08:56:13 INFO - 'PAGER': '/bin/cat', 08:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:13 INFO - 'PWD': '/builds/slave/test', 08:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:13 INFO - 'SHELL': '/bin/bash', 08:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:13 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:13 INFO - 'USER': 'cltbld', 08:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:13 INFO - 'XPC_FLAGS': '0x0', 08:56:13 INFO - 'XPC_SERVICE_NAME': '0', 08:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:13 INFO - Downloading/unpacking jsonschema 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:16 INFO - Downloading/unpacking functools32 (from jsonschema) 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:16 INFO - warning: no files found matching '*.txt' 08:56:16 INFO - no previously-included directories found matching 'build' 08:56:16 INFO - no previously-included directories found matching 'dist' 08:56:16 INFO - no previously-included directories found matching '.git*' 08:56:16 INFO - Installing collected packages: jsonschema, functools32 08:56:16 INFO - Running setup.py install for functools32 08:56:16 INFO - warning: no files found matching '*.txt' 08:56:16 INFO - no previously-included directories found matching 'build' 08:56:16 INFO - no previously-included directories found matching 'dist' 08:56:16 INFO - no previously-included directories found matching '.git*' 08:56:16 INFO - Successfully installed jsonschema functools32 08:56:16 INFO - Cleaning up... 08:56:16 INFO - Return code: 0 08:56:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:16 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 0x10ec59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec69420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c87a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, '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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:16 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 08:56:16 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 08:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:16 INFO - 'HOME': '/Users/cltbld', 08:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:16 INFO - 'LOGNAME': 'cltbld', 08:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:16 INFO - 'MOZ_NO_REMOTE': '1', 08:56:16 INFO - 'NO_EM_RESTART': '1', 08:56:16 INFO - 'PAGER': '/bin/cat', 08:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:16 INFO - 'PWD': '/builds/slave/test', 08:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:16 INFO - 'SHELL': '/bin/bash', 08:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:16 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:16 INFO - 'USER': 'cltbld', 08:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:16 INFO - 'XPC_FLAGS': '0x0', 08:56:16 INFO - 'XPC_SERVICE_NAME': '0', 08:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:17 INFO - Downloading/unpacking flake8 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:56:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:56:19 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 08:56:19 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 08:56:19 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 08:56:19 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 08:56:19 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 08:56:19 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 08:56:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:56:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 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 08:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:56:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:20 INFO - no previously-included directories found matching 'docs/_build' 08:56:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:56:21 INFO - Running setup.py install for pep8 08:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:21 INFO - no previously-included directories found matching 'docs/_build' 08:56:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:56:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:56:21 INFO - Cleaning up... 08:56:21 INFO - Return code: 0 08:56:21 INFO - Running post-action listener: _resource_record_post_action 08:56:21 INFO - Running post-action listener: _start_resource_monitoring 08:56:21 INFO - Starting resource monitoring. 08:56:21 INFO - ##### 08:56:21 INFO - ##### Running install step. 08:56:21 INFO - ##### 08:56:21 INFO - Running pre-action listener: _resource_record_pre_action 08:56:21 INFO - Running main action method: install 08:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:21 INFO - Reading from file tmpfile_stdout 08:56:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:21 INFO - Reading from file tmpfile_stdout 08:56:21 INFO - Output received: 08:56:21 INFO - Usage: mozinstall [options] installer 08:56:21 INFO - Options: 08:56:21 INFO - -h, --help show this help message and exit 08:56:21 INFO - -d DEST, --destination=DEST 08:56:21 INFO - Directory to install application into. [default: 08:56:21 INFO - "/builds/slave/test"] 08:56:21 INFO - --app=APP Application being installed. [default: firefox] 08:56:21 INFO - mkdir: /builds/slave/test/build/application 08:56:21 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'] 08:56:21 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 08:56:55 INFO - Reading from file tmpfile_stdout 08:56:55 INFO - Output received: 08:56:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:56:55 INFO - Running post-action listener: _resource_record_post_action 08:56:55 INFO - ##### 08:56:55 INFO - ##### Running run-tests step. 08:56:55 INFO - ##### 08:56:55 INFO - Running pre-action listener: _resource_record_pre_action 08:56:55 INFO - Running main action method: run_tests 08:56:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:55 INFO - 2016-04-08 08:56:55.170 screenresolution[1649:7953] starting screenresolution argv=screenresolution get 08:56:55 INFO - 2016-04-08 08:56:55.173 screenresolution[1649:7953] Display 0: 1600x1200x32@60 08:56:55 INFO - 2016-04-08 08:56:55.179 screenresolution[1650:7956] starting screenresolution argv=screenresolution list 08:56:55 INFO - Available Modes on Display 0 08:56:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:55 INFO - Intel Iris: 08:56:55 INFO - Chipset Model: Intel Iris 08:56:55 INFO - Type: GPU 08:56:55 INFO - Bus: Built-In 08:56:55 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:55 INFO - Vendor: Intel (0x8086) 08:56:55 INFO - Device ID: 0x0a2e 08:56:55 INFO - Revision ID: 0x0009 08:56:55 INFO - Displays: 08:56:55 INFO - Display: 08:56:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:55 INFO - Display Serial Number: 1600x1200 60 08:56:55 INFO - Main Display: Yes 08:56:55 INFO - Mirror: Off 08:56:55 INFO - Online: Yes 08:56:55 INFO - Rotation: Supported 08:56:55 INFO - Return code: 0 08:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:55 INFO - Python 2.7.3 08:56:55 INFO - Return code: 0 08:56:55 INFO - grabbing minidump binary from tooltool 08:56: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')]} 08:56:55 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 0x10eaf8e00>, '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 0x10e921db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:55 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 08:56:55 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 08:56:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:55 INFO - Return code: 0 08:56:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:56:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:56:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:56:56 INFO - Return code: 0 08:56:56 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/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 08:56:56 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/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --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 08:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4iHrcSnDs/Render', 08:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:56 INFO - 'HOME': '/Users/cltbld', 08:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:56 INFO - 'LOGNAME': 'cltbld', 08:56:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:56 INFO - 'MOZ_NO_REMOTE': '1', 08:56:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:56 INFO - 'NO_EM_RESTART': '1', 08:56:56 INFO - 'PAGER': '/bin/cat', 08:56:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:56 INFO - 'PWD': '/builds/slave/test', 08:56:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:56 INFO - 'SHELL': '/bin/bash', 08:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWRlXBdKUY/Listeners', 08:56:56 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:56 INFO - 'USER': 'cltbld', 08:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:56 INFO - 'XPC_FLAGS': '0x0', 08:56:56 INFO - 'XPC_SERVICE_NAME': '0', 08:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:56 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/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 08:56:57 INFO - mozversion application_buildid: 20160408075804 08:56:57 INFO - mozversion application_changeset: 1ea84d818c7d58b4bde2766fa9f6e64818d6822d 08:56:57 INFO - mozversion application_display_name: Nightly 08:56:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:57 INFO - mozversion application_name: Firefox 08:56:57 INFO - mozversion application_remotingname: firefox 08:56:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:56:57 INFO - mozversion application_vendor: Mozilla 08:56:57 INFO - mozversion application_version: 48.0a1 08:56:57 INFO - mozversion platform_buildid: 20160408075804 08:56:57 INFO - mozversion platform_changeset: 1ea84d818c7d58b4bde2766fa9f6e64818d6822d 08:56:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:56:57 INFO - mozversion platform_version: 48.0a1 08:56:57 INFO - using testdate: 1460131017 08:56:57 INFO - actual date: 1460131017 08:56:57 INFO - starting webserver on 'localhost:49276' 08:56:57 INFO - SUITE-START | Running 2 tests 08:56:57 INFO - TEST-START | dromaeo_css 08:56:57 INFO - operating with platform_type : mac_ 08:56:57 INFO - Initialising browser for dromaeo_css test... 08:56:57 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpSxr3CV/profile http://localhost:49276/getInfo.html) 08:56:59 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 08:56:59 INFO - PROCESS | 1668 | colorDepth:24 08:56:59 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 08:56:59 INFO - PROCESS | 1668 | __metrics 08:56:59 INFO - PROCESS | 1668 | 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" 08:56:59 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:56:59 INFO - TEST-INFO | 1668: exit 0 08:56:59 INFO - Browser initialized. 08:56:59 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:59 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpSxr3CV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:11 INFO - PROCESS | 1671 | RSS: Main: 237424640 08:57:11 INFO - PROCESS | 1671 | 08:58:03 INFO - PROCESS | 1671 | 1460131083307 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] 09:00:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 09:00:14 INFO - PROCESS | 1671 | RSS: Main: 350404608 09:00:14 INFO - PROCESS | 1671 | 09:03:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 09:03:17 INFO - PROCESS | 1671 | RSS: Main: 378802176 09:03:17 INFO - PROCESS | 1671 | 09:06:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 09:06:20 INFO - PROCESS | 1671 | RSS: Main: 378032128 09:06:20 INFO - PROCESS | 1671 | 09:09:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 09:09:23 INFO - PROCESS | 1671 | RSS: Main: 335818752 09:09:23 INFO - PROCESS | 1671 | 09:12:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 09:12:27 INFO - PROCESS | 1671 | RSS: Main: 337801216 09:12:27 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 09:15:30 INFO - PROCESS | 1671 | RSS: Main: 384880640 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | __start_tp_report 09:15:30 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 09:15:30 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 09:15:30 INFO - PROCESS | 1671 | |i|pagename|runs| 09:15:30 INFO - PROCESS | 1671 | |0;dojo.html;2942.4262268857583;3387.559617249758;3442.294329662418;3472.340255351483;3521.1901262709575;4676.3920690310215;5665.943340566593;5679.829605111848;5690.17492463593;5729.026065568858;5700.116481945295;5721.427857214277;5793.71031448428;5855.268091488564;5862.472377486026;5093.770780314895;5123.231515272721;5139.9720055988955;5145.691258524482;5247.658902171365;5282.894342113155;5310.8406747797435;5336.786528538873;5338.599605029619;5392.865178370533;5127.871803204913;5219.947800521984;5224.660397074178;5236.24074509194;5269.288646032794;5159.509846564571;5167.276581278624;5182.378114626231;5186.896262074737;5193.948060519384;5207.3490813648295;5215.478452154792;5219.243209734605;5248.580113590903;5254.448282930275;5575.107982722745;5615.747291371898;5621.971890140564;5629.408912064216;5636.15457681347;6086.756529738849;6241.407066328737;6245.437910588023;6246.0630905364105;6247.250329960389;6132.969335153296;6151.938480615226;6171.290301615327;6214.5960512566535;6229.1590635264565;5687.345955215121;5735.1970724098655;5760.971195143998;5761.942380576183;5771;6199.194104766351;6272.466840318624;6276.968615156895;6297.874042519124;6316.05259211122;6111.144439778434;6137.754489820447;6140.570160088841;6143.692815359214;6151.200343955257;6257.655828929453;6281.497480201573;6283.497320214372;6290.559660823698;6299.023651334051;5205.375354957429;6064.666443345658;6117.279373342116;6121.81881567809;6215.595986260879;6217.875642487125;6253.6560489172625;6257.74969001244;6261.7182226799905;6273.654948977759;4921.630877684188;4925.852224433201;4943.9864827710235;4954.603631709455;4978.5270399312;4369.344598310279;4410.42664453619;4458.71018383804;4478.686491945533;4493;5693.946619875253;5711.086226203787;5722.914156287659;5731.570132240098;5746.109353050284;6277.058441233851;6288.874222515524;6291.245050593958;6299.370062993664;6312.0531920211415;5577.9163312550345;5630.915536266959;5682.772689092472;5693.715314234355;5734.713264336767;5351.759170837322;5369.060414427538;5407.864803379947;5407.891842163135;5411.485908838654;6204.534659900525;6243.313235544087;6263.154474145932;6278.466330361879;6286.52851036165;6147.846303842261;6237.719302631302;6246.968765156145;6299.811005669837;6301.96849015752;5437.211604317431;6237.220347456568;6279;6280;6291.1192433058495;6125.326214116532;6147.84630384244;6151.354107818794;6160.599561028519;6170.969145154246;6053.364396738455;6109.908351374644;6243.500519958483;6255.843603909939;6285.277193122849;6093.512518998381;6097.373446762037;6105.9694701526205;6113.871604717183;6119.106526814536;6084.543659225665;6090.665013424305;6098.786542470993;6102.176206212104;6112.113743507255;5704.657720536781;5863.560232982458;5929.1995580597795;5943.108533719977;5963.701814909324;6007;6028.608140470856;6045.17502717346;6064.545159112996;6094.908576371269;5844.970775146097;5851.736671849691;5857.648541087548;5863.17915491823;5866.853328666817 09:15:30 INFO - PROCESS | 1671 | |1;ext.html;480.9350737650418;510.1225891466677;522.8091746512524;558.1655425139418;586.1822757253628;28967.710322896764;37715.86852394429;38853;38864.80567597165;39074.21851562974;42953.57046429542;43879.78060109703;43890.68327950167;43893.341599876025;43920.56079439205;9535.332526723132;9736.318457707963;9747;9750.512474376288;9760.951195244013;9583.472908990003;9704.466254356008;9711.271654625896;9732.51337433129;9739.123478886899;9662.516874156265;9703.466309352983;9718.416894986289;9760.2679799015;9763.316567840255;9537.80924381512;9594.280428967855;9595.712128636153;9600.279979001603;9709.320347575673;9512.191463725592;9597.568109435093;9601.519924003773;9605.991370906024;9629.807403851953;39707.60292397068;40053.39919901204;40092.99767505807;40093.79953100245;40195;3373.004963535738;3438.948415773765;3748.11919198988;3873.0511024799102;3907.081835768592;24463;27705.030323938565;29633.851830740925;29639;29723.554146687817;2745.1901689001793;2766.7094955029834;2816.380396312808;2845.146456063173;2855.129185598392;426209;426747;427397;427522;428352;60618.09072863911;61089;61113.69443152756;61162.69418652878;61175.69412152911;63474.60465860361;63987;64140.35859641437;64291.03563446552;64347.678261608395;15719.68560628781;15811.762823557656;16014.759778603331;16026.958247714094;16040.438584649715;12284.447199876027;12346.629601111981;12367.443465044094;12368.81446778299;12391.442385092692;16605.50183494497;16686.33254669824;16702;16705.415310464075;16743.748843767353;6569.178852643419;6599.241087274929;6619.404253617101;6681.265060843303;6730.966345168243;967.351874244258;991.3258983890879;1032.0453580438066;1075.4891426572315;1077.8167711489066;24491.632625510632;29360.559591606143;30125;30631.081067568008;30962.845185773927;1065.1957771882335;1070.7686160914855;1146.9197156198986;1152.590830255264;1214.7449035702602;12889.355532223351;13141.277229752455;13922.37349319283;14347;14361.569152925429;651625;669735;670832;670849;671515;56725.71637141788;58432.70783646055;58473;58591.121133183035;58684.41315586789;1331.0283493049933;1357.104311154653;1437.2167168893188;1453.6365908522869;1494.5292232946804;22900.31299061031;28864.855675721486;28874;29566;29693.257668558457;41430.378544321255;47982.76008620074;48479.78800530015;49208.753956229986;49298;372719;386838;387085;387742;388854;23081;25839.224823255332;26571.202863914114;26668.066617669065;27704.722952771022;43087.9228019302;43386.78306608447;43704.781476092416;43716.34425483557;44830.3275450862;35533.82233088818;35542.46686299656;35835.46246806248;36204.189790509845;37135.44296835495;36108.45837312495;36116.63883361133;36511;36806.63193368139;36850.8157459211;30875.382492350476;35328.94013179609;35558;35904.82047589745;36661.450078248316;28944;31010.844945775127;31377.8431107843;31922.6807731929;31995.36009279848;23348.416289592897;23977.00574856286;24179.395515112265;24487.632685509376;24577.385565361008 09:15:30 INFO - PROCESS | 1671 | |2;jquery.html;388.2971821003983;388.46004054364437;389.44504081683596;393.0550424824529;399.85005622891396;14183.13276878124;19694.606107877833;19695.606087878252;20574.691379629297;20618.793812061893;16127.354905803782;17645.382411615596;20394.490137746565;20477.180912763473;20842.583148337024;5658.207850900877;5970.104484327342;6013.098035294719;6017.277926648809;6037.335893051761;5615.298087739033;5890.381509941459;5896.498797602209;5902.3507414184405;5948.245267646055;5821.6507009579345;5852.063669812809;5860.384659610743;5870.090136028923;5879.265091863517;5849.912251316234;5895.410458954113;5907.02534081876;5907.734151963151;5933.13969474426;4964.255361695775;5116.386033675945;5120.564751996085;5133.512316329943;5140.511651393149;24287.392815179584;25478;25926;25936.22191334263;25998.480030399474;1985.6525108106168;2019.5254115282896;2171.8588291760984;2370.97629023711;2645.7354264573582;14641.048331858501;14677;14732.983304936895;15060.945733798639;15143.394264229528;1730.1695186310515;1735.878488505805;1779.7241427578747;1782.9554261143576;1867.9252829886789;114161;116422.83577164204;117930.4103479477;118054;119191.40404297924;10626.415547144981;10885.346879187275;11157.163212759075;11189.272697274813;11307.265027773168;13991.58025259244;14135.363908624136;14186.148831069962;14190.503332383318;14197.503087392099;6486.740530378732;7415.59214243211;8288.668453261922;8435.451695639764;8482.151784821468;8191.508509489449;8200.138985406445;8202.83594328122;8311.709090181814;8344.62449189788;6434.324395938359;6526.967365163238;6536.869262614721;6550.181227346582;6664.6337500812215;1642.3102297035273;1788.7495750594926;1884.6701827180189;1900.9714854277197;1902.6301063234448;903.5572569441058;905.23055402907;920.8158368326361;980.4705459052032;992.846108853129;19763.604727905647;19862.11999260099;20360.24333529997;20858.79141208599;21625.891870540545;961.9086186812242;997.551102004101;1001.234055947201;1004.2267454060333;1049;10509.264351495474;10911.890881091247;10931.56273749057;10952.4523773811;11068;562816;590077;608126;609387;617895;115357;118465.40767296108;119077;119082.4045879765;121428.39285803691;1031.8194315994822;1031.8297480915714;1052.8736551614008;1054.2672842374477;1054.7995880782628;17951.743377963416;18159.273629055217;18202.45392638223;18307.26770929148;18373.03585943499;32109.35781284408;44650;45570.544294557956;46151.76924115358;47733.76133119312;65813.67093164503;66483.33516664771;67212.66393668001;67437;69894;7541.509801862861;7633.732819351296;7733.729319474017;7808.6095695216145;8023.318017968538;11721.589744358907;11869.109816763605;12130.211536250115;12192.75614487723;12203.511859525875;8925.196732294125;10019.649312274327;10193.23550733683;10617.126072752415;10747.978942000498;8351.457155284887;10195.388276703421;10205.979402060031;10218.233632477743;10621.362718236931;10409.375437473776;10451.216158788273;10589.4705264738;10791.676249712522;10802.243842930919;6775.322467753185;7521.699132034657;7659.923400766144;7752.8449431012195;7927;10055.648052318134;10134.087932086148;10329.74175645615;10527;10529.105026072562 09:15:30 INFO - PROCESS | 1671 | |3;mootools.html;1246.9563565275216;1605.5022942887706;1624.545127364338;1883.7927827938934;2009.3570057581571;7806.219378062191;8527.275181609562;8752.29981601472;8770.254528365082;8772.210501054911;8057.556834374107;8123.634436450359;8211.260986511214;8214.63034163464;8230;2158.5359147783224;2160.567886422714;2386.6300723387903;2411.336882357353;2487.514934587756;2443.6945381827272;2474.6659201007906;2477.3682710908693;2486.589712697412;2494.48862983088;2412.7104747430335;2448.1309135256993;2448.1431498975394;2452.0682140786566;2459.1515927005153;2422.200673777649;2439.207257641274;2447.412620970972;2447.6940382452194;2453.0800949643885;2354.8704821234824;2370.348154257593;2373.6320870265135;2377.0848223434105;2377.09670325277;8729.60716767747;8844.823103537958;8845.248153906925;8858.114188581154;8864.689735859278;5158.303629010074;5311.389190243133;5326.334208223972;5361.812336568201;5385;3428.777129486575;3450.3099380124077;3494.9989814120177;3513.5608048993877;3528.558930133733;1021.5454122915305;1037.7613148975702;1040.7086015915556;1045.6131231444338;1049.5801679328254;11017;11024.952629500185;11030;11030.338179709162;11034.668959931216;4585.587297143273;4590.747508886977;4811.182099043171;4839.9758001210475;4856.68431551948;9467.905320946702;9468.242540596873;9477.431354118775;9488.146066854017;9526.714198574055;5309.7345132743985;5344.144936810169;5345.305110335631;5350.3312085989255;5367.221752845816;4419.955800442019;4536.160810250114;4885.145099607555;4905.166121759309;5005.674631149037;3957.841686332572;4022.0950286185375;4044.2315959967514;4085.6527195188146;4087.9795601021806;1312.4946895445132;1316.795896636023;1331.5805521260966;1338.5448947357945;1342.8052932324954;1120.9271397359146;1166.2943918928927;1292.6768307922832;1361.537077393671;1365.208179256029;8074.475159114756;8120.796980075545;8124.512529248264;8137.471064380797;8171.836563268701;507.3505912432093;523.3144580599427;523.9764210610532;525.3879230696197;527.8495628745789;6155.784547540815;6248.218972628421;6370.872582548323;6389.041643753381;6396.232452105684;10062.597496100221;10463.84304235437;10529.526171322308;10557.894421055844;10579.788404231873;10361.740956475998;10475.738106547396;10627;10632.41521716313;10648.14814814813;7909.050913890255;8026.839463210703;8037.879431808527;8081.272685458337;8083.434159608889;7767.184445633353;7937.603119844101;7968.521888686697;7975.361971042419;7975.680972761024;9588.760280992752;9742.805143897223;9812.067853553901;9856.112949834549;9952.203823693942;9292.860607091034;9574;9583.904160958302;9596.76008099803;9934.850977235492;6243.500519958483;6864.519483636098;7094.255103214088;7298;7576.8484630308185;8217.83564328722;8225.79435514117;8278.089410164997;8293.170682931659;8295.751127466187;7296.087989001375;7345.081864766904;7365.631718414165;7529.360004399468;7541.5475071495885;7001.754938577329;7134.536255143399;7144.285571442814;7197.892031619425;7198.100237470317;7474.177840437656;7564.319211271012;7585.393168546393;7587.317141457295;7597.2022937590755;6774.356436138559;6795.116634837439;6878.793636190922;6882.965585172042;6889.689963951534;6733.6296503692765;6836;6838.350356716104;6842.931570684428;6912.239653637996 09:15:30 INFO - PROCESS | 1671 | |4;prototype.html;292.6575906189758;322.5065649556178;324.1151655979178;329.9950500742489;331.3274053671046;4883.2430973199125;5160.535551800342;5782.82651520454;5856.414358564152;5866.354700982888;5741.511971482419;5742.28221472316;5743.54051675866;5754.65472071676;5802.926458605161;3704.2403409459857;3963.7225394222414;4048.4736984192014;4265.189613973351;4405.207062728708;4350;4362.302031674933;4380.321050237202;4398.428204333432;4405.880501730876;3969;4208.473940757405;4387.188370151516;4387.736735795863;4395.670324725643;3567.910802229965;3914.9038269284647;4240.703150779446;4383.649308055364;4391.253486907233;3423.96576034239;3642.6357364263627;3813.9427908581392;3825.464434979105;3856.9915465936615;5027.542012816279;5219.824140687473;5553.972230138864;5592.5805564582815;5618.7190640468225;4245.61789438952;4850.9272360914265;5012.624053196025;5046.924296135561;5050.267711181858;6040.395960403968;6045.6674882881425;6048.727807248684;6074.119252708377;6079.361667024943;3552.662497062775;4201.621854033152;4202.726822756542;4204.768737719424;4220.894477638053;5948.79894439056;5959.314678811992;6089.238845144357;6394.168758061469;6469.547131700783;3701.370766969622;3910.804459777;4129.050318426718;4159.688023398257;4169.478815148106;4118.341065429517;4237.131388065439;4237.788110594458;4240.618344349024;4272.423222864935;4636.629069674418;4938.8765280868265;4981.825636102719;4986.152354099811;4986.700797952134;5405.999890020359;6106.297775755756;6124.571280010446;6154.230721159855;6178;1222.2299951030793;1451.310627451973;1453.4113683958014;1456.4174330267977;1458.4968185975822;929.5636479658637;961.3799099580731;963.6145541783343;971.2909576009553;976.8534719791946;4833.492483289274;5665.263515742927;5705.800296989585;5718.0272805881905;5749.453801888814;6308.211473565804;6322.936770632326;6333.588316759396;6338.556301058974;6348.682565871688;4893.877653058631;5404.864878377994;5712.200291959129;5717.8570535736935;5719.942800572025;3311.983440082832;3319.2365755876285;3350.9664903350654;3353.625013744353;3377.2401209728105;5536.695481748462;6120.510359171256;6238.189035425366;6547.312532184147;6547.34526547351;5677.602567820213;6229.283632382243;6476.384743449365;6495.642739649365;6525.608463492205;5688.943110568925;6342.207224096988;6604.3725846044545;6636.502262330345;6657.933420665731;6086.939130608815;6393.968030159819;6399.968000159969;6408.263049749338;6420.229572451336;5513.476219759116;6235.251769787655;6279.246490421178;6297.181366422519;6308.810735677937;5431.456854314537;6594.571352862049;6594.571352862049;6602.8349291268105;6677.632730199885;3915.3735402335487;3919.412088186795;4151.647109995684;4178.435911151955;4208.074223670787;6128.754849805958;6292.276388215414;6320.968395158179;6330.082138090043;6334.429901308904;5950.910736339045;6136.140940268277;6145.201123853871;6153.630782153085;6162.815115546541;5272.76272567743;5804.1874137619925;6089.391060894052;6139.631622102688;6141.723622436912;5565.916511252415;5771.047777116896;5959.463648271503;5963.850903727442;5982.025931442527;5465.808696695596;5545.511751250965;5690.544756419559;6118.20463339763;6122.74483730843;5518.448155184449;6030.758769649165;6036.456718895321;6061.909071363845;6098.725557349841 09:15:30 INFO - PROCESS | 1671 | |5;yui.html;596.9194158788563;673.2291526202498;712.8004158835528;712.8752468318045;744.735618855306;14784.852151478482;15180.240987950587;15242.923785381057;15249.31378087986;15277.618059548517;15195.392184312614;15664.530064098068;15684.215789210522;15688.215589220521;15727.685446291096;726.5459088069956;744.8212429017051;916.0610374366262;918.6279556779515;923.2706162131908;909.236241557092;928.16465181337;928.7817362919709;929.4748467116092;930.0374112793261;966.3139171188465;966.8259713251612;967.0281367225963;967.4243824924159;968.7384406210319;758.9848203035908;774.7327172125607;775.3448336155939;964.2189826240732;970.5972021611022;576.6684156609924;694.3195668245148;709.7054722290243;710.605613884294;712.0316369737153;15363.385464581403;15405.845941540552;15449.227538623136;15456.381744730197;15462.536123916301;10004.39841657003;11030.896910308906;12333.198342107824;12565.869071783492;12657.620271391874;9989.900100999042;10178.592856285739;10208.18334533243;10212.897871021269;10934.507947142398;3442.2599141184764;3485.9128521786906;3516.2791627716256;3526.1360966563357;3590.964090359089;82675;83620;84054.318913622;84217;84496.57751711263;9362.765930851783;9384.488268145313;9449.149576538008;9667.081627245401;9769.560369783378;21503.2473863414;21548.922553872242;21566.676499852514;21573.568528629654;21581.78418215798;7138.428925686037;7431.925680743231;7438.1446133694235;7470.028896243453;7582.658780354897;4069.6337329640473;4115.053537686349;4154.813033413504;4192.329227323614;4341.826326946887;3536.664016918389;3654.3787556115526;3656.5794933582447;3658.5975542690285;3659.9817000914827;650.1580453312877;652.0773106054879;657.9046038324416;660.92729799722;671.1744554198364;442.8870637987357;478.95928846048474;529.3991319851918;582.7788359264831;617.1791517282004;7272.563646181246;7672.232776722395;7775.688972441152;7847.489913155627;8034.558099304478;567.8410045187354;585.5802115644656;594.5006194796392;601.8856417280703;607.5504126946028;3580.6240344763946;3829.9808500957874;3841.9807900960877;3859.3246181918053;3870.6903447724117;73739;75769;75817;75992.62003689946;86510.83722906977;55972;64660.353396465434;67613.66193169101;68044;68678;63905.72188556296;64933.70132597322;67564;68197;68937.62124757477;8199.59002049907;8217.83564328698;8348.749537513884;8437.915620843713;8447.746567602982;43033.784831075645;43670.344944825214;44081.77959110184;44091;45863;50830.491695084056;61931;63532.50571218627;63751.6812415935;63771.681141593996;10911.890881091405;11075.944620276847;11140.654742084282;11252.718682032688;11475.024622907147;11479.785660014875;11931.164818462625;11931.582394616147;12015.579454719043;12410.33069741143;11344.716382090513;11377.693263807309;11460.255083419552;11477;12071.75856482883;11418.371989540656;11730.472128754398;11798.587049453228;11852;12000.939995299968;11130.610428634958;11221;11451.484683189443;11729.648110556696;11890.10824188172;9401.435913845191;9677.951610241904;9740.318177727491;9820.4107753535;10060.346077504939;9297.45889387145;9501.619935202514;9537.952310238405;9542.66600669001;9699.272554558578 09:15:30 INFO - PROCESS | 1671 | __end_tp_report 09:15:30 INFO - PROCESS | 1671 | __start_cc_report 09:15:30 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1121 09:15:30 INFO - PROCESS | 1671 | __end_cc_report 09:15:30 INFO - PROCESS | 1671 | __startTimestamp1460132130363__endTimestamp 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | ------- Summary: start ------- 09:15:30 INFO - PROCESS | 1671 | Number of tests: 6 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5720.23 Median:5863.56 stddev:636.02 (10.8%) stddev-sans-first:599.48 09:15:30 INFO - PROCESS | 1671 | Values: 2942.4 3387.6 3442.3 3472.3 3521.2 4676.4 5665.9 5679.8 5690.2 5729.0 5700.1 5721.4 5793.7 5855.3 5862.5 5093.8 5123.2 5140.0 5145.7 5247.7 5282.9 5310.8 5336.8 5338.6 5392.9 5127.9 5219.9 5224.7 5236.2 5269.3 5159.5 5167.3 5182.4 5186.9 5193.9 5207.3 5215.5 5219.2 5248.6 5254.4 5575.1 5615.7 5622.0 5629.4 5636.2 6086.8 6241.4 6245.4 6246.1 6247.3 6133.0 6151.9 6171.3 6214.6 6229.2 5687.3 5735.2 5761.0 5761.9 5771.0 6199.2 6272.5 6277.0 6297.9 6316.1 6111.1 6137.8 6140.6 6143.7 6151.2 6257.7 6281.5 6283.5 6290.6 6299.0 5205.4 6064.7 6117.3 6121.8 6215.6 6217.9 6253.7 6257.7 6261.7 6273.7 4921.6 4925.9 4944.0 4954.6 4978.5 4369.3 4410.4 4458.7 4478.7 4493.0 5693.9 5711.1 5722.9 5731.6 5746.1 6277.1 6288.9 6291.2 6299.4 6312.1 5577.9 5630.9 5682.8 5693.7 5734.7 5351.8 5369.1 5407.9 5407.9 5411.5 6204.5 6243.3 6263.2 6278.5 6286.5 6147.8 6237.7 6247.0 6299.8 6302.0 5437.2 6237.2 6279.0 6280.0 6291.1 6125.3 6147.8 6151.4 6160.6 6171.0 6053.4 6109.9 6243.5 6255.8 6285.3 6093.5 6097.4 6106.0 6113.9 6119.1 6084.5 6090.7 6098.8 6102.2 6112.1 5704.7 5863.6 5929.2 5943.1 5963.7 6007.0 6028.6 6045.2 6064.5 6094.9 5845.0 5851.7 5857.6 5863.2 5866.9 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:63100.37 Median:195479.03 stddev:136003.75 (69.6%) stddev-sans-first:136304.01 09:15:30 INFO - PROCESS | 1671 | Values: 480.9 510.1 522.8 558.2 586.2 28967.7 37715.9 38853.0 38864.8 39074.2 42953.6 43879.8 43890.7 43893.3 43920.6 9535.3 9736.3 9747.0 9750.5 9761.0 9583.5 9704.5 9711.3 9732.5 9739.1 9662.5 9703.5 9718.4 9760.3 9763.3 9537.8 9594.3 9595.7 9600.3 9709.3 9512.2 9597.6 9601.5 9606.0 9629.8 39707.6 40053.4 40093.0 40093.8 40195.0 3373.0 3438.9 3748.1 3873.1 3907.1 24463.0 27705.0 29633.9 29639.0 29723.6 2745.2 2766.7 2816.4 2845.1 2855.1 426209.0 426747.0 427397.0 427522.0 428352.0 60618.1 61089.0 61113.7 61162.7 61175.7 63474.6 63987.0 64140.4 64291.0 64347.7 15719.7 15811.8 16014.8 16027.0 16040.4 12284.4 12346.6 12367.4 12368.8 12391.4 16605.5 16686.3 16702.0 16705.4 16743.7 6569.2 6599.2 6619.4 6681.3 6731.0 967.4 991.3 1032.0 1075.5 1077.8 24491.6 29360.6 30125.0 30631.1 30962.8 1065.2 1070.8 1146.9 1152.6 1214.7 12889.4 13141.3 13922.4 14347.0 14361.6 651625.0 669735.0 670832.0 670849.0 671515.0 56725.7 58432.7 58473.0 58591.1 58684.4 1331.0 1357.1 1437.2 1453.6 1494.5 22900.3 28864.9 28874.0 29566.0 29693.3 41430.4 47982.8 48479.8 49208.8 49298.0 372719.0 386838.0 387085.0 387742.0 388854.0 23081.0 25839.2 26571.2 26668.1 27704.7 43087.9 43386.8 43704.8 43716.3 44830.3 35533.8 35542.5 35835.5 36204.2 37135.4 36108.5 36116.6 36511.0 36806.6 36850.8 30875.4 35328.9 35558.0 35904.8 36661.5 28944.0 31010.8 31377.8 31922.7 31995.4 23348.4 23977.0 24179.4 24487.6 24577.4 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34055.34 Median:20850.69 stddev:99428.88 (476.9%) stddev-sans-first:99675.66 09:15:30 INFO - PROCESS | 1671 | Values: 388.3 388.5 389.4 393.1 399.9 14183.1 19694.6 19695.6 20574.7 20618.8 16127.4 17645.4 20394.5 20477.2 20842.6 5658.2 5970.1 6013.1 6017.3 6037.3 5615.3 5890.4 5896.5 5902.4 5948.2 5821.7 5852.1 5860.4 5870.1 5879.3 5849.9 5895.4 5907.0 5907.7 5933.1 4964.3 5116.4 5120.6 5133.5 5140.5 24287.4 25478.0 25926.0 25936.2 25998.5 1985.7 2019.5 2171.9 2371.0 2645.7 14641.0 14677.0 14733.0 15060.9 15143.4 1730.2 1735.9 1779.7 1783.0 1867.9 114161.0 116422.8 117930.4 118054.0 119191.4 10626.4 10885.3 11157.2 11189.3 11307.3 13991.6 14135.4 14186.1 14190.5 14197.5 6486.7 7415.6 8288.7 8435.5 8482.2 8191.5 8200.1 8202.8 8311.7 8344.6 6434.3 6527.0 6536.9 6550.2 6664.6 1642.3 1788.7 1884.7 1901.0 1902.6 903.6 905.2 920.8 980.5 992.8 19763.6 19862.1 20360.2 20858.8 21625.9 961.9 997.6 1001.2 1004.2 1049.0 10509.3 10911.9 10931.6 10952.5 11068.0 562816.0 590077.0 608126.0 609387.0 617895.0 115357.0 118465.4 119077.0 119082.4 121428.4 1031.8 1031.8 1052.9 1054.3 1054.8 17951.7 18159.3 18202.5 18307.3 18373.0 32109.4 44650.0 45570.5 46151.8 47733.8 65813.7 66483.3 67212.7 67437.0 69894.0 7541.5 7633.7 7733.7 7808.6 8023.3 11721.6 11869.1 12130.2 12192.8 12203.5 8925.2 10019.6 10193.2 10617.1 10748.0 8351.5 10195.4 10206.0 10218.2 10621.4 10409.4 10451.2 10589.5 10791.7 10802.2 6775.3 7521.7 7659.9 7752.8 7927.0 10055.6 10134.1 10329.7 10527.0 10529.1 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5927.94 Median:5347.82 stddev:3111.99 (58.2%) stddev-sans-first:3100.82 09:15:30 INFO - PROCESS | 1671 | Values: 1247.0 1605.5 1624.5 1883.8 2009.4 7806.2 8527.3 8752.3 8770.3 8772.2 8057.6 8123.6 8211.3 8214.6 8230.0 2158.5 2160.6 2386.6 2411.3 2487.5 2443.7 2474.7 2477.4 2486.6 2494.5 2412.7 2448.1 2448.1 2452.1 2459.2 2422.2 2439.2 2447.4 2447.7 2453.1 2354.9 2370.3 2373.6 2377.1 2377.1 8729.6 8844.8 8845.2 8858.1 8864.7 5158.3 5311.4 5326.3 5361.8 5385.0 3428.8 3450.3 3495.0 3513.6 3528.6 1021.5 1037.8 1040.7 1045.6 1049.6 11017.0 11025.0 11030.0 11030.3 11034.7 4585.6 4590.7 4811.2 4840.0 4856.7 9467.9 9468.2 9477.4 9488.1 9526.7 5309.7 5344.1 5345.3 5350.3 5367.2 4420.0 4536.2 4885.1 4905.2 5005.7 3957.8 4022.1 4044.2 4085.7 4088.0 1312.5 1316.8 1331.6 1338.5 1342.8 1120.9 1166.3 1292.7 1361.5 1365.2 8074.5 8120.8 8124.5 8137.5 8171.8 507.4 523.3 524.0 525.4 527.8 6155.8 6248.2 6370.9 6389.0 6396.2 10062.6 10463.8 10529.5 10557.9 10579.8 10361.7 10475.7 10627.0 10632.4 10648.1 7909.1 8026.8 8037.9 8081.3 8083.4 7767.2 7937.6 7968.5 7975.4 7975.7 9588.8 9742.8 9812.1 9856.1 9952.2 9292.9 9574.0 9583.9 9596.8 9934.9 6243.5 6864.5 7094.3 7298.0 7576.8 8217.8 8225.8 8278.1 8293.2 8295.8 7296.1 7345.1 7365.6 7529.4 7541.5 7001.8 7134.5 7144.3 7197.9 7198.1 7474.2 7564.3 7585.4 7587.3 7597.2 6774.4 6795.1 6878.8 6883.0 6889.7 6733.6 6836.0 6838.4 6842.9 6912.2 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4959.23 Median:5683.27 stddev:1550.32 (27.3%) stddev-sans-first:1514.59 09:15:30 INFO - PROCESS | 1671 | Values: 292.7 322.5 324.1 330.0 331.3 4883.2 5160.5 5782.8 5856.4 5866.4 5741.5 5742.3 5743.5 5754.7 5802.9 3704.2 3963.7 4048.5 4265.2 4405.2 4350.0 4362.3 4380.3 4398.4 4405.9 3969.0 4208.5 4387.2 4387.7 4395.7 3567.9 3914.9 4240.7 4383.6 4391.3 3424.0 3642.6 3813.9 3825.5 3857.0 5027.5 5219.8 5554.0 5592.6 5618.7 4245.6 4850.9 5012.6 5046.9 5050.3 6040.4 6045.7 6048.7 6074.1 6079.4 3552.7 4201.6 4202.7 4204.8 4220.9 5948.8 5959.3 6089.2 6394.2 6469.5 3701.4 3910.8 4129.1 4159.7 4169.5 4118.3 4237.1 4237.8 4240.6 4272.4 4636.6 4938.9 4981.8 4986.2 4986.7 5406.0 6106.3 6124.6 6154.2 6178.0 1222.2 1451.3 1453.4 1456.4 1458.5 929.6 961.4 963.6 971.3 976.9 4833.5 5665.3 5705.8 5718.0 5749.5 6308.2 6322.9 6333.6 6338.6 6348.7 4893.9 5404.9 5712.2 5717.9 5719.9 3312.0 3319.2 3351.0 3353.6 3377.2 5536.7 6120.5 6238.2 6547.3 6547.3 5677.6 6229.3 6476.4 6495.6 6525.6 5688.9 6342.2 6604.4 6636.5 6657.9 6086.9 6394.0 6400.0 6408.3 6420.2 5513.5 6235.3 6279.2 6297.2 6308.8 5431.5 6594.6 6594.6 6602.8 6677.6 3915.4 3919.4 4151.6 4178.4 4208.1 6128.8 6292.3 6321.0 6330.1 6334.4 5950.9 6136.1 6145.2 6153.6 6162.8 5272.8 5804.2 6089.4 6139.6 6141.7 5565.9 5771.0 5959.5 5963.9 5982.0 5465.8 5545.5 5690.5 6118.2 6122.7 5518.4 6030.8 6036.5 6061.9 6098.7 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17215.27 Median:599.40 stddev:23263.54 (3881.1%) stddev-sans-first:23295.34 09:15:30 INFO - PROCESS | 1671 | Values: 596.9 673.2 712.8 712.9 744.7 14784.9 15180.2 15242.9 15249.3 15277.6 15195.4 15664.5 15684.2 15688.2 15727.7 726.5 744.8 916.1 918.6 923.3 909.2 928.2 928.8 929.5 930.0 966.3 966.8 967.0 967.4 968.7 759.0 774.7 775.3 964.2 970.6 576.7 694.3 709.7 710.6 712.0 15363.4 15405.8 15449.2 15456.4 15462.5 10004.4 11030.9 12333.2 12565.9 12657.6 9989.9 10178.6 10208.2 10212.9 10934.5 3442.3 3485.9 3516.3 3526.1 3591.0 82675.0 83620.0 84054.3 84217.0 84496.6 9362.8 9384.5 9449.1 9667.1 9769.6 21503.2 21548.9 21566.7 21573.6 21581.8 7138.4 7431.9 7438.1 7470.0 7582.7 4069.6 4115.1 4154.8 4192.3 4341.8 3536.7 3654.4 3656.6 3658.6 3660.0 650.2 652.1 657.9 660.9 671.2 442.9 479.0 529.4 582.8 617.2 7272.6 7672.2 7775.7 7847.5 8034.6 567.8 585.6 594.5 601.9 607.6 3580.6 3830.0 3842.0 3859.3 3870.7 73739.0 75769.0 75817.0 75992.6 86510.8 55972.0 64660.4 67613.7 68044.0 68678.0 63905.7 64933.7 67564.0 68197.0 68937.6 8199.6 8217.8 8348.7 8437.9 8447.7 43033.8 43670.3 44081.8 44091.0 45863.0 50830.5 61931.0 63532.5 63751.7 63771.7 10911.9 11075.9 11140.7 11252.7 11475.0 11479.8 11931.2 11931.6 12015.6 12410.3 11344.7 11377.7 11460.3 11477.0 12071.8 11418.4 11730.5 11798.6 11852.0 12000.9 11130.6 11221.0 11451.5 11729.6 11890.1 9401.4 9678.0 9740.3 9820.4 10060.3 9297.5 9501.6 9538.0 9542.7 9699.3 09:15:30 INFO - PROCESS | 1671 | -------- Summary: end -------- 09:15:30 INFO - PROCESS | 1671 | 09:15:30 INFO - TEST-INFO | 1671: exit 0 09:15:30 INFO - TEST-OK | dromaeo_css | took 1113912ms 09:15:30 INFO - TEST-START | kraken 09:15:30 INFO - operating with platform_type : mac_ 09:15:30 INFO - Initialising browser for kraken test... 09:15:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpbpuZkh/profile http://localhost:49276/getInfo.html) 09:15:32 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 09:15:32 INFO - PROCESS | 1676 | colorDepth:24 09:15:32 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 09:15:32 INFO - PROCESS | 1676 | __metrics 09:15:33 INFO - PROCESS | 1676 | 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" 09:15:33 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:15:33 INFO - TEST-INFO | 1676: exit 0 09:15:33 INFO - Browser initialized. 09:15:33 INFO - Running cycle 1/1 for kraken test... 09:15:33 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpbpuZkh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:45 INFO - PROCESS | 1678 | RSS: Main: 237355008 09:15:45 INFO - PROCESS | 1678 | 09:15:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:48 INFO - PROCESS | 1678 | RSS: Main: 283369472 09:15:48 INFO - PROCESS | 1678 | 09:15:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 09:15:52 INFO - PROCESS | 1678 | RSS: Main: 293961728 09:15:52 INFO - PROCESS | 1678 | 09:15:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 09:15:55 INFO - PROCESS | 1678 | RSS: Main: 279015424 09:15:55 INFO - PROCESS | 1678 | 09:15:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 09:15:58 INFO - PROCESS | 1678 | RSS: Main: 281899008 09:15:58 INFO - PROCESS | 1678 | 09:16:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:01 INFO - PROCESS | 1678 | RSS: Main: 282906624 09:16:01 INFO - PROCESS | 1678 | 09:16:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:04 INFO - PROCESS | 1678 | RSS: Main: 284110848 09:16:04 INFO - PROCESS | 1678 | 09:16:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:08 INFO - PROCESS | 1678 | RSS: Main: 283226112 09:16:08 INFO - PROCESS | 1678 | 09:16:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 09:16:11 INFO - PROCESS | 1678 | RSS: Main: 283668480 09:16:11 INFO - PROCESS | 1678 | 09:16:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:13 INFO - PROCESS | 1678 | RSS: Main: 318287872 09:16:13 INFO - PROCESS | 1678 | 09:16:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:16 INFO - PROCESS | 1678 | RSS: Main: 318386176 09:16:16 INFO - PROCESS | 1678 | 09:16:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:18 INFO - PROCESS | 1678 | RSS: Main: 324194304 09:16:18 INFO - PROCESS | 1678 | 09:16:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:22 INFO - PROCESS | 1678 | RSS: Main: 325308416 09:16:22 INFO - PROCESS | 1678 | 09:16:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:25 INFO - PROCESS | 1678 | RSS: Main: 325320704 09:16:25 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 09:16:27 INFO - PROCESS | 1678 | RSS: Main: 389226496 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | __start_tp_report 09:16:27 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 09:16:27 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 09:16:27 INFO - PROCESS | 1678 | |i|pagename|runs| 09:16:27 INFO - PROCESS | 1678 | |0;ai-astar;112;111;111;113;114;115;119;117;113;115 09:16:27 INFO - PROCESS | 1678 | |1;audio-beat-detection;163;149;172;160;120;142;142;120;163;121 09:16:27 INFO - PROCESS | 1678 | |2;audio-dft;189;184;188;183;186;187;186;188;181;186 09:16:27 INFO - PROCESS | 1678 | |3;audio-fft;74;73;83;84;80;84;61;82;80;55 09:16:27 INFO - PROCESS | 1678 | |4;audio-oscillator;95;96;127;77;90;112;154;82;78;118 09:16:27 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;90;87;121;88;89;85;91;87;89;86 09:16:27 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;94;95;95;95;94;96;94;94;95 09:16:27 INFO - PROCESS | 1678 | |7;imaging-desaturate;94;86;85;87;85;87;87;85;87;85 09:16:27 INFO - PROCESS | 1678 | |8;json-parse-financial;57;53;54;53;55;53;54;64;55;52 09:16:27 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;65;72;77;72;71;68;68;69;68;69 09:16:27 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;86;85;85;86;81;85;81;83;85;84 09:16:27 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;145;145;156;164;163;141;140;135;141;144 09:16:27 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;176;173;169;168;168;169;167;170;173;165 09:16:27 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;69;80;94;91;92;76;68;69;66;66 09:16:27 INFO - PROCESS | 1678 | __end_tp_report 09:16:27 INFO - PROCESS | 1678 | __start_cc_report 09:16:27 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1308 09:16:27 INFO - PROCESS | 1678 | __end_cc_report 09:16:27 INFO - PROCESS | 1678 | __startTimestamp1460132187737__endTimestamp 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | ------- Summary: start ------- 09:16:27 INFO - PROCESS | 1678 | Number of tests: 14 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:2.58 (2.3%) stddev-sans-first:2.64 09:16:27 INFO - PROCESS | 1678 | Values: 112.0 111.0 111.0 113.0 114.0 115.0 119.0 117.0 113.0 115.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:154.50 stddev:19.61 (12.7%) stddev-sans-first:19.72 09:16:27 INFO - PROCESS | 1678 | Values: 163.0 149.0 172.0 160.0 120.0 142.0 142.0 120.0 163.0 121.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.50 stddev:2.49 (1.3%) stddev-sans-first:2.35 09:16:27 INFO - PROCESS | 1678 | Values: 189.0 184.0 188.0 183.0 186.0 187.0 186.0 188.0 181.0 186.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:75.60 Median:81.00 stddev:10.12 (12.5%) stddev-sans-first:10.72 09:16:27 INFO - PROCESS | 1678 | Values: 74.0 73.0 83.0 84.0 80.0 84.0 61.0 82.0 80.0 55.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:80.00 stddev:24.74 (30.9%) stddev-sans-first:26.07 09:16:27 INFO - PROCESS | 1678 | Values: 95.0 96.0 127.0 77.0 90.0 112.0 154.0 82.0 78.0 118.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:88.50 stddev:10.59 (12.0%) stddev-sans-first:11.23 09:16:27 INFO - PROCESS | 1678 | Values: 90.0 87.0 121.0 88.0 89.0 85.0 91.0 87.0 89.0 86.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:16:27 INFO - PROCESS | 1678 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 96.0 94.0 94.0 95.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:2.70 (3.1%) stddev-sans-first:1.00 09:16:27 INFO - PROCESS | 1678 | Values: 94.0 86.0 85.0 87.0 85.0 87.0 87.0 85.0 87.0 85.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:3.46 (6.4%) stddev-sans-first:3.60 09:16:27 INFO - PROCESS | 1678 | Values: 57.0 53.0 54.0 53.0 55.0 53.0 54.0 64.0 55.0 52.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.28 (4.7%) stddev-sans-first:2.96 09:16:27 INFO - PROCESS | 1678 | Values: 65.0 72.0 77.0 72.0 71.0 68.0 68.0 69.0 68.0 69.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:1.85 (2.2%) stddev-sans-first:1.83 09:16:27 INFO - PROCESS | 1678 | Values: 86.0 85.0 85.0 86.0 81.0 85.0 81.0 83.0 85.0 84.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:145.00 stddev:10.04 (6.9%) stddev-sans-first:10.61 09:16:27 INFO - PROCESS | 1678 | Values: 145.0 145.0 156.0 164.0 163.0 141.0 140.0 135.0 141.0 144.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:169.50 stddev:3.29 (1.9%) stddev-sans-first:2.62 09:16:27 INFO - PROCESS | 1678 | Values: 176.0 173.0 169.0 168.0 168.0 169.0 167.0 170.0 173.0 165.0 09:16:27 INFO - PROCESS | 1678 | 09:16:27 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:78.00 stddev:11.41 (14.6%) stddev-sans-first:11.72 09:16:27 INFO - PROCESS | 1678 | Values: 69.0 80.0 94.0 91.0 92.0 76.0 68.0 69.0 66.0 66.0 09:16:27 INFO - PROCESS | 1678 | -------- Summary: end -------- 09:16:27 INFO - PROCESS | 1678 | 09:16:28 INFO - TEST-INFO | 1678: exit 0 09:16:28 INFO - TEST-OK | kraken | took 57567ms 09:16:28 INFO - SUITE-END | took 1171s 09:16:28 INFO - Completed test suite (00:19:31) 09:16:28 INFO - javascript benchmark 09:16:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2942.4262268857583, 3387.559617249758, 3442.294329662418, 3472.340255351483, 3521.1901262709575, 4676.3920690310215, 5665.943340566593, 5679.829605111848, 5690.17492463593, 5729.026065568858, 5700.116481945295, 5721.427857214277, 5793.71031448428, 5855.268091488564, 5862.472377486026, 5093.770780314895, 5123.231515272721, 5139.9720055988955, 5145.691258524482, 5247.658902171365, 5282.894342113155, 5310.8406747797435, 5336.786528538873, 5338.599605029619, 5392.865178370533, 5127.871803204913, 5219.947800521984, 5224.660397074178, 5236.24074509194, 5269.288646032794, 5159.509846564571, 5167.276581278624, 5182.378114626231, 5186.896262074737, 5193.948060519384, 5207.3490813648295, 5215.478452154792, 5219.243209734605, 5248.580113590903, 5254.448282930275, 5575.107982722745, 5615.747291371898, 5621.971890140564, 5629.408912064216, 5636.15457681347, 6086.756529738849, 6241.407066328737, 6245.437910588023, 6246.0630905364105, 6247.250329960389, 6132.969335153296, 6151.938480615226, 6171.290301615327, 6214.5960512566535, 6229.1590635264565, 5687.345955215121, 5735.1970724098655, 5760.971195143998, 5761.942380576183, 5771.0, 6199.194104766351, 6272.466840318624, 6276.968615156895, 6297.874042519124, 6316.05259211122, 6111.144439778434, 6137.754489820447, 6140.570160088841, 6143.692815359214, 6151.200343955257, 6257.655828929453, 6281.497480201573, 6283.497320214372, 6290.559660823698, 6299.023651334051, 5205.375354957429, 6064.666443345658, 6117.279373342116, 6121.81881567809, 6215.595986260879, 6217.875642487125, 6253.6560489172625, 6257.74969001244, 6261.7182226799905, 6273.654948977759, 4921.630877684188, 4925.852224433201, 4943.9864827710235, 4954.603631709455, 4978.5270399312, 4369.344598310279, 4410.42664453619, 4458.71018383804, 4478.686491945533, 4493.0, 5693.946619875253, 5711.086226203787, 5722.914156287659, 5731.570132240098, 5746.109353050284, 6277.058441233851, 6288.874222515524, 6291.245050593958, 6299.370062993664, 6312.0531920211415, 5577.9163312550345, 5630.915536266959, 5682.772689092472, 5693.715314234355, 5734.713264336767, 5351.759170837322, 5369.060414427538, 5407.864803379947, 5407.891842163135, 5411.485908838654, 6204.534659900525, 6243.313235544087, 6263.154474145932, 6278.466330361879, 6286.52851036165, 6147.846303842261, 6237.719302631302, 6246.968765156145, 6299.811005669837, 6301.96849015752, 5437.211604317431, 6237.220347456568, 6279.0, 6280.0, 6291.1192433058495, 6125.326214116532, 6147.84630384244, 6151.354107818794, 6160.599561028519, 6170.969145154246, 6053.364396738455, 6109.908351374644, 6243.500519958483, 6255.843603909939, 6285.277193122849, 6093.512518998381, 6097.373446762037, 6105.9694701526205, 6113.871604717183, 6119.106526814536, 6084.543659225665, 6090.665013424305, 6098.786542470993, 6102.176206212104, 6112.113743507255, 5704.657720536781, 5863.560232982458, 5929.1995580597795, 5943.108533719977, 5963.701814909324, 6007.0, 6028.608140470856, 6045.17502717346, 6064.545159112996, 6094.908576371269, 5844.970775146097, 5851.736671849691, 5857.648541087548, 5863.17915491823, 5866.853328666817], "value": 5679.899016158052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.9350737650418, 510.1225891466677, 522.8091746512524, 558.1655425139418, 586.1822757253628, 28967.710322896764, 37715.86852394429, 38853.0, 38864.80567597165, 39074.21851562974, 42953.57046429542, 43879.78060109703, 43890.68327950167, 43893.341599876025, 43920.56079439205, 9535.332526723132, 9736.318457707963, 9747.0, 9750.512474376288, 9760.951195244013, 9583.472908990003, 9704.466254356008, 9711.271654625896, 9732.51337433129, 9739.123478886899, 9662.516874156265, 9703.466309352983, 9718.416894986289, 9760.2679799015, 9763.316567840255, 9537.80924381512, 9594.280428967855, 9595.712128636153, 9600.279979001603, 9709.320347575673, 9512.191463725592, 9597.568109435093, 9601.519924003773, 9605.991370906024, 9629.807403851953, 39707.60292397068, 40053.39919901204, 40092.99767505807, 40093.79953100245, 40195.0, 3373.004963535738, 3438.948415773765, 3748.11919198988, 3873.0511024799102, 3907.081835768592, 24463.0, 27705.030323938565, 29633.851830740925, 29639.0, 29723.554146687817, 2745.1901689001793, 2766.7094955029834, 2816.380396312808, 2845.146456063173, 2855.129185598392, 426209.0, 426747.0, 427397.0, 427522.0, 428352.0, 60618.09072863911, 61089.0, 61113.69443152756, 61162.69418652878, 61175.69412152911, 63474.60465860361, 63987.0, 64140.35859641437, 64291.03563446552, 64347.678261608395, 15719.68560628781, 15811.762823557656, 16014.759778603331, 16026.958247714094, 16040.438584649715, 12284.447199876027, 12346.629601111981, 12367.443465044094, 12368.81446778299, 12391.442385092692, 16605.50183494497, 16686.33254669824, 16702.0, 16705.415310464075, 16743.748843767353, 6569.178852643419, 6599.241087274929, 6619.404253617101, 6681.265060843303, 6730.966345168243, 967.351874244258, 991.3258983890879, 1032.0453580438066, 1075.4891426572315, 1077.8167711489066, 24491.632625510632, 29360.559591606143, 30125.0, 30631.081067568008, 30962.845185773927, 1065.1957771882335, 1070.7686160914855, 1146.9197156198986, 1152.590830255264, 1214.7449035702602, 12889.355532223351, 13141.277229752455, 13922.37349319283, 14347.0, 14361.569152925429, 651625.0, 669735.0, 670832.0, 670849.0, 671515.0, 56725.71637141788, 58432.70783646055, 58473.0, 58591.121133183035, 58684.41315586789, 1331.0283493049933, 1357.104311154653, 1437.2167168893188, 1453.6365908522869, 1494.5292232946804, 22900.31299061031, 28864.855675721486, 28874.0, 29566.0, 29693.257668558457, 41430.378544321255, 47982.76008620074, 48479.78800530015, 49208.753956229986, 49298.0, 372719.0, 386838.0, 387085.0, 387742.0, 388854.0, 23081.0, 25839.224823255332, 26571.202863914114, 26668.066617669065, 27704.722952771022, 43087.9228019302, 43386.78306608447, 43704.781476092416, 43716.34425483557, 44830.3275450862, 35533.82233088818, 35542.46686299656, 35835.46246806248, 36204.189790509845, 37135.44296835495, 36108.45837312495, 36116.63883361133, 36511.0, 36806.63193368139, 36850.8157459211, 30875.382492350476, 35328.94013179609, 35558.0, 35904.82047589745, 36661.450078248316, 28944.0, 31010.844945775127, 31377.8431107843, 31922.6807731929, 31995.36009279848, 23348.416289592897, 23977.00574856286, 24179.395515112265, 24487.632685509376, 24577.385565361008], "value": 19188.73120292786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2971821003983, 388.46004054364437, 389.44504081683596, 393.0550424824529, 399.85005622891396, 14183.13276878124, 19694.606107877833, 19695.606087878252, 20574.691379629297, 20618.793812061893, 16127.354905803782, 17645.382411615596, 20394.490137746565, 20477.180912763473, 20842.583148337024, 5658.207850900877, 5970.104484327342, 6013.098035294719, 6017.277926648809, 6037.335893051761, 5615.298087739033, 5890.381509941459, 5896.498797602209, 5902.3507414184405, 5948.245267646055, 5821.6507009579345, 5852.063669812809, 5860.384659610743, 5870.090136028923, 5879.265091863517, 5849.912251316234, 5895.410458954113, 5907.02534081876, 5907.734151963151, 5933.13969474426, 4964.255361695775, 5116.386033675945, 5120.564751996085, 5133.512316329943, 5140.511651393149, 24287.392815179584, 25478.0, 25926.0, 25936.22191334263, 25998.480030399474, 1985.6525108106168, 2019.5254115282896, 2171.8588291760984, 2370.97629023711, 2645.7354264573582, 14641.048331858501, 14677.0, 14732.983304936895, 15060.945733798639, 15143.394264229528, 1730.1695186310515, 1735.878488505805, 1779.7241427578747, 1782.9554261143576, 1867.9252829886789, 114161.0, 116422.83577164204, 117930.4103479477, 118054.0, 119191.40404297924, 10626.415547144981, 10885.346879187275, 11157.163212759075, 11189.272697274813, 11307.265027773168, 13991.58025259244, 14135.363908624136, 14186.148831069962, 14190.503332383318, 14197.503087392099, 6486.740530378732, 7415.59214243211, 8288.668453261922, 8435.451695639764, 8482.151784821468, 8191.508509489449, 8200.138985406445, 8202.83594328122, 8311.709090181814, 8344.62449189788, 6434.324395938359, 6526.967365163238, 6536.869262614721, 6550.181227346582, 6664.6337500812215, 1642.3102297035273, 1788.7495750594926, 1884.6701827180189, 1900.9714854277197, 1902.6301063234448, 903.5572569441058, 905.23055402907, 920.8158368326361, 980.4705459052032, 992.846108853129, 19763.604727905647, 19862.11999260099, 20360.24333529997, 20858.79141208599, 21625.891870540545, 961.9086186812242, 997.551102004101, 1001.234055947201, 1004.2267454060333, 1049.0, 10509.264351495474, 10911.890881091247, 10931.56273749057, 10952.4523773811, 11068.0, 562816.0, 590077.0, 608126.0, 609387.0, 617895.0, 115357.0, 118465.40767296108, 119077.0, 119082.4045879765, 121428.39285803691, 1031.8194315994822, 1031.8297480915714, 1052.8736551614008, 1054.2672842374477, 1054.7995880782628, 17951.743377963416, 18159.273629055217, 18202.45392638223, 18307.26770929148, 18373.03585943499, 32109.35781284408, 44650.0, 45570.544294557956, 46151.76924115358, 47733.76133119312, 65813.67093164503, 66483.33516664771, 67212.66393668001, 67437.0, 69894.0, 7541.509801862861, 7633.732819351296, 7733.729319474017, 7808.6095695216145, 8023.318017968538, 11721.589744358907, 11869.109816763605, 12130.211536250115, 12192.75614487723, 12203.511859525875, 8925.196732294125, 10019.649312274327, 10193.23550733683, 10617.126072752415, 10747.978942000498, 8351.457155284887, 10195.388276703421, 10205.979402060031, 10218.233632477743, 10621.362718236931, 10409.375437473776, 10451.216158788273, 10589.4705264738, 10791.676249712522, 10802.243842930919, 6775.322467753185, 7521.699132034657, 7659.923400766144, 7752.8449431012195, 7927.0, 10055.648052318134, 10134.087932086148, 10329.74175645615, 10527.0, 10529.105026072562], "value": 9423.161440814678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.9563565275216, 1605.5022942887706, 1624.545127364338, 1883.7927827938934, 2009.3570057581571, 7806.219378062191, 8527.275181609562, 8752.29981601472, 8770.254528365082, 8772.210501054911, 8057.556834374107, 8123.634436450359, 8211.260986511214, 8214.63034163464, 8230.0, 2158.5359147783224, 2160.567886422714, 2386.6300723387903, 2411.336882357353, 2487.514934587756, 2443.6945381827272, 2474.6659201007906, 2477.3682710908693, 2486.589712697412, 2494.48862983088, 2412.7104747430335, 2448.1309135256993, 2448.1431498975394, 2452.0682140786566, 2459.1515927005153, 2422.200673777649, 2439.207257641274, 2447.412620970972, 2447.6940382452194, 2453.0800949643885, 2354.8704821234824, 2370.348154257593, 2373.6320870265135, 2377.0848223434105, 2377.09670325277, 8729.60716767747, 8844.823103537958, 8845.248153906925, 8858.114188581154, 8864.689735859278, 5158.303629010074, 5311.389190243133, 5326.334208223972, 5361.812336568201, 5385.0, 3428.777129486575, 3450.3099380124077, 3494.9989814120177, 3513.5608048993877, 3528.558930133733, 1021.5454122915305, 1037.7613148975702, 1040.7086015915556, 1045.6131231444338, 1049.5801679328254, 11017.0, 11024.952629500185, 11030.0, 11030.338179709162, 11034.668959931216, 4585.587297143273, 4590.747508886977, 4811.182099043171, 4839.9758001210475, 4856.68431551948, 9467.905320946702, 9468.242540596873, 9477.431354118775, 9488.146066854017, 9526.714198574055, 5309.7345132743985, 5344.144936810169, 5345.305110335631, 5350.3312085989255, 5367.221752845816, 4419.955800442019, 4536.160810250114, 4885.145099607555, 4905.166121759309, 5005.674631149037, 3957.841686332572, 4022.0950286185375, 4044.2315959967514, 4085.6527195188146, 4087.9795601021806, 1312.4946895445132, 1316.795896636023, 1331.5805521260966, 1338.5448947357945, 1342.8052932324954, 1120.9271397359146, 1166.2943918928927, 1292.6768307922832, 1361.537077393671, 1365.208179256029, 8074.475159114756, 8120.796980075545, 8124.512529248264, 8137.471064380797, 8171.836563268701, 507.3505912432093, 523.3144580599427, 523.9764210610532, 525.3879230696197, 527.8495628745789, 6155.784547540815, 6248.218972628421, 6370.872582548323, 6389.041643753381, 6396.232452105684, 10062.597496100221, 10463.84304235437, 10529.526171322308, 10557.894421055844, 10579.788404231873, 10361.740956475998, 10475.738106547396, 10627.0, 10632.41521716313, 10648.14814814813, 7909.050913890255, 8026.839463210703, 8037.879431808527, 8081.272685458337, 8083.434159608889, 7767.184445633353, 7937.603119844101, 7968.521888686697, 7975.361971042419, 7975.680972761024, 9588.760280992752, 9742.805143897223, 9812.067853553901, 9856.112949834549, 9952.203823693942, 9292.860607091034, 9574.0, 9583.904160958302, 9596.76008099803, 9934.850977235492, 6243.500519958483, 6864.519483636098, 7094.255103214088, 7298.0, 7576.8484630308185, 8217.83564328722, 8225.79435514117, 8278.089410164997, 8293.170682931659, 8295.751127466187, 7296.087989001375, 7345.081864766904, 7365.631718414165, 7529.360004399468, 7541.5475071495885, 7001.754938577329, 7134.536255143399, 7144.285571442814, 7197.892031619425, 7198.100237470317, 7474.177840437656, 7564.319211271012, 7585.393168546393, 7587.317141457295, 7597.2022937590755, 6774.356436138559, 6795.116634837439, 6878.793636190922, 6882.965585172042, 6889.689963951534, 6733.6296503692765, 6836.0, 6838.350356716104, 6842.931570684428, 6912.239653637996], "value": 4767.514600484359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6575906189758, 322.5065649556178, 324.1151655979178, 329.9950500742489, 331.3274053671046, 4883.2430973199125, 5160.535551800342, 5782.82651520454, 5856.414358564152, 5866.354700982888, 5741.511971482419, 5742.28221472316, 5743.54051675866, 5754.65472071676, 5802.926458605161, 3704.2403409459857, 3963.7225394222414, 4048.4736984192014, 4265.189613973351, 4405.207062728708, 4350.0, 4362.302031674933, 4380.321050237202, 4398.428204333432, 4405.880501730876, 3969.0, 4208.473940757405, 4387.188370151516, 4387.736735795863, 4395.670324725643, 3567.910802229965, 3914.9038269284647, 4240.703150779446, 4383.649308055364, 4391.253486907233, 3423.96576034239, 3642.6357364263627, 3813.9427908581392, 3825.464434979105, 3856.9915465936615, 5027.542012816279, 5219.824140687473, 5553.972230138864, 5592.5805564582815, 5618.7190640468225, 4245.61789438952, 4850.9272360914265, 5012.624053196025, 5046.924296135561, 5050.267711181858, 6040.395960403968, 6045.6674882881425, 6048.727807248684, 6074.119252708377, 6079.361667024943, 3552.662497062775, 4201.621854033152, 4202.726822756542, 4204.768737719424, 4220.894477638053, 5948.79894439056, 5959.314678811992, 6089.238845144357, 6394.168758061469, 6469.547131700783, 3701.370766969622, 3910.804459777, 4129.050318426718, 4159.688023398257, 4169.478815148106, 4118.341065429517, 4237.131388065439, 4237.788110594458, 4240.618344349024, 4272.423222864935, 4636.629069674418, 4938.8765280868265, 4981.825636102719, 4986.152354099811, 4986.700797952134, 5405.999890020359, 6106.297775755756, 6124.571280010446, 6154.230721159855, 6178.0, 1222.2299951030793, 1451.310627451973, 1453.4113683958014, 1456.4174330267977, 1458.4968185975822, 929.5636479658637, 961.3799099580731, 963.6145541783343, 971.2909576009553, 976.8534719791946, 4833.492483289274, 5665.263515742927, 5705.800296989585, 5718.0272805881905, 5749.453801888814, 6308.211473565804, 6322.936770632326, 6333.588316759396, 6338.556301058974, 6348.682565871688, 4893.877653058631, 5404.864878377994, 5712.200291959129, 5717.8570535736935, 5719.942800572025, 3311.983440082832, 3319.2365755876285, 3350.9664903350654, 3353.625013744353, 3377.2401209728105, 5536.695481748462, 6120.510359171256, 6238.189035425366, 6547.312532184147, 6547.34526547351, 5677.602567820213, 6229.283632382243, 6476.384743449365, 6495.642739649365, 6525.608463492205, 5688.943110568925, 6342.207224096988, 6604.3725846044545, 6636.502262330345, 6657.933420665731, 6086.939130608815, 6393.968030159819, 6399.968000159969, 6408.263049749338, 6420.229572451336, 5513.476219759116, 6235.251769787655, 6279.246490421178, 6297.181366422519, 6308.810735677937, 5431.456854314537, 6594.571352862049, 6594.571352862049, 6602.8349291268105, 6677.632730199885, 3915.3735402335487, 3919.412088186795, 4151.647109995684, 4178.435911151955, 4208.074223670787, 6128.754849805958, 6292.276388215414, 6320.968395158179, 6330.082138090043, 6334.429901308904, 5950.910736339045, 6136.140940268277, 6145.201123853871, 6153.630782153085, 6162.815115546541, 5272.76272567743, 5804.1874137619925, 6089.391060894052, 6139.631622102688, 6141.723622436912, 5565.916511252415, 5771.047777116896, 5959.463648271503, 5963.850903727442, 5982.025931442527, 5465.808696695596, 5545.511751250965, 5690.544756419559, 6118.20463339763, 6122.74483730843, 5518.448155184449, 6030.758769649165, 6036.456718895321, 6061.909071363845, 6098.725557349841], "value": 4457.756261274582, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9194158788563, 673.2291526202498, 712.8004158835528, 712.8752468318045, 744.735618855306, 14784.852151478482, 15180.240987950587, 15242.923785381057, 15249.31378087986, 15277.618059548517, 15195.392184312614, 15664.530064098068, 15684.215789210522, 15688.215589220521, 15727.685446291096, 726.5459088069956, 744.8212429017051, 916.0610374366262, 918.6279556779515, 923.2706162131908, 909.236241557092, 928.16465181337, 928.7817362919709, 929.4748467116092, 930.0374112793261, 966.3139171188465, 966.8259713251612, 967.0281367225963, 967.4243824924159, 968.7384406210319, 758.9848203035908, 774.7327172125607, 775.3448336155939, 964.2189826240732, 970.5972021611022, 576.6684156609924, 694.3195668245148, 709.7054722290243, 710.605613884294, 712.0316369737153, 15363.385464581403, 15405.845941540552, 15449.227538623136, 15456.381744730197, 15462.536123916301, 10004.39841657003, 11030.896910308906, 12333.198342107824, 12565.869071783492, 12657.620271391874, 9989.900100999042, 10178.592856285739, 10208.18334533243, 10212.897871021269, 10934.507947142398, 3442.2599141184764, 3485.9128521786906, 3516.2791627716256, 3526.1360966563357, 3590.964090359089, 82675.0, 83620.0, 84054.318913622, 84217.0, 84496.57751711263, 9362.765930851783, 9384.488268145313, 9449.149576538008, 9667.081627245401, 9769.560369783378, 21503.2473863414, 21548.922553872242, 21566.676499852514, 21573.568528629654, 21581.78418215798, 7138.428925686037, 7431.925680743231, 7438.1446133694235, 7470.028896243453, 7582.658780354897, 4069.6337329640473, 4115.053537686349, 4154.813033413504, 4192.329227323614, 4341.826326946887, 3536.664016918389, 3654.3787556115526, 3656.5794933582447, 3658.5975542690285, 3659.9817000914827, 650.1580453312877, 652.0773106054879, 657.9046038324416, 660.92729799722, 671.1744554198364, 442.8870637987357, 478.95928846048474, 529.3991319851918, 582.7788359264831, 617.1791517282004, 7272.563646181246, 7672.232776722395, 7775.688972441152, 7847.489913155627, 8034.558099304478, 567.8410045187354, 585.5802115644656, 594.5006194796392, 601.8856417280703, 607.5504126946028, 3580.6240344763946, 3829.9808500957874, 3841.9807900960877, 3859.3246181918053, 3870.6903447724117, 73739.0, 75769.0, 75817.0, 75992.62003689946, 86510.83722906977, 55972.0, 64660.353396465434, 67613.66193169101, 68044.0, 68678.0, 63905.72188556296, 64933.70132597322, 67564.0, 68197.0, 68937.62124757477, 8199.59002049907, 8217.83564328698, 8348.749537513884, 8437.915620843713, 8447.746567602982, 43033.784831075645, 43670.344944825214, 44081.77959110184, 44091.0, 45863.0, 50830.491695084056, 61931.0, 63532.50571218627, 63751.6812415935, 63771.681141593996, 10911.890881091405, 11075.944620276847, 11140.654742084282, 11252.718682032688, 11475.024622907147, 11479.785660014875, 11931.164818462625, 11931.582394616147, 12015.579454719043, 12410.33069741143, 11344.716382090513, 11377.693263807309, 11460.255083419552, 11477.0, 12071.75856482883, 11418.371989540656, 11730.472128754398, 11798.587049453228, 11852.0, 12000.939995299968, 11130.610428634958, 11221.0, 11451.484683189443, 11729.648110556696, 11890.10824188172, 9401.435913845191, 9677.951610241904, 9740.318177727491, 9820.4107753535, 10060.346077504939, 9297.45889387145, 9501.619935202514, 9537.952310238405, 9542.66600669001, 9699.272554558578], "value": 6770.302613269838, "unit": "score"}], "name": "dromaeo_css", "value": 7271.207992736386, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 113.0, 114.0, 115.0, 119.0, 117.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 149.0, 172.0, 160.0, 120.0, 142.0, 142.0, 120.0, 163.0, 121.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 184.0, 188.0, 183.0, 186.0, 187.0, 186.0, 188.0, 181.0, 186.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 83.0, 84.0, 80.0, 84.0, 61.0, 82.0, 80.0, 55.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 127.0, 77.0, 90.0, 112.0, 154.0, 82.0, 78.0, 118.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 121.0, 88.0, 89.0, 85.0, 91.0, 87.0, 89.0, 86.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 85.0, 87.0, 85.0, 87.0, 87.0, 85.0, 87.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 55.0, 53.0, 54.0, 64.0, 55.0, 52.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 77.0, 72.0, 71.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 81.0, 85.0, 81.0, 83.0, 85.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 156.0, 164.0, 163.0, 141.0, 140.0, 135.0, 141.0, 144.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 169.0, 168.0, 168.0, 169.0, 167.0, 170.0, 173.0, 165.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 94.0, 91.0, 92.0, 76.0, 68.0, 69.0, 66.0, 66.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1499.6, "alertThreshold": 2.0}]} 09:16:28 INFO - Return code: 0 09:16:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:16:29 ERROR - # TBPL SUCCESS # 09:16:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:29 INFO - 2016-04-08 09:16:29.039 screenresolution[1682:9973] starting screenresolution argv=screenresolution get 09:16:29 INFO - 2016-04-08 09:16:29.041 screenresolution[1682:9973] Display 0: 1600x1200x32@60 09:16:29 INFO - 2016-04-08 09:16:29.047 screenresolution[1683:9976] starting screenresolution argv=screenresolution list 09:16:29 INFO - Available Modes on Display 0 09:16:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:29 INFO - Intel Iris: 09:16:29 INFO - Chipset Model: Intel Iris 09:16:29 INFO - Type: GPU 09:16:29 INFO - Bus: Built-In 09:16:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:29 INFO - Vendor: Intel (0x8086) 09:16:29 INFO - Device ID: 0x0a2e 09:16:29 INFO - Revision ID: 0x0009 09:16:29 INFO - Displays: 09:16:29 INFO - Display: 09:16:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:29 INFO - Display Serial Number: 1600x1200 60 09:16:29 INFO - Main Display: Yes 09:16:29 INFO - Mirror: Off 09:16:29 INFO - Online: Yes 09:16:29 INFO - Rotation: Supported 09:16:29 INFO - Return code: 0 09:16:29 INFO - Running post-action listener: _resource_record_post_action 09:16:29 INFO - Running post-run listener: _resource_record_post_run 09:16:30 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 32361984; Write bytes: 691809280; Read time: 321; Write time: 1957 09:16:30 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375065088; Write bytes: 369690624; Read time: 28000; Write time: 713 09:16:30 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 31428096; Write bytes: 297092096; Read time: 307; Write time: 1193 09:16:30 INFO - Running post-run listener: _upload_blobber_files 09:16:30 INFO - Blob upload gear active. 09:16:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:30 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 09:16:30 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'] 09:16:30 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 09:16:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:16:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:31 INFO - (blobuploader) - INFO - Done attempting. 09:16:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:16:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:16:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:32 INFO - (blobuploader) - INFO - Done attempting. 09:16:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:32 INFO - Return code: 0 09:16:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65cc0987ba204aaeb6d6d8f80e705b5957b6d813b75b994b38518a0536e203a7861898de88b075c7ecd63c9247d433eea61dc6acc1983863a5cf1f9919f2360d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/305ff12a744fd854a22fee500adef420c19b9cf9b4be668ca32bece8b0bdd845267b50cc98dc34ecb876fc343e88944772bc6f43ea883c5cd9edebb8a652efa1"} 09:16:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:32 INFO - Contents: 09:16:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65cc0987ba204aaeb6d6d8f80e705b5957b6d813b75b994b38518a0536e203a7861898de88b075c7ecd63c9247d433eea61dc6acc1983863a5cf1f9919f2360d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/305ff12a744fd854a22fee500adef420c19b9cf9b4be668ca32bece8b0bdd845267b50cc98dc34ecb876fc343e88944772bc6f43ea883c5cd9edebb8a652efa1"} 09:16:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:32 INFO - Copying logs to upload dir... 09:16:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.815213 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-08 09:16:32.906711) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 09:16:32.910268) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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/65cc0987ba204aaeb6d6d8f80e705b5957b6d813b75b994b38518a0536e203a7861898de88b075c7ecd63c9247d433eea61dc6acc1983863a5cf1f9919f2360d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/305ff12a744fd854a22fee500adef420c19b9cf9b4be668ca32bece8b0bdd845267b50cc98dc34ecb876fc343e88944772bc6f43ea883c5cd9edebb8a652efa1"} build_url:https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/VnsCB6bRTmCSfxCSHl9e6A/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/65cc0987ba204aaeb6d6d8f80e705b5957b6d813b75b994b38518a0536e203a7861898de88b075c7ecd63c9247d433eea61dc6acc1983863a5cf1f9919f2360d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/305ff12a744fd854a22fee500adef420c19b9cf9b4be668ca32bece8b0bdd845267b50cc98dc34ecb876fc343e88944772bc6f43ea883c5cd9edebb8a652efa1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 09:16:32.940740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:16:32.941485) ========= 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.S4iHrcSnDs/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.lWRlXBdKUY/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005199 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:16:32.992488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 09:16:32.993198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 09:16:32.994018) ========= ========= Total master_lag: 0.48 =========