builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0035 starttime: 1457662696.54 results: success (0) buildid: 20160310172413 builduid: 04ab1d0835174a0697109a1f4d77f23c revision: 9f8996d35a3acc7687237aa366f6fba111e6f90f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.537790) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.538229) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.538556) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005563 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.572654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.576026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.594141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.594451) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.004981 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.644201) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.644513) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.646361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.646697) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-10 18:18:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-03-10 18:18:16 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.774155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.774504) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.024649 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:16.968229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-10 18:18:16.968619) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f8996d35a3acc7687237aa366f6fba111e6f90f --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 9f8996d35a3acc7687237aa366f6fba111e6f90f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-10 18:18:17,136 truncating revision to first 12 chars 2016-03-10 18:18:17,136 Setting DEBUG logging. 2016-03-10 18:18:17,136 attempt 1/10 2016-03-10 18:18:17,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f8996d35a3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 18:18:19,181 unpacking tar archive at: fx-team-9f8996d35a3a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.289573 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-10 18:18:19.372094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:19.373035) ========= echo 9f8996d35a3acc7687237aa366f6fba111e6f90f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9f8996d35a3acc7687237aa366f6fba111e6f90f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 9f8996d35a3acc7687237aa366f6fba111e6f90f program finished with exit code 0 elapsedTime=0.005313 script_repo_revision: '9f8996d35a3acc7687237aa366f6fba111e6f90f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:19.428733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:19.429469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 18:18:19.445059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-10 18:18:19.445674) ========= /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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:19 INFO - MultiFileLogger online at 20160310 18:18:19 in /builds/slave/test 18:18:19 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 18:18:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:19 INFO - {'append_to_log': False, 18:18:19 INFO - 'base_work_dir': '/builds/slave/test', 18:18:19 INFO - 'blob_upload_branch': 'Fx-Team', 18:18:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:19 INFO - 'branch': 'Fx-Team', 18:18:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:19 INFO - 'config_files': ('talos/mac_config.py',), 18:18:19 INFO - 'default_actions': ('clobber', 18:18:19 INFO - 'read-buildbot-config', 18:18:19 INFO - 'download-and-extract', 18:18:19 INFO - 'populate-webroot', 18:18:19 INFO - 'create-virtualenv', 18:18:19 INFO - 'install', 18:18:19 INFO - 'run-tests'), 18:18:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:19 INFO - 'download_minidump_stackwalk': True, 18:18:19 INFO - 'download_symbols': 'ondemand', 18:18:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:19 INFO - 'installer_path': 'installer.exe', 18:18:19 INFO - 'log_level': 'info', 18:18:19 INFO - 'log_name': 'talos', 18:18:19 INFO - 'log_to_console': True, 18:18:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:18:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:18:19 INFO - 'opt_config_files': (), 18:18:19 INFO - 'pip_index': False, 18:18:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:19 INFO - 'cmd': ('bash', 18:18:19 INFO - '-c', 18:18:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:19 INFO - 'enabled': True, 18:18:19 INFO - 'halt_on_failure': False, 18:18:19 INFO - 'name': 'check_screen_resolution'},), 18:18:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:19 INFO - 'cmd': ('bash', 18:18:19 INFO - '-c', 18:18:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:19 INFO - 'enabled': True, 18:18:19 INFO - 'halt_on_failure': False, 18:18:19 INFO - 'name': 'check_screen_resolution'},), 18:18:19 INFO - 'run_cmd_checks_enabled': True, 18:18:19 INFO - 'sps_profile': False, 18:18:19 INFO - 'sps_profile_interval': 0, 18:18:19 INFO - 'suite': 'dromaeojs', 18:18:19 INFO - 'system_bits': '32', 18:18:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:19 INFO - 'title': 't-yosemite-r7-0035', 18:18:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:19 INFO - 'use_talos_json': True, 18:18:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:19 INFO - 'work_dir': 'build'} 18:18:19 INFO - ##### 18:18:19 INFO - ##### Running clobber step. 18:18:19 INFO - ##### 18:18:19 INFO - Running pre-action listener: _resource_record_pre_action 18:18:19 INFO - Running main action method: clobber 18:18:19 INFO - rmtree: /builds/slave/test/build 18:18:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:22 INFO - Running post-action listener: _resource_record_post_action 18:18:22 INFO - ##### 18:18:22 INFO - ##### Running read-buildbot-config step. 18:18:22 INFO - ##### 18:18:22 INFO - Running pre-action listener: _resource_record_pre_action 18:18:22 INFO - Running main action method: read_buildbot_config 18:18:22 INFO - Using buildbot properties: 18:18:22 INFO - { 18:18:22 INFO - "project": "", 18:18:22 INFO - "product": "firefox", 18:18:22 INFO - "script_repo_revision": "production", 18:18:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:18:22 INFO - "repository": "", 18:18:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:18:22 INFO - "buildid": "20160310172413", 18:18:22 INFO - "pgo_build": "False", 18:18:22 INFO - "basedir": "/builds/slave/test", 18:18:22 INFO - "buildnumber": 486, 18:18:22 INFO - "slavename": "t-yosemite-r7-0035", 18:18:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:18:22 INFO - "platform": "yosemite_r7", 18:18:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:18:22 INFO - "branch": "fx-team", 18:18:22 INFO - "repo_path": "integration/fx-team", 18:18:22 INFO - "revision": "9f8996d35a3acc7687237aa366f6fba111e6f90f", 18:18:22 INFO - "stage_platform": "macosx64", 18:18:22 INFO - "builduid": "04ab1d0835174a0697109a1f4d77f23c", 18:18:22 INFO - "slavebuilddir": "test" 18:18:22 INFO - } 18:18:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:18:22 INFO - Running post-action listener: _resource_record_post_action 18:18:22 INFO - ##### 18:18:22 INFO - ##### Running download-and-extract step. 18:18:22 INFO - ##### 18:18:22 INFO - Running pre-action listener: _resource_record_pre_action 18:18:22 INFO - Running main action method: download_and_extract 18:18:22 INFO - mkdir: /builds/slave/test/build/tests 18:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:22 INFO - https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:23 INFO - Downloaded 1199 bytes. 18:18:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:18:23 INFO - Using the following test package requirements: 18:18:23 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:18:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:18:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:18:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'jsshell-mac.zip'], 18:18:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:18:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:18:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:18:23 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:18:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:18:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:18:23 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:18:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:18:23 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')]} 18:18:23 INFO - https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:24 INFO - Downloaded 17867597 bytes. 18:18:24 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'] 18:18:24 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 18:18:27 INFO - Return code: 0 18:18:27 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 18:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:27 INFO - https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:29 INFO - Downloaded 17867597 bytes. 18:18:29 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'] 18:18:29 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 18:18:32 INFO - Return code: 0 18:18:32 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')]} 18:18:32 INFO - https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:18:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:33 INFO - Downloaded 10845161 bytes. 18:18:33 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'] 18:18:33 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 18:18:33 INFO - Return code: 0 18:18:33 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')]} 18:18:33 INFO - https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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 18:18:37 INFO - Downloaded 110984308 bytes. 18:18:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:18:37 INFO - mkdir: /builds/slave/test/properties 18:18:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:37 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:37 INFO - Contents: 18:18:37 INFO - build_url:https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:18:38 INFO - Running post-action listener: _resource_record_post_action 18:18:38 INFO - Running post-action listener: set_extra_try_arguments 18:18:38 INFO - ##### 18:18:38 INFO - ##### Running populate-webroot step. 18:18:38 INFO - ##### 18:18:38 INFO - Running pre-action listener: _resource_record_pre_action 18:18:38 INFO - Running main action method: populate_webroot 18:18:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:38 INFO - '--tppagecycles', 18:18:38 INFO - '7'], 18:18:38 INFO - 'tests': ['tsvgm']}}, 18:18:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:18:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:18:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'tests': ['damp', 'tps']}, 18:18:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['damp', 'tps']}, 18:18:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:18:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:38 INFO - 'other': {'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'other_l64': {'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'other_nol64': {'tests': ['a11yr', 18:18:38 INFO - 'ts_paint', 18:18:38 INFO - 'tpaint', 18:18:38 INFO - 'sessionrestore', 18:18:38 INFO - 'sessionrestore_no_auto_restore', 18:18:38 INFO - 'tabpaint']}, 18:18:38 INFO - 'svgr': {'tests': ['tsvgx', 18:18:38 INFO - 'tsvgr_opacity', 18:18:38 INFO - 'tart', 18:18:38 INFO - 'tscrollx', 18:18:38 INFO - 'cart']}, 18:18:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['tsvgx', 18:18:38 INFO - 'tsvgr_opacity', 18:18:38 INFO - 'tart', 18:18:38 INFO - 'tscrollx', 18:18:38 INFO - 'cart']}, 18:18:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'tests': ['tp5o']}, 18:18:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'talos_options': ['--e10s'], 18:18:38 INFO - 'tests': ['tp5o']}, 18:18:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'talos_options': ['--xperf_path', 18:18:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:38 INFO - 'tests': ['tp5n']}, 18:18:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:38 INFO - 'talos_options': ['--e10s', 18:18:38 INFO - '--xperf_path', 18:18:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:38 INFO - 'tests': ['tp5n']}}, 18:18:38 INFO - 'talos.zip': {'path': '', 18:18:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:38 INFO - Running post-action listener: _resource_record_post_action 18:18:38 INFO - ##### 18:18:38 INFO - ##### Running create-virtualenv step. 18:18:38 INFO - ##### 18:18:38 INFO - Running pre-action listener: _resource_record_pre_action 18:18:38 INFO - Running main action method: create_virtualenv 18:18:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:38 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 18:18:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:38 INFO - Using real prefix '/tools/python27' 18:18:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:42 INFO - Installing pip.................done. 18:18:42 INFO - Return code: 0 18:18:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:42 INFO - 'HOME': '/Users/cltbld', 18:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:42 INFO - 'LOGNAME': 'cltbld', 18:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:42 INFO - 'MOZ_NO_REMOTE': '1', 18:18:42 INFO - 'NO_EM_RESTART': '1', 18:18:42 INFO - 'PAGER': '/bin/cat', 18:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:42 INFO - 'PWD': '/builds/slave/test', 18:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:42 INFO - 'SHELL': '/bin/bash', 18:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:42 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:42 INFO - 'USER': 'cltbld', 18:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:42 INFO - 'XPC_FLAGS': '0x0', 18:18:42 INFO - 'XPC_SERVICE_NAME': '0', 18:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 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 18:18:42 INFO - Cleaning up... 18:18:42 INFO - Return code: 0 18:18:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:42 INFO - 'HOME': '/Users/cltbld', 18:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:42 INFO - 'LOGNAME': 'cltbld', 18:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:42 INFO - 'MOZ_NO_REMOTE': '1', 18:18:42 INFO - 'NO_EM_RESTART': '1', 18:18:42 INFO - 'PAGER': '/bin/cat', 18:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:42 INFO - 'PWD': '/builds/slave/test', 18:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:42 INFO - 'SHELL': '/bin/bash', 18:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:42 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:42 INFO - 'USER': 'cltbld', 18:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:42 INFO - 'XPC_FLAGS': '0x0', 18:18:42 INFO - 'XPC_SERVICE_NAME': '0', 18:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 INFO - Downloading/unpacking psutil>=0.7.1 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:45 INFO - Installing collected packages: psutil 18:18:45 INFO - Running setup.py install for psutil 18:18:45 INFO - building 'psutil._psutil_osx' extension 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 INFO - building 'psutil._psutil_posix' extension 18:18:45 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 18:18:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:18:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:18:46 INFO - ^ 18:18:46 INFO - 1 warning generated. 18:18:46 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 18:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:46 INFO - Successfully installed psutil 18:18:46 INFO - Cleaning up... 18:18:46 INFO - Return code: 0 18:18:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:18:46 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')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:46 INFO - 'HOME': '/Users/cltbld', 18:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PAGER': '/bin/cat', 18:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:46 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - 'XPC_FLAGS': '0x0', 18:18:46 INFO - 'XPC_SERVICE_NAME': '0', 18:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:18:48 INFO - Installing collected packages: mozsystemmonitor 18:18:48 INFO - Running setup.py install for mozsystemmonitor 18:18:49 INFO - Successfully installed mozsystemmonitor 18:18:49 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:49 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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:49 INFO - 'HOME': '/Users/cltbld', 18:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PAGER': '/bin/cat', 18:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test', 18:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:49 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - 'XPC_FLAGS': '0x0', 18:18:49 INFO - 'XPC_SERVICE_NAME': '0', 18:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 INFO - Downloading docopt-0.6.1.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:53 INFO - Running setup.py install for blobuploader 18:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:53 INFO - Running setup.py install for requests 18:18:53 INFO - Running setup.py install for docopt 18:18:53 INFO - Successfully installed blobuploader requests docopt 18:18:53 INFO - Cleaning up... 18:18:53 INFO - Return code: 0 18:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:53 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')]} 18:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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')]} 18:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:53 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 18:18:53 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 18:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:53 INFO - 'HOME': '/Users/cltbld', 18:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:53 INFO - 'LOGNAME': 'cltbld', 18:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:53 INFO - 'MOZ_NO_REMOTE': '1', 18:18:53 INFO - 'NO_EM_RESTART': '1', 18:18:53 INFO - 'PAGER': '/bin/cat', 18:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:53 INFO - 'PWD': '/builds/slave/test', 18:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:53 INFO - 'SHELL': '/bin/bash', 18:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:53 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:53 INFO - 'USER': 'cltbld', 18:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:53 INFO - 'XPC_FLAGS': '0x0', 18:18:53 INFO - 'XPC_SERVICE_NAME': '0', 18:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-pwba_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-qqSnqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-xyqdhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-0yPpvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-CBMZxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nm31U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-w9aDpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-961ADa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-VGkbIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-OSpKgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-uxY_dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-D3rsa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-GQAJqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-g9ck_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-LIZS6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-41kNd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nlPtC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:55 INFO - Running setup.py install for manifestparser 18:18:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozcrash 18:18:56 INFO - Running setup.py install for mozdebug 18:18:56 INFO - Running setup.py install for mozdevice 18:18:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozfile 18:18:56 INFO - Running setup.py install for mozhttpd 18:18:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozinfo 18:18:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozInstall 18:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozleak 18:18:57 INFO - Running setup.py install for mozlog 18:18:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for moznetwork 18:18:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozprocess 18:18:57 INFO - Running setup.py install for mozprofile 18:18:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozrunner 18:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Running setup.py install for mozscreenshot 18:18:58 INFO - Running setup.py install for moztest 18:18:58 INFO - Running setup.py install for mozversion 18:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:58 INFO - Cleaning up... 18:18:58 INFO - Return code: 0 18:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:58 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:18:58 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 18:18:58 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 18:18:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:18:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:58 INFO - 'HOME': '/Users/cltbld', 18:18:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:58 INFO - 'LOGNAME': 'cltbld', 18:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:58 INFO - 'MOZ_NO_REMOTE': '1', 18:18:58 INFO - 'NO_EM_RESTART': '1', 18:18:58 INFO - 'PAGER': '/bin/cat', 18:18:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:58 INFO - 'PWD': '/builds/slave/test', 18:18:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:58 INFO - 'SHELL': '/bin/bash', 18:18:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:18:58 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:18:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:58 INFO - 'USER': 'cltbld', 18:18:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:58 INFO - 'XPC_FLAGS': '0x0', 18:18:58 INFO - 'XPC_SERVICE_NAME': '0', 18:18:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:58 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-K9teGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:58 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)) 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:58 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-F9W9iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-CzjM10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-myOHsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-rU5AqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ZGs_uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-baQBki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-a9HT70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-zYN0CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-2BvMA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-cHbhD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:59 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)) 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:59 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-A27f63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:00 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-rtdC1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:00 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-IOQb7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:00 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-_I_JbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:00 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-p09GJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:00 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-L3w9NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:02 INFO - Downloading blessings-1.6.tar.gz 18:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:02 INFO - Installing collected packages: blessings 18:19:02 INFO - Running setup.py install for blessings 18:19:03 INFO - Successfully installed blessings 18:19:03 INFO - Cleaning up... 18:19:03 INFO - Return code: 0 18:19:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:03 INFO - Reading from file tmpfile_stdout 18:19:03 INFO - Current package versions: 18:19:03 INFO - blessings == 1.6 18:19:03 INFO - blobuploader == 1.2.4 18:19:03 INFO - docopt == 0.6.1 18:19:03 INFO - manifestparser == 1.1 18:19:03 INFO - mozInstall == 1.12 18:19:03 INFO - mozcrash == 0.17 18:19:03 INFO - mozdebug == 0.1 18:19:03 INFO - mozdevice == 0.48 18:19:03 INFO - mozfile == 1.2 18:19:03 INFO - mozhttpd == 0.7 18:19:03 INFO - mozinfo == 0.9 18:19:03 INFO - mozleak == 0.1 18:19:03 INFO - mozlog == 3.1 18:19:03 INFO - moznetwork == 0.27 18:19:03 INFO - mozprocess == 0.22 18:19:03 INFO - mozprofile == 0.28 18:19:03 INFO - mozrunner == 6.11 18:19:03 INFO - mozscreenshot == 0.1 18:19:03 INFO - mozsystemmonitor == 0.0 18:19:03 INFO - moztest == 0.7 18:19:03 INFO - mozversion == 1.4 18:19:03 INFO - psutil == 3.1.1 18:19:03 INFO - requests == 1.2.3 18:19:03 INFO - wsgiref == 0.1.2 18:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:19:03 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 18:19:03 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 18:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:03 INFO - 'HOME': '/Users/cltbld', 18:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:03 INFO - 'LOGNAME': 'cltbld', 18:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:03 INFO - 'MOZ_NO_REMOTE': '1', 18:19:03 INFO - 'NO_EM_RESTART': '1', 18:19:03 INFO - 'PAGER': '/bin/cat', 18:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:03 INFO - 'PWD': '/builds/slave/test', 18:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:03 INFO - 'SHELL': '/bin/bash', 18:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:19:03 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:03 INFO - 'USER': 'cltbld', 18:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:03 INFO - 'XPC_FLAGS': '0x0', 18:19:03 INFO - 'XPC_SERVICE_NAME': '0', 18:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 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)) 18:19:04 INFO - Cleaning up... 18:19:04 INFO - Return code: 0 18:19:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:04 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')]} 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:04 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')]} 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:04 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:19:04 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 18:19:04 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 18:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:04 INFO - 'HOME': '/Users/cltbld', 18:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:04 INFO - 'LOGNAME': 'cltbld', 18:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:04 INFO - 'MOZ_NO_REMOTE': '1', 18:19:04 INFO - 'NO_EM_RESTART': '1', 18:19:04 INFO - 'PAGER': '/bin/cat', 18:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:04 INFO - 'PWD': '/builds/slave/test', 18:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:04 INFO - 'SHELL': '/bin/bash', 18:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:19:04 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:04 INFO - 'USER': 'cltbld', 18:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:04 INFO - 'XPC_FLAGS': '0x0', 18:19:04 INFO - 'XPC_SERVICE_NAME': '0', 18:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:04 INFO - Downloading/unpacking jsonschema 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:07 INFO - warning: no files found matching '*.txt' 18:19:07 INFO - no previously-included directories found matching 'build' 18:19:07 INFO - no previously-included directories found matching 'dist' 18:19:07 INFO - no previously-included directories found matching '.git*' 18:19:07 INFO - Installing collected packages: jsonschema, functools32 18:19:07 INFO - Running setup.py install for functools32 18:19:07 INFO - warning: no files found matching '*.txt' 18:19:07 INFO - no previously-included directories found matching 'build' 18:19:07 INFO - no previously-included directories found matching 'dist' 18:19:07 INFO - no previously-included directories found matching '.git*' 18:19:07 INFO - Successfully installed jsonschema functools32 18:19:07 INFO - Cleaning up... 18:19:07 INFO - Return code: 0 18:19:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:07 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 0x104de6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dee4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb19571cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, '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.cM5MazIxzI/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.L1LWRqRm1W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 18:19:07 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 18:19:07 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 18:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:07 INFO - 'HOME': '/Users/cltbld', 18:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:07 INFO - 'LOGNAME': 'cltbld', 18:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:07 INFO - 'MOZ_NO_REMOTE': '1', 18:19:07 INFO - 'NO_EM_RESTART': '1', 18:19:07 INFO - 'PAGER': '/bin/cat', 18:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:07 INFO - 'PWD': '/builds/slave/test', 18:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:07 INFO - 'SHELL': '/bin/bash', 18:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:19:07 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:07 INFO - 'USER': 'cltbld', 18:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:07 INFO - 'XPC_FLAGS': '0x0', 18:19:07 INFO - 'XPC_SERVICE_NAME': '0', 18:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:07 INFO - Downloading/unpacking flake8 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:19:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:19:09 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 18:19:09 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 18:19:09 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 18:19:09 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 18:19:09 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 18:19:09 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 18:19:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:19:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:11 INFO - no previously-included directories found matching 'docs/_build' 18:19:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:19:11 INFO - Running setup.py install for pep8 18:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:11 INFO - no previously-included directories found matching 'docs/_build' 18:19:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:19:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:19:11 INFO - Cleaning up... 18:19:11 INFO - Return code: 0 18:19:11 INFO - Running post-action listener: _resource_record_post_action 18:19:11 INFO - Running post-action listener: _start_resource_monitoring 18:19:11 INFO - Starting resource monitoring. 18:19:11 INFO - ##### 18:19:11 INFO - ##### Running install step. 18:19:11 INFO - ##### 18:19:11 INFO - Running pre-action listener: _resource_record_pre_action 18:19:11 INFO - Running main action method: install 18:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:11 INFO - Reading from file tmpfile_stdout 18:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:11 INFO - Reading from file tmpfile_stdout 18:19:11 INFO - Output received: 18:19:11 INFO - Usage: mozinstall [options] installer 18:19:11 INFO - Options: 18:19:11 INFO - -h, --help show this help message and exit 18:19:11 INFO - -d DEST, --destination=DEST 18:19:11 INFO - Directory to install application into. [default: 18:19:11 INFO - "/builds/slave/test"] 18:19:11 INFO - --app=APP Application being installed. [default: firefox] 18:19:11 INFO - mkdir: /builds/slave/test/build/application 18:19:11 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'] 18:19:11 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 18:19:45 INFO - Reading from file tmpfile_stdout 18:19:45 INFO - Output received: 18:19:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:19:45 INFO - Running post-action listener: _resource_record_post_action 18:19:45 INFO - ##### 18:19:45 INFO - ##### Running run-tests step. 18:19:45 INFO - ##### 18:19:45 INFO - Running pre-action listener: _resource_record_pre_action 18:19:45 INFO - Running main action method: run_tests 18:19:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:19:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:19:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:19:45 INFO - 2016-03-10 18:19:45.579 screenresolution[1665:7420] starting screenresolution argv=screenresolution get 18:19:45 INFO - 2016-03-10 18:19:45.582 screenresolution[1665:7420] Display 0: 1600x1200x32@60 18:19:45 INFO - 2016-03-10 18:19:45.588 screenresolution[1666:7422] starting screenresolution argv=screenresolution list 18:19:45 INFO - Available Modes on Display 0 18:19:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:19:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:19:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:19:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:19:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:19:45 INFO - Intel Iris: 18:19:45 INFO - Chipset Model: Intel Iris 18:19:45 INFO - Type: GPU 18:19:45 INFO - Bus: Built-In 18:19:45 INFO - VRAM (Dynamic, Max): 1536 MB 18:19:45 INFO - Vendor: Intel (0x8086) 18:19:45 INFO - Device ID: 0x0a2e 18:19:45 INFO - Revision ID: 0x0009 18:19:45 INFO - Displays: 18:19:45 INFO - Display: 18:19:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:19:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:19:45 INFO - Display Serial Number: 1600x1200 60 18:19:45 INFO - Main Display: Yes 18:19:45 INFO - Mirror: Off 18:19:45 INFO - Online: Yes 18:19:45 INFO - Rotation: Supported 18:19:45 INFO - Return code: 0 18:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:45 INFO - Python 2.7.3 18:19:45 INFO - Return code: 0 18:19:45 INFO - grabbing minidump binary from tooltool 18:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:45 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 0x104c8ad30>, '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 0x104aaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c81b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:45 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 18:19:45 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 18:19:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:45 INFO - Return code: 0 18:19:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:19:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:19:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:19:47 INFO - Return code: 0 18:19:47 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/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 18:19:47 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/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --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 18:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM5MazIxzI/Render', 18:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:47 INFO - 'HOME': '/Users/cltbld', 18:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:47 INFO - 'LOGNAME': 'cltbld', 18:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:47 INFO - 'MOZ_NO_REMOTE': '1', 18:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:47 INFO - 'NO_EM_RESTART': '1', 18:19:47 INFO - 'PAGER': '/bin/cat', 18:19:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:47 INFO - 'PWD': '/builds/slave/test', 18:19:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:47 INFO - 'SHELL': '/bin/bash', 18:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1LWRqRm1W/Listeners', 18:19:47 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 18:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:47 INFO - 'USER': 'cltbld', 18:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:47 INFO - 'XPC_FLAGS': '0x0', 18:19:47 INFO - 'XPC_SERVICE_NAME': '0', 18:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:47 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/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 18:19:47 INFO - mozversion application_buildid: 20160310172413 18:19:47 INFO - mozversion application_changeset: 9f8996d35a3acc7687237aa366f6fba111e6f90f 18:19:47 INFO - mozversion application_display_name: Nightly 18:19:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:47 INFO - mozversion application_name: Firefox 18:19:47 INFO - mozversion application_remotingname: firefox 18:19:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:19:47 INFO - mozversion application_vendor: Mozilla 18:19:47 INFO - mozversion application_version: 48.0a1 18:19:47 INFO - mozversion platform_buildid: 20160310172413 18:19:47 INFO - mozversion platform_changeset: 9f8996d35a3acc7687237aa366f6fba111e6f90f 18:19:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:19:47 INFO - mozversion platform_version: 48.0a1 18:19:47 INFO - using testdate: 1457662787 18:19:47 INFO - actual date: 1457662787 18:19:47 INFO - starting webserver on 'localhost:49270' 18:19:47 INFO - SUITE-START | Running 2 tests 18:19:47 INFO - TEST-START | dromaeo_css 18:19:47 INFO - operating with platform_type : mac_ 18:19:47 INFO - Initialising browser for dromaeo_css test... 18:19:47 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpqmSCoL/profile http://localhost:49270/getInfo.html) 18:19:49 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 18:19:49 INFO - PROCESS | 1684 | colorDepth:24 18:19:49 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 18:19:49 INFO - PROCESS | 1684 | __metrics 18:19:49 INFO - PROCESS | 1684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:19:49 ERROR - PROCESS | 1684 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:19:50 INFO - TEST-INFO | 1684: exit 0 18:19:50 INFO - Browser initialized. 18:19:50 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:50 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpqmSCoL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:02 INFO - PROCESS | 1687 | RSS: Main: 241451008 18:20:02 INFO - PROCESS | 1687 | 18:20:53 INFO - PROCESS | 1687 | 1457662853824 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] 18:23:03 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 18:23:05 INFO - PROCESS | 1687 | RSS: Main: 331096064 18:23:05 INFO - PROCESS | 1687 | 18:26:07 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 18:26:08 INFO - PROCESS | 1687 | RSS: Main: 368943104 18:26:08 INFO - PROCESS | 1687 | 18:29:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 18:29:10 INFO - PROCESS | 1687 | RSS: Main: 371150848 18:29:10 INFO - PROCESS | 1687 | 18:32:12 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 18:32:13 INFO - PROCESS | 1687 | RSS: Main: 332435456 18:32:13 INFO - PROCESS | 1687 | 18:35:16 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 18:35:17 INFO - PROCESS | 1687 | RSS: Main: 336916480 18:35:17 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:38:20 INFO - PROCESS | 1687 | RSS: Main: 380977152 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | __start_tp_report 18:38:20 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 18:38:20 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 18:38:20 INFO - PROCESS | 1687 | |i|pagename|runs| 18:38:20 INFO - PROCESS | 1687 | |0;dojo.html;3442.586889573251;3480.390931586972;3521;3528.0297918072533;3563.6792688658015;5590.86022849428;5633.6338138021;5659.320881494221;5660.2358681578025;5666.914996275049;5551.1673249012665;5609.607327487078;5611.719414029292;5612.07400778871;5621.747021384037;5069.645124841262;5070.8225212117395;5104.948950510485;5109.770060347293;5145.614078944075;5172.327597412331;5172.896542069157;5174.611904107188;5180.45605211453;5181.948180518203;5131.820386286481;5135.948640513603;5181.792728290864;5183.455737147602;5191.558717509016;5165.9225111623355;5213.322268105122;5229.973850130763;5230.2416149658275;5268.394134674523;4986.326845875833;5023.397192336906;5089.949100508985;5118.539331460149;5134.435212126663;4661.650376221763;5521.723913804334;5545.140503222007;5555.111182210827;5676.517496012844;5314.910443359102;6111.63330200185;6212.968935155295;6221.782237621662;6223.159873417076;6062.144951780659;6103.883205879423;6245.3442388549;6305.905411418832;6327.5254355923025;5767.36558978512;5772.307323121252;5778.508826749731;5783.681897495636;5812.88374232513;6325.304216536178;6334.144890439732;6341.365863413714;6346.904796428057;6351.269603995507;5951.1073338999495;6056.818295451144;6104.542159337979;6108.281362586102;6118.801925441459;6195.349488303663;6253.78111766086;6254.593451425642;6264.123022776815;6275.623462592168;6122.755089796358;6162.168107305546;6195.535334849904;6198.659073750987;6216.378362163838;6061.7575296987625;6110.862540392742;6119.776756597957;6187.721552530147;6209;4808.3027960946165;4818.132736107465;4818.734969576707;4850.054239423279;4854.611631069506;4329.848455304049;4331.870043898688;4345.087531618332;4371.431713877176;4388.605025547716;5355.116405793078;5457.072297709399;5650.7174641267775;5719.3136823581435;5756.597038207286;6245.437910587978;6299.5275354348605;6301.905471417932;6302.4958003359625;6314.842128946813;5657.9434205658235;5681.744321505542;5688.317401911797;5703.287089113861;5729.713514324267;5216;5284.9735751320995;5343.305370301913;5348;5381.73091345439;6303.716332765037;6316.8420789479715;6331.366863313632;6333.303336632875;6346.682665866781;6116.296625887901;6200.782972595937;6252.062190671254;6255.874882502416;6285.1515045470105;6268.27914789805;6330.556861019684;6346.650934198663;6352.237731472068;6359.618422894641;6131.816045518642;6144.969275153596;6183.876322473615;6186.288576813724;6191.442770150708;6105.877882442415;6135.754569817157;6252.999520076766;6255.687215639109;6270.717817698123;5668.801591944262;5687.20379146928;5694.971525142348;5722.885542289214;5753.510951569164;5684.175794509855;5686.687232202268;5695.202671626059;5702.258706368311;5710.029295019774;5596.916046259391;5618.381977982501;5669.54643628517;5732.197492350991;5951.851203719942;5913.497352724895;5967.134765459071;6013.278406591237;6083.209182806207;6144.10910417978;5757.913631295618;5801.6519008859605;5812.099124635688;5818.796342128006;5828.737706803119 18:38:20 INFO - PROCESS | 1687 | |1;ext.html;492.94824043475455;573.1431509892711;581.453433772254;610.685496969061;633.0377825704928;26191.345216369602;31060.534091988582;31096.533551996738;31196.22009449762;31255.218619534524;31750.36499270013;41069.58930410695;41592;41661;41882.162356752844;9614.375065620747;9790.167835733972;9832.803343933118;9842.803143937117;9842.852357214648;9544.522773861314;9652.75868103296;9662.420254784736;9664.4201347919;9674.951625241863;9633.08485693858;9703.854442183372;9712.708618741413;9713.22294216461;9733.464659443727;9671.516424178799;9839.966803485639;9840.409575425498;9851.113399794018;9856.704298871045;9691.07934746198;9835.409875407498;9836.409815411098;9845;9852.605895764162;41751.58248417507;42101.78949105265;42146.157076858595;42290.365644515354;42294.57705422937;3167.3665266946705;3212.5341825435416;3321.734261259118;3420.1791570023265;3426.1777173478436;23241.535169296687;24534.877325613437;25691.84386702603;28196.013139540224;30097.849510752527;2677.745614166651;2726.2230264374757;2866.312085099582;2881.0492537462587;2891.1182089462704;488235;491931;496655.9999999964;496701;498768;74110.25889741034;74542.62728686322;75347.62326188335;75362.62318688481;75480;78523.60738196272;79232.20767792364;79393.80909286365;79438.20561794423;79578.6021069891;17185.05482198491;17277.740833887503;17320.30718771235;17355.13224338778;17387.130643467775;12964;13068.673283167996;13070.934645326712;13085;13096.952243820471;22240.332790016324;22944;23320.883395582914;23360.883195583912;23395.7660423397;8464.619092140869;9814.52782082679;10018.39889606626;10145.898541014643;10379.01399367074;955.7323949294208;1012.1700205831148;1030.0317701360698;1061.1616822709973;1101.867775866885;28404.147875563765;29331.560026599192;29401.705982939897;29419.41161176807;30438;939.5208443693765;1066.173715370594;1162.581470670558;1163.4764356039648;1287.7102651903433;14997.550073497812;14998.95007349475;15020.549383518512;15378.154201519024;15416.306266217824;514859;520647;521254;521998;523262;60158;60783.69608151931;60824.39175608276;61021.38978610246;61062;1224.6693392783898;1301.8738790945763;1325.3505782166862;1441.3369849868968;1479.1568805780603;29637.85181074167;29716.10851674453;29811.10566683003;30459;30607.387852242384;52541.7372913133;53243;53243.73378133085;53246;53322;428817;431092;431516;432400;433058;33587.83206083954;35129;35133.648663513035;35146.485351464646;35238.647613523535;34565.65434345624;45513.77243113763;46421.76789116033;46651.600451986495;47872.281915770596;30595.847020764755;30915.227119322197;37114.814425927696;37209.813950930074;37953.81023094867;27804.721952781023;36303.092422689646;36432;36864.26271474502;37129.51481940692;36178.8191059043;36539.26921461609;36679.81660091683;36815.26369472649;37096.629033709316;30261.31103479205;32327;32465;32742;32884.849030283825;24282.51434971326;24291.271261862174;24608.384790380383;24738;24743.876280618482 18:38:20 INFO - PROCESS | 1687 | |2;jquery.html;323.51795824221904;359.67269784496114;359.80210884013786;367.2361488104742;368.06511460889345;19912.013198020286;19922.601547969032;21454.24910128144;21455.57088858222;21477.892610536925;19343.129559169836;20104.793712377268;20353.38939831804;20370.083346249416;20480.38558843237;5849.7367618457165;6024.397560243984;6066.120412540179;6069.817905462844;6076.817695469143;4224.408582798395;4502.504724480321;5993.640381577097;6521.380468855451;6536.281009088996;5086.745662716868;5146.176611742122;5185.948140518584;5200.29795977542;5573.526250268732;6096.51227901769;6182.474489668383;6360.395762402542;6449.935500645028;6494.0583615375745;5538.584606154554;5545.223668686387;5558.666480011212;5560.277163968699;5571.637843540157;24790.752092479026;25388.826396700413;25453.109141180154;25649.102281420248;25694.229173124837;2311.7572654871333;2356.917507887216;2390;2442.4992876460283;2704.945901081987;14376.353064112036;14437.13377197361;14592;15079.170645614488;15200.087994720352;1742.7473016412675;1787.1421717575506;1795.1293622593032;1812.1482903035685;1932.7970563090955;83289.58355208185;93769.5311523438;95240;103891;110964.4451777744;19157.233710651697;19410;19608.019599019994;19690.70463943042;19841.900790495954;29105.563416548768;29227.123186304445;29231.56152657712;29234.415311693647;29316;8801.91198088011;10267.281290309607;10573.89426105729;10601.363918164934;10617.469126543796;8553;8553.44402613828;8992.55037248135;9083.318751093695;9125.581720843982;8826.514541700268;8903.866442003375;8970;8991.730248092437;9004.774880628036;2999.805012674169;3382.1082974057317;3539.2567560812004;3540.6105328413855;3568.5896121946307;922.3543519536352;944.471096186138;985.5072463768116;988.7280997725683;1030.4538594544904;19526.511837204183;19707.4672825251;19760.505987350432;19995.400137995883;20237.79762202359;929.934904556688;936.1106948399048;956.53129966316;971.5232846074069;995.1392045880261;10710.036096751173;11031.779364412827;11047.337159770439;11330.894009032707;11401.087912966943;633518;634258;639130;648267;655356;120229;122361;124793;125879.74120258863;130335;1040.484959944817;1059.772148987956;1076.7415820203096;1078.6116997880756;1080.0387654987069;16196.757048644044;18509.81490185081;18815.341463048728;18909.621807564046;18913.905430472758;51831.44505664836;51834.74082629563;52833.7358313206;52870.735646321526;53862;63219.367806321345;74785.6260718693;75411.24588754043;76440.23559764332;80477.19522804697;7854.921450785419;8032.598370081356;8043.115257321573;8235;8244.505329680238;11065.778684426105;11891.94054029759;13056.934715326362;13314.733705326033;13459;11281.548738050715;11442.256253343507;11464.484098215433;11685.474153663276;11815.822762658396;11084.722881928017;11167.329960202414;11198.328100314007;11249.21255512139;11420.486078126338;11488.080953523866;11534.59628912984;11728.70678233051;11816.172867899164;11822;6828.7268509259075;7954.5624990626075;8006.399520036137;8092.271695547429;8310.21052999964;9790.85313720309;10634.787304253718;10920.890791091988;11299.661010169708;11418.885811141783 18:38:20 INFO - PROCESS | 1687 | |3;mootools.html;1450.057462649277;1592.3948899418224;1617.223732608348;1907.2847682119204;2034.8575599708008;7938.40461965352;8667.176618221267;8870.911290887088;8874.645014199441;8879.64481420744;8561.957190214056;8793.076726943675;8806.735797926072;8816.735497935073;8818.823623527525;2140.1332460353583;2431.8905649245826;2485.391079185593;2501.7498250174926;2507.1976967370447;2488.4525404411;2534.3410713214603;2539.898404063835;2541.834780739255;2543.249741326304;2435.281591930385;2480.9255722328357;2513.710923243832;2514.107491840398;2515.0065724038996;2445.144199530168;2473.146764366291;2491.676082109323;2502.323443292998;2518.4837108392735;2470.6664600278914;2493.6010238361955;2519.1183085919965;2522.911698090558;2523.6971563412326;8610.44032137909;8715.433496822687;8723.476591404473;8723.476591404537;8729.563521823884;5428.782848686048;5581.8604534886545;5589.245451863987;5607.158926161068;5612.831615051514;2965.569992351119;3629.927401451956;3634.745567810254;3674.1365779041903;3695.7412981091334;974.1719538392381;1054.4991129213638;1056.3186744549723;1071.4963966935527;1076.56399158341;11675.94916457523;11824.645260642195;11887.821682674767;11900.940495297555;11917.986971107379;4957.702537847741;4962.702237865739;4985.825496107619;4997.375328083989;5021;8727.738167854974;10283.07452329294;10313.793724125475;10320.948395257976;10333.689989300183;5529.502344788988;5562.082256427644;5567.8886422272135;5575.553955683536;5580.944190558123;4418.072204836956;4600.470945841271;4816.614670826326;4929.802807887644;5002.724850133278;3561.8753343632848;3897.395903634941;3930;3998.420229066769;4033.69747268956;1310.8164856920039;1324.582756431721;1325.191633103806;1336.4854531005633;1340.604521666111;1135.330155208431;1151.268944220426;1218.622227109599;1357.056845492393;1360.0547619404617;8089.31240844523;8269.21442462965;8279.172082791792;8282.8343433131;8307.37694672902;476.3783262841955;504.51818513319694;507.16571240309486;512.8692183493185;513.668683699012;6225.937740622627;6239.500839932794;6290.433860952537;6306.306306306303;6307.653079080695;10244.282900197064;10583.100436462986;10649.680509584725;10763.56945722178;10788.568457261621;8460.323174146053;10517.894821051692;10576.259661823598;10614.575416983389;10638.468076596138;7994.720184793504;8249.917500825035;8283.213094755989;8359.331253499706;8361.122082181406;7810.726624568113;7855.33229675484;7871.252231038042;7906.090799557895;7940.126586075412;9311.44131352121;9398.248140148635;9445.574949127169;9484.905150948402;9694.272929530454;9471.384360016576;9814.312998090065;9852.802943940938;9978.10197082237;9987.400755954666;6785.93214067853;6961.547499412522;7189.317014883578;7489.13874904393;7567.621618918922;8078.353731701567;8159.755207343789;8167.550784706898;8187.754367368989;8207.548584827891;7245.420366370783;7349.669264882986;7351.081114860643;7473.17795042534;7521.774346769387;7198.438724425911;7328.413726901728;7404.074490688664;7424.331810137113;7476.25237476248;6664.8000559983275;7666.884996724942;7675.194104619158;7698.422618303762;7737.535747855147;6940.514164008471;6947.513674042769;6947.687354068978;7008.614526201108;7009.894851577128;7087.043249161297;7161.39128174111;7165.749198778018;7179.138503379628;7182.533135346186 18:38:20 INFO - PROCESS | 1687 | |4;prototype.html;275.41474366970186;329.379120358125;331.02513098923674;335.41135307535274;337.5072394304316;6289.937100628998;6397.264314603822;6440.5491615586925;6447.903281450782;6451.161349024632;6321.810345689625;6340;6350;6355.618662880231;6360.968195159017;4506.932396014063;4608.354830323758;4616.584507394334;4748.145333839908;4765;4236.703430759832;4397.670174736892;4692.366530518388;4709.764511774415;4718.598919091882;4679.227927391977;4702.717836929795;4703.0593881223895;4703.6237101032;4705.223638099709;4480.103979204156;4611.884702882421;4617.7691115444095;4629.467611224719;4688.648351373644;3967.4247234151176;4051.129007263423;4057.2696914555368;4068.8779336619655;4072.7963601819793;6017.368176341465;6050.122732203806;6055.697215139269;6070.787522436738;6104.816855494342;4722.787474563618;5383.892322153574;5534.418886016951;5542.86142846428;5560.805371811967;5488.067028605146;6117.449429551317;6154.261488621394;6758.12144421227;6762.492813038993;4264.637505811978;4419.204543182226;4465.151621191995;4545.340925565807;4554.840580579664;7096.503244772868;7136.571805691623;7176.892346614753;7212.675429605628;7229.1686456057705;4518.615917646971;4525.321201819754;4526.411566496335;4529.365888775574;4532.116237333688;4599.7470139142;4606.078784243098;4610.76946152691;4615.661458177091;4626.329182268552;5423.376311724123;5432.7555260012605;5434.864128396822;5445.809396671098;5448.536874365724;6591.736330546821;6819.931800681929;6832.726690932307;6834.487413443912;6845.212800527904;1321.5770953294852;1578.1162548972611;1589.5628702107012;1597.8482044206014;1598.7362085256036;1014.624588902111;1014.9289549731595;1027.5067967375553;1038.1072277841051;1040.8542804007445;6085.330613632497;6282;6290.968545157245;6390.201224846895;6395.584287021329;6879.6216208108035;6967.82580435483;6982.860342793116;7017.263187365355;7067.71729130829;6401.647909364937;6409.102725618417;6414.166158399378;6421.325760795143;6444.387783160592;3704.49989251453;3753.549574051077;3765.3975363942186;3767.9434808477895;3770.2271034437877;7071.858562828715;7347.155077166088;7444.069491313586;7454.627268636655;7456.217097204824;6124.755009799647;7219.675114619855;7272.96363518179;7280.854382912312;7298.379637730853;6018.518518518508;7297.087864016998;7442.06974128234;7444.069491313586;7456.552606843498;5705.914411283751;7074.115735533059;7076.540024898365;7078.646067696697;7087.893681594677;6680.2651708313015;6910.861782764216;6916.79249622492;6946.16646002483;6970.198427180939;7302.160251570925;7340.486165968331;7347.926520734938;7366.300201480851;7446.851062978819;4688;4754.833580824655;4755.2153894607;4766.666333356632;4767.642426818072;7002.879539273692;7012.824679382852;7024.438044956289;7027.051348067946;7027.156741190885;6560.540762146795;6807.863842723217;6812.523123381316;6816.693248803716;6827.2490026098085;5183.870403239949;6789.981502774624;6790.7623233186605;6807.217170025312;6827.351401616838;5159.458256883124;6642.20293564756;6663.633500157538;6663.966680166568;6667.766628167991;5621.297337832771;6764.526483146133;6786.491013174131;6790.796276111724;6791.45668346541;6389.456896163878;6624.933750662624;6639.203295604559;6647;6670.899936501053 18:38:20 INFO - PROCESS | 1687 | |5;yui.html;682.4813142012073;691.5193940211552;710.1974768511581;723.3020135569175;817.4768148385035;14844.183569903651;15181.16503592302;15203.391864325442;15221.162836044014;15223.771643425358;13977.580672579814;15756.212189390542;16198.35206591738;16208.865379423445;16255.837441625581;706.0609389511962;907.3693782820942;917.4495302818323;925.5696101312889;927.958241879117;720.2509390234151;905.8777065096193;919.4529255093208;921.6543796076471;924.3991405586355;960.9375390599623;961.6970654243926;965.1988849255137;966.2752935298527;967.3228739882076;747.5103807006419;946.4179529589322;956.5073986896754;960.8174446855145;961.3270710502641;715.4133610439442;716.5808002318598;716.7276434954736;717.2504732554441;719.0329007484977;15502.379904803794;15530.611734706723;15540.533783986499;15578.22108894562;15593.37626494939;12261.448234829453;12362.567310144192;12371.319577423239;12516.311602861839;12703.301318427482;9884.950575247078;10136.290459667825;10263.79472410555;10583.31208471447;11063.170262230366;3596.1369271374942;3630.146915474861;3681.4109742441083;3766.472693822867;3769.5099637047283;67157.3284267156;73408.06367745338;81574.18425815726;81662.9999999994;82785;9017.143371379709;9302.302327325478;9362.110599493037;9370.10983956523;9571.138597526256;20972;21253;21259.36221913345;21309.68035479469;21338.78661213399;7281;7490.887636685454;7581.962090189514;7593.6582853771715;7639.732609358757;4032.4757781488806;4041.8383264669083;4052.797360131982;4062.5937406259727;4092.5293591237387;3624.1483251435893;3675.8345874435713;3681.834317455721;3681.9815900920858;3687.1519550503535;662.6686656671665;666.8032930285577;670.2191946382508;683.0642020431941;687.0244253160524;452.9297958816389;569.792025910548;573.292869484283;581.5870731780399;606.130203158469;7937.325327347125;8011.639476223584;8130.390220733469;8173.386995975326;8321.916780832235;541.8889127728806;580.1645630292365;597.2344368755041;605.2253116011424;617.5831313863124;3742.7754334740002;3771.5904104671304;3799.8290076946605;3874.341361968472;3897.902552436155;87353.56323218471;89794;89993;90124.19751605063;90219.54890225508;75783;76951.61524192455;77183.61408192923;78015;78577;65757.01364479537;65765.67117164383;66095;66630.66684666643;66910.99633505501;7649.273319034683;7675.078990521173;7778.299953004257;7800.765977020698;7873.37013038944;48721.512784871695;49551.752241238566;49875.75062124666;50010.749946250035;51297;62084.68957655183;66004.33995659983;66489.33510664832;66636.33363666301;67897.66051169712;9815.509224538888;9853.802923941337;9900.900990989998;9917;10290.073893349634;10792.298500597437;10807.783844323227;10841.783164336512;11158.44207789591;11328.94335528317;10292.588296468057;10305.53625086858;10360.740981475523;10561.788764224519;10625.840612390666;8610.569471526524;10280.588776448858;10368.792624147625;10597.576096956036;10744.151529791574;9900.950495247478;9914.603415863285;9957.651482198089;10260.127889129508;10294.279400442198;8358.916410836056;8371.32241694903;8651.264642505457;8655.82688346217;8812.427192232484;8532.829343413221;8564.143585641386;8702.390832641655;8719.564021799011;8774.298056155365 18:38:20 INFO - PROCESS | 1687 | __end_tp_report 18:38:20 INFO - PROCESS | 1687 | __start_cc_report 18:38:20 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1286 18:38:20 INFO - PROCESS | 1687 | __end_cc_report 18:38:20 INFO - PROCESS | 1687 | __startTimestamp1457663900362__endTimestamp 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | ------- Summary: start ------- 18:38:20 INFO - PROCESS | 1687 | Number of tests: 6 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#0] dojo.html Cycles:165 Average:5670.43 Median:5732.20 stddev:633.35 (11.0%) stddev-sans-first:610.70 18:38:20 INFO - PROCESS | 1687 | Values: 3442.6 3480.4 3521.0 3528.0 3563.7 5590.9 5633.6 5659.3 5660.2 5666.9 5551.2 5609.6 5611.7 5612.1 5621.7 5069.6 5070.8 5104.9 5109.8 5145.6 5172.3 5172.9 5174.6 5180.5 5181.9 5131.8 5135.9 5181.8 5183.5 5191.6 5165.9 5213.3 5230.0 5230.2 5268.4 4986.3 5023.4 5089.9 5118.5 5134.4 4661.7 5521.7 5545.1 5555.1 5676.5 5314.9 6111.6 6213.0 6221.8 6223.2 6062.1 6103.9 6245.3 6305.9 6327.5 5767.4 5772.3 5778.5 5783.7 5812.9 6325.3 6334.1 6341.4 6346.9 6351.3 5951.1 6056.8 6104.5 6108.3 6118.8 6195.3 6253.8 6254.6 6264.1 6275.6 6122.8 6162.2 6195.5 6198.7 6216.4 6061.8 6110.9 6119.8 6187.7 6209.0 4808.3 4818.1 4818.7 4850.1 4854.6 4329.8 4331.9 4345.1 4371.4 4388.6 5355.1 5457.1 5650.7 5719.3 5756.6 6245.4 6299.5 6301.9 6302.5 6314.8 5657.9 5681.7 5688.3 5703.3 5729.7 5216.0 5285.0 5343.3 5348.0 5381.7 6303.7 6316.8 6331.4 6333.3 6346.7 6116.3 6200.8 6252.1 6255.9 6285.2 6268.3 6330.6 6346.7 6352.2 6359.6 6131.8 6145.0 6183.9 6186.3 6191.4 6105.9 6135.8 6253.0 6255.7 6270.7 5668.8 5687.2 5695.0 5722.9 5753.5 5684.2 5686.7 5695.2 5702.3 5710.0 5596.9 5618.4 5669.5 5732.2 5951.9 5913.5 5967.1 6013.3 6083.2 6144.1 5757.9 5801.7 5812.1 5818.8 5828.7 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#1] ext.html Cycles:180 Average:63648.31 Median:36747.54 stddev:128504.60 (349.7%) stddev-sans-first:128777.61 18:38:20 INFO - PROCESS | 1687 | Values: 492.9 573.1 581.5 610.7 633.0 26191.3 31060.5 31096.5 31196.2 31255.2 31750.4 41069.6 41592.0 41661.0 41882.2 9614.4 9790.2 9832.8 9842.8 9842.9 9544.5 9652.8 9662.4 9664.4 9675.0 9633.1 9703.9 9712.7 9713.2 9733.5 9671.5 9840.0 9840.4 9851.1 9856.7 9691.1 9835.4 9836.4 9845.0 9852.6 41751.6 42101.8 42146.2 42290.4 42294.6 3167.4 3212.5 3321.7 3420.2 3426.2 23241.5 24534.9 25691.8 28196.0 30097.8 2677.7 2726.2 2866.3 2881.0 2891.1 488235.0 491931.0 496656.0 496701.0 498768.0 74110.3 74542.6 75347.6 75362.6 75480.0 78523.6 79232.2 79393.8 79438.2 79578.6 17185.1 17277.7 17320.3 17355.1 17387.1 12964.0 13068.7 13070.9 13085.0 13097.0 22240.3 22944.0 23320.9 23360.9 23395.8 8464.6 9814.5 10018.4 10145.9 10379.0 955.7 1012.2 1030.0 1061.2 1101.9 28404.1 29331.6 29401.7 29419.4 30438.0 939.5 1066.2 1162.6 1163.5 1287.7 14997.6 14999.0 15020.5 15378.2 15416.3 514859.0 520647.0 521254.0 521998.0 523262.0 60158.0 60783.7 60824.4 61021.4 61062.0 1224.7 1301.9 1325.4 1441.3 1479.2 29637.9 29716.1 29811.1 30459.0 30607.4 52541.7 53243.0 53243.7 53246.0 53322.0 428817.0 431092.0 431516.0 432400.0 433058.0 33587.8 35129.0 35133.6 35146.5 35238.6 34565.7 45513.8 46421.8 46651.6 47872.3 30595.8 30915.2 37114.8 37209.8 37953.8 27804.7 36303.1 36432.0 36864.3 37129.5 36178.8 36539.3 36679.8 36815.3 37096.6 30261.3 32327.0 32465.0 32742.0 32884.8 24282.5 24291.3 24608.4 24738.0 24743.9 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#2] jquery.html Cycles:180 Average:36429.54 Median:15905.25 stddev:106109.07 (667.1%) stddev-sans-first:106372.10 18:38:20 INFO - PROCESS | 1687 | Values: 323.5 359.7 359.8 367.2 368.1 19912.0 19922.6 21454.2 21455.6 21477.9 19343.1 20104.8 20353.4 20370.1 20480.4 5849.7 6024.4 6066.1 6069.8 6076.8 4224.4 4502.5 5993.6 6521.4 6536.3 5086.7 5146.2 5185.9 5200.3 5573.5 6096.5 6182.5 6360.4 6449.9 6494.1 5538.6 5545.2 5558.7 5560.3 5571.6 24790.8 25388.8 25453.1 25649.1 25694.2 2311.8 2356.9 2390.0 2442.5 2704.9 14376.4 14437.1 14592.0 15079.2 15200.1 1742.7 1787.1 1795.1 1812.1 1932.8 83289.6 93769.5 95240.0 103891.0 110964.4 19157.2 19410.0 19608.0 19690.7 19841.9 29105.6 29227.1 29231.6 29234.4 29316.0 8801.9 10267.3 10573.9 10601.4 10617.5 8553.0 8553.4 8992.6 9083.3 9125.6 8826.5 8903.9 8970.0 8991.7 9004.8 2999.8 3382.1 3539.3 3540.6 3568.6 922.4 944.5 985.5 988.7 1030.5 19526.5 19707.5 19760.5 19995.4 20237.8 929.9 936.1 956.5 971.5 995.1 10710.0 11031.8 11047.3 11330.9 11401.1 633518.0 634258.0 639130.0 648267.0 655356.0 120229.0 122361.0 124793.0 125879.7 130335.0 1040.5 1059.8 1076.7 1078.6 1080.0 16196.8 18509.8 18815.3 18909.6 18913.9 51831.4 51834.7 52833.7 52870.7 53862.0 63219.4 74785.6 75411.2 76440.2 80477.2 7854.9 8032.6 8043.1 8235.0 8244.5 11065.8 11891.9 13056.9 13314.7 13459.0 11281.5 11442.3 11464.5 11685.5 11815.8 11084.7 11167.3 11198.3 11249.2 11420.5 11488.1 11534.6 11728.7 11816.2 11822.0 6828.7 7954.6 8006.4 8092.3 8310.2 9790.9 10634.8 10920.9 11299.7 11418.9 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#3] mootools.html Cycles:180 Average:6025.31 Median:5571.72 stddev:3171.15 (56.9%) stddev-sans-first:3161.40 18:38:20 INFO - PROCESS | 1687 | Values: 1450.1 1592.4 1617.2 1907.3 2034.9 7938.4 8667.2 8870.9 8874.6 8879.6 8562.0 8793.1 8806.7 8816.7 8818.8 2140.1 2431.9 2485.4 2501.7 2507.2 2488.5 2534.3 2539.9 2541.8 2543.2 2435.3 2480.9 2513.7 2514.1 2515.0 2445.1 2473.1 2491.7 2502.3 2518.5 2470.7 2493.6 2519.1 2522.9 2523.7 8610.4 8715.4 8723.5 8723.5 8729.6 5428.8 5581.9 5589.2 5607.2 5612.8 2965.6 3629.9 3634.7 3674.1 3695.7 974.2 1054.5 1056.3 1071.5 1076.6 11675.9 11824.6 11887.8 11900.9 11918.0 4957.7 4962.7 4985.8 4997.4 5021.0 8727.7 10283.1 10313.8 10320.9 10333.7 5529.5 5562.1 5567.9 5575.6 5580.9 4418.1 4600.5 4816.6 4929.8 5002.7 3561.9 3897.4 3930.0 3998.4 4033.7 1310.8 1324.6 1325.2 1336.5 1340.6 1135.3 1151.3 1218.6 1357.1 1360.1 8089.3 8269.2 8279.2 8282.8 8307.4 476.4 504.5 507.2 512.9 513.7 6225.9 6239.5 6290.4 6306.3 6307.7 10244.3 10583.1 10649.7 10763.6 10788.6 8460.3 10517.9 10576.3 10614.6 10638.5 7994.7 8249.9 8283.2 8359.3 8361.1 7810.7 7855.3 7871.3 7906.1 7940.1 9311.4 9398.2 9445.6 9484.9 9694.3 9471.4 9814.3 9852.8 9978.1 9987.4 6785.9 6961.5 7189.3 7489.1 7567.6 8078.4 8159.8 8167.6 8187.8 8207.5 7245.4 7349.7 7351.1 7473.2 7521.8 7198.4 7328.4 7404.1 7424.3 7476.3 6664.8 7666.9 7675.2 7698.4 7737.5 6940.5 6947.5 6947.7 7008.6 7009.9 7087.0 7161.4 7165.7 7179.1 7182.5 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#4] prototype.html Cycles:180 Average:5537.86 Median:6285.97 stddev:1756.51 (27.9%) stddev-sans-first:1716.45 18:38:20 INFO - PROCESS | 1687 | Values: 275.4 329.4 331.0 335.4 337.5 6289.9 6397.3 6440.5 6447.9 6451.2 6321.8 6340.0 6350.0 6355.6 6361.0 4506.9 4608.4 4616.6 4748.1 4765.0 4236.7 4397.7 4692.4 4709.8 4718.6 4679.2 4702.7 4703.1 4703.6 4705.2 4480.1 4611.9 4617.8 4629.5 4688.6 3967.4 4051.1 4057.3 4068.9 4072.8 6017.4 6050.1 6055.7 6070.8 6104.8 4722.8 5383.9 5534.4 5542.9 5560.8 5488.1 6117.4 6154.3 6758.1 6762.5 4264.6 4419.2 4465.2 4545.3 4554.8 7096.5 7136.6 7176.9 7212.7 7229.2 4518.6 4525.3 4526.4 4529.4 4532.1 4599.7 4606.1 4610.8 4615.7 4626.3 5423.4 5432.8 5434.9 5445.8 5448.5 6591.7 6819.9 6832.7 6834.5 6845.2 1321.6 1578.1 1589.6 1597.8 1598.7 1014.6 1014.9 1027.5 1038.1 1040.9 6085.3 6282.0 6291.0 6390.2 6395.6 6879.6 6967.8 6982.9 7017.3 7067.7 6401.6 6409.1 6414.2 6421.3 6444.4 3704.5 3753.5 3765.4 3767.9 3770.2 7071.9 7347.2 7444.1 7454.6 7456.2 6124.8 7219.7 7273.0 7280.9 7298.4 6018.5 7297.1 7442.1 7444.1 7456.6 5705.9 7074.1 7076.5 7078.6 7087.9 6680.3 6910.9 6916.8 6946.2 6970.2 7302.2 7340.5 7347.9 7366.3 7446.9 4688.0 4754.8 4755.2 4766.7 4767.6 7002.9 7012.8 7024.4 7027.1 7027.2 6560.5 6807.9 6812.5 6816.7 6827.2 5183.9 6790.0 6790.8 6807.2 6827.4 5159.5 6642.2 6663.6 6664.0 6667.8 5621.3 6764.5 6786.5 6790.8 6791.5 6389.5 6624.9 6639.2 6647.0 6670.9 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - PROCESS | 1687 | [#5] yui.html Cycles:180 Average:17780.73 Median:66773.66 stddev:24946.67 (37.4%) stddev-sans-first:24983.62 18:38:20 INFO - PROCESS | 1687 | Values: 682.5 691.5 710.2 723.3 817.5 14844.2 15181.2 15203.4 15221.2 15223.8 13977.6 15756.2 16198.4 16208.9 16255.8 706.1 907.4 917.4 925.6 928.0 720.3 905.9 919.5 921.7 924.4 960.9 961.7 965.2 966.3 967.3 747.5 946.4 956.5 960.8 961.3 715.4 716.6 716.7 717.3 719.0 15502.4 15530.6 15540.5 15578.2 15593.4 12261.4 12362.6 12371.3 12516.3 12703.3 9885.0 10136.3 10263.8 10583.3 11063.2 3596.1 3630.1 3681.4 3766.5 3769.5 67157.3 73408.1 81574.2 81663.0 82785.0 9017.1 9302.3 9362.1 9370.1 9571.1 20972.0 21253.0 21259.4 21309.7 21338.8 7281.0 7490.9 7582.0 7593.7 7639.7 4032.5 4041.8 4052.8 4062.6 4092.5 3624.1 3675.8 3681.8 3682.0 3687.2 662.7 666.8 670.2 683.1 687.0 452.9 569.8 573.3 581.6 606.1 7937.3 8011.6 8130.4 8173.4 8321.9 541.9 580.2 597.2 605.2 617.6 3742.8 3771.6 3799.8 3874.3 3897.9 87353.6 89794.0 89993.0 90124.2 90219.5 75783.0 76951.6 77183.6 78015.0 78577.0 65757.0 65765.7 66095.0 66630.7 66911.0 7649.3 7675.1 7778.3 7800.8 7873.4 48721.5 49551.8 49875.8 50010.7 51297.0 62084.7 66004.3 66489.3 66636.3 67897.7 9815.5 9853.8 9900.9 9917.0 10290.1 10792.3 10807.8 10841.8 11158.4 11328.9 10292.6 10305.5 10360.7 10561.8 10625.8 8610.6 10280.6 10368.8 10597.6 10744.2 9901.0 9914.6 9957.7 10260.1 10294.3 8358.9 8371.3 8651.3 8655.8 8812.4 8532.8 8564.1 8702.4 8719.6 8774.3 18:38:20 INFO - PROCESS | 1687 | -------- Summary: end -------- 18:38:20 INFO - PROCESS | 1687 | 18:38:20 INFO - TEST-INFO | 1687: exit 0 18:38:20 INFO - TEST-OK | dromaeo_css | took 1113606ms 18:38:20 INFO - TEST-START | kraken 18:38:20 INFO - operating with platform_type : mac_ 18:38:20 INFO - Initialising browser for kraken test... 18:38:20 INFO - TEST-INFO | started process 1810 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpR6wI6W/profile http://localhost:49270/getInfo.html) 18:38:22 INFO - PROCESS | 1810 | __metrics Screen width/height:1600/1200 18:38:22 INFO - PROCESS | 1810 | colorDepth:24 18:38:22 INFO - PROCESS | 1810 | Browser inner width/height: 1024/689 18:38:22 INFO - PROCESS | 1810 | __metrics 18:38:23 INFO - PROCESS | 1810 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:38:23 ERROR - PROCESS | 1810 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:38:23 INFO - TEST-INFO | 1810: exit 0 18:38:23 INFO - Browser initialized. 18:38:23 INFO - Running cycle 1/1 for kraken test... 18:38:23 INFO - TEST-INFO | started process 1812 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpR6wI6W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:35 INFO - PROCESS | 1812 | RSS: Main: 243220480 18:38:35 INFO - PROCESS | 1812 | 18:38:37 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:38 INFO - PROCESS | 1812 | RSS: Main: 288899072 18:38:38 INFO - PROCESS | 1812 | 18:38:41 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 18:38:41 INFO - PROCESS | 1812 | RSS: Main: 300339200 18:38:41 INFO - PROCESS | 1812 | 18:38:44 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 18:38:45 INFO - PROCESS | 1812 | RSS: Main: 286703616 18:38:45 INFO - PROCESS | 1812 | 18:38:47 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 18:38:48 INFO - PROCESS | 1812 | RSS: Main: 290086912 18:38:48 INFO - PROCESS | 1812 | 18:38:50 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:50 INFO - PROCESS | 1812 | RSS: Main: 291348480 18:38:50 INFO - PROCESS | 1812 | 18:38:53 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:54 INFO - PROCESS | 1812 | RSS: Main: 290852864 18:38:54 INFO - PROCESS | 1812 | 18:38:56 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:57 INFO - PROCESS | 1812 | RSS: Main: 293027840 18:38:57 INFO - PROCESS | 1812 | 18:39:00 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 18:39:00 INFO - PROCESS | 1812 | RSS: Main: 291553280 18:39:00 INFO - PROCESS | 1812 | 18:39:02 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:02 INFO - PROCESS | 1812 | RSS: Main: 326189056 18:39:02 INFO - PROCESS | 1812 | 18:39:04 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:05 INFO - PROCESS | 1812 | RSS: Main: 324378624 18:39:05 INFO - PROCESS | 1812 | 18:39:07 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:08 INFO - PROCESS | 1812 | RSS: Main: 331296768 18:39:08 INFO - PROCESS | 1812 | 18:39:10 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:11 INFO - PROCESS | 1812 | RSS: Main: 332496896 18:39:11 INFO - PROCESS | 1812 | 18:39:13 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:14 INFO - PROCESS | 1812 | RSS: Main: 332722176 18:39:14 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 18:39:16 INFO - PROCESS | 1812 | RSS: Main: 393625600 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | __start_tp_report 18:39:16 INFO - PROCESS | 1812 | _x_x_mozilla_page_load 18:39:16 INFO - PROCESS | 1812 | _x_x_mozilla_page_load_details 18:39:16 INFO - PROCESS | 1812 | |i|pagename|runs| 18:39:16 INFO - PROCESS | 1812 | |0;ai-astar;111;110;109;110;112;110;117;110;110;112 18:39:16 INFO - PROCESS | 1812 | |1;audio-beat-detection;156;120;142;154;116;140;138;114;154;115 18:39:16 INFO - PROCESS | 1812 | |2;audio-dft;185;184;184;180;186;184;188;184;185;180 18:39:16 INFO - PROCESS | 1812 | |3;audio-fft;77;75;84;77;56;58;59;81;84;77 18:39:16 INFO - PROCESS | 1812 | |4;audio-oscillator;89;95;125;80;78;86;114;75;79;114 18:39:16 INFO - PROCESS | 1812 | |5;imaging-gaussian-blur;90;86;91;87;91;86;91;88;90;86 18:39:16 INFO - PROCESS | 1812 | |6;imaging-darkroom;93;94;94;94;94;94;95;94;93;93 18:39:16 INFO - PROCESS | 1812 | |7;imaging-desaturate;85;85;87;86;87;87;86;88;85;86 18:39:16 INFO - PROCESS | 1812 | |8;json-parse-financial;55;57;54;54;54;55;54;63;55;52 18:39:16 INFO - PROCESS | 1812 | |9;json-stringify-tinderbox;65;64;71;74;79;57;65;69;86;97 18:39:16 INFO - PROCESS | 1812 | |10;stanford-crypto-aes;83;84;82;83;82;83;80;82;84;84 18:39:16 INFO - PROCESS | 1812 | |11;stanford-crypto-ccm;124;126;131;110;120;126;127;125;116;118 18:39:16 INFO - PROCESS | 1812 | |12;stanford-crypto-pbkdf2;139;128;137;172;121;152;171;170;165;133 18:39:16 INFO - PROCESS | 1812 | |13;stanford-crypto-sha256-iterative;67;68;69;67;68;67;68;67;66;67 18:39:16 INFO - PROCESS | 1812 | __end_tp_report 18:39:16 INFO - PROCESS | 1812 | __start_cc_report 18:39:16 INFO - PROCESS | 1812 | _x_x_mozilla_cycle_collect,1217 18:39:16 INFO - PROCESS | 1812 | __end_cc_report 18:39:16 INFO - PROCESS | 1812 | __startTimestamp1457663956435__endTimestamp 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | ------- Summary: start ------- 18:39:16 INFO - PROCESS | 1812 | Number of tests: 14 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:2.28 (2.1%) stddev-sans-first:2.42 18:39:16 INFO - PROCESS | 1812 | Values: 111.0 110.0 109.0 110.0 112.0 110.0 117.0 110.0 110.0 112.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:141.00 stddev:17.23 (12.2%) stddev-sans-first:16.50 18:39:16 INFO - PROCESS | 1812 | Values: 156.0 120.0 142.0 154.0 116.0 140.0 138.0 114.0 154.0 115.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:2.45 (1.3%) stddev-sans-first:2.57 18:39:16 INFO - PROCESS | 1812 | Values: 185.0 184.0 184.0 180.0 186.0 184.0 188.0 184.0 185.0 180.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#3] audio-fft Cycles:10 Average:72.80 Median:77.00 stddev:10.89 (14.1%) stddev-sans-first:11.45 18:39:16 INFO - PROCESS | 1812 | Values: 77.0 75.0 84.0 77.0 56.0 58.0 59.0 81.0 84.0 77.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.50 stddev:17.91 (22.5%) stddev-sans-first:18.92 18:39:16 INFO - PROCESS | 1812 | Values: 89.0 95.0 125.0 80.0 78.0 86.0 114.0 75.0 79.0 114.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:2.22 (2.5%) stddev-sans-first:2.30 18:39:16 INFO - PROCESS | 1812 | Values: 90.0 86.0 91.0 87.0 91.0 86.0 91.0 88.0 90.0 86.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 18:39:16 INFO - PROCESS | 1812 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 93.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.03 (1.2%) stddev-sans-first:1.00 18:39:16 INFO - PROCESS | 1812 | Values: 85.0 85.0 87.0 86.0 87.0 87.0 86.0 88.0 85.0 86.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.16 18:39:16 INFO - PROCESS | 1812 | Values: 55.0 57.0 54.0 54.0 54.0 55.0 54.0 63.0 55.0 52.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.50 stddev:11.86 (16.4%) stddev-sans-first:12.25 18:39:16 INFO - PROCESS | 1812 | Values: 65.0 64.0 71.0 74.0 79.0 57.0 65.0 69.0 86.0 97.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 18:39:16 INFO - PROCESS | 1812 | Values: 83.0 84.0 82.0 83.0 82.0 83.0 80.0 82.0 84.0 84.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:125.50 stddev:6.24 (5.0%) stddev-sans-first:6.58 18:39:16 INFO - PROCESS | 1812 | Values: 124.0 126.0 131.0 110.0 120.0 126.0 127.0 125.0 116.0 118.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:158.50 stddev:19.56 (12.3%) stddev-sans-first:20.42 18:39:16 INFO - PROCESS | 1812 | Values: 139.0 128.0 137.0 172.0 121.0 152.0 171.0 170.0 165.0 133.0 18:39:16 INFO - PROCESS | 1812 | 18:39:16 INFO - PROCESS | 1812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 18:39:16 INFO - PROCESS | 1812 | Values: 67.0 68.0 69.0 67.0 68.0 67.0 68.0 67.0 66.0 67.0 18:39:16 INFO - PROCESS | 1812 | -------- Summary: end -------- 18:39:16 INFO - PROCESS | 1812 | 18:39:17 INFO - TEST-INFO | 1812: exit 0 18:39:17 INFO - TEST-OK | kraken | took 56371ms 18:39:17 INFO - SUITE-END | took 1169s 18:39:17 INFO - Completed test suite (00:19:30) 18:39:17 INFO - javascript benchmark 18:39:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3442.586889573251, 3480.390931586972, 3521.0, 3528.0297918072533, 3563.6792688658015, 5590.86022849428, 5633.6338138021, 5659.320881494221, 5660.2358681578025, 5666.914996275049, 5551.1673249012665, 5609.607327487078, 5611.719414029292, 5612.07400778871, 5621.747021384037, 5069.645124841262, 5070.8225212117395, 5104.948950510485, 5109.770060347293, 5145.614078944075, 5172.327597412331, 5172.896542069157, 5174.611904107188, 5180.45605211453, 5181.948180518203, 5131.820386286481, 5135.948640513603, 5181.792728290864, 5183.455737147602, 5191.558717509016, 5165.9225111623355, 5213.322268105122, 5229.973850130763, 5230.2416149658275, 5268.394134674523, 4986.326845875833, 5023.397192336906, 5089.949100508985, 5118.539331460149, 5134.435212126663, 4661.650376221763, 5521.723913804334, 5545.140503222007, 5555.111182210827, 5676.517496012844, 5314.910443359102, 6111.63330200185, 6212.968935155295, 6221.782237621662, 6223.159873417076, 6062.144951780659, 6103.883205879423, 6245.3442388549, 6305.905411418832, 6327.5254355923025, 5767.36558978512, 5772.307323121252, 5778.508826749731, 5783.681897495636, 5812.88374232513, 6325.304216536178, 6334.144890439732, 6341.365863413714, 6346.904796428057, 6351.269603995507, 5951.1073338999495, 6056.818295451144, 6104.542159337979, 6108.281362586102, 6118.801925441459, 6195.349488303663, 6253.78111766086, 6254.593451425642, 6264.123022776815, 6275.623462592168, 6122.755089796358, 6162.168107305546, 6195.535334849904, 6198.659073750987, 6216.378362163838, 6061.7575296987625, 6110.862540392742, 6119.776756597957, 6187.721552530147, 6209.0, 4808.3027960946165, 4818.132736107465, 4818.734969576707, 4850.054239423279, 4854.611631069506, 4329.848455304049, 4331.870043898688, 4345.087531618332, 4371.431713877176, 4388.605025547716, 5355.116405793078, 5457.072297709399, 5650.7174641267775, 5719.3136823581435, 5756.597038207286, 6245.437910587978, 6299.5275354348605, 6301.905471417932, 6302.4958003359625, 6314.842128946813, 5657.9434205658235, 5681.744321505542, 5688.317401911797, 5703.287089113861, 5729.713514324267, 5216.0, 5284.9735751320995, 5343.305370301913, 5348.0, 5381.73091345439, 6303.716332765037, 6316.8420789479715, 6331.366863313632, 6333.303336632875, 6346.682665866781, 6116.296625887901, 6200.782972595937, 6252.062190671254, 6255.874882502416, 6285.1515045470105, 6268.27914789805, 6330.556861019684, 6346.650934198663, 6352.237731472068, 6359.618422894641, 6131.816045518642, 6144.969275153596, 6183.876322473615, 6186.288576813724, 6191.442770150708, 6105.877882442415, 6135.754569817157, 6252.999520076766, 6255.687215639109, 6270.717817698123, 5668.801591944262, 5687.20379146928, 5694.971525142348, 5722.885542289214, 5753.510951569164, 5684.175794509855, 5686.687232202268, 5695.202671626059, 5702.258706368311, 5710.029295019774, 5596.916046259391, 5618.381977982501, 5669.54643628517, 5732.197492350991, 5951.851203719942, 5913.497352724895, 5967.134765459071, 6013.278406591237, 6083.209182806207, 6144.10910417978, 5757.913631295618, 5801.6519008859605, 5812.099124635688, 5818.796342128006, 5828.737706803119], "unit": "score", "name": "dojo.html", "value": 5631.178657485343}, {"lowerIsBetter": false, "replicates": [492.94824043475455, 573.1431509892711, 581.453433772254, 610.685496969061, 633.0377825704928, 26191.345216369602, 31060.534091988582, 31096.533551996738, 31196.22009449762, 31255.218619534524, 31750.36499270013, 41069.58930410695, 41592.0, 41661.0, 41882.162356752844, 9614.375065620747, 9790.167835733972, 9832.803343933118, 9842.803143937117, 9842.852357214648, 9544.522773861314, 9652.75868103296, 9662.420254784736, 9664.4201347919, 9674.951625241863, 9633.08485693858, 9703.854442183372, 9712.708618741413, 9713.22294216461, 9733.464659443727, 9671.516424178799, 9839.966803485639, 9840.409575425498, 9851.113399794018, 9856.704298871045, 9691.07934746198, 9835.409875407498, 9836.409815411098, 9845.0, 9852.605895764162, 41751.58248417507, 42101.78949105265, 42146.157076858595, 42290.365644515354, 42294.57705422937, 3167.3665266946705, 3212.5341825435416, 3321.734261259118, 3420.1791570023265, 3426.1777173478436, 23241.535169296687, 24534.877325613437, 25691.84386702603, 28196.013139540224, 30097.849510752527, 2677.745614166651, 2726.2230264374757, 2866.312085099582, 2881.0492537462587, 2891.1182089462704, 488235.0, 491931.0, 496655.9999999964, 496701.0, 498768.0, 74110.25889741034, 74542.62728686322, 75347.62326188335, 75362.62318688481, 75480.0, 78523.60738196272, 79232.20767792364, 79393.80909286365, 79438.20561794423, 79578.6021069891, 17185.05482198491, 17277.740833887503, 17320.30718771235, 17355.13224338778, 17387.130643467775, 12964.0, 13068.673283167996, 13070.934645326712, 13085.0, 13096.952243820471, 22240.332790016324, 22944.0, 23320.883395582914, 23360.883195583912, 23395.7660423397, 8464.619092140869, 9814.52782082679, 10018.39889606626, 10145.898541014643, 10379.01399367074, 955.7323949294208, 1012.1700205831148, 1030.0317701360698, 1061.1616822709973, 1101.867775866885, 28404.147875563765, 29331.560026599192, 29401.705982939897, 29419.41161176807, 30438.0, 939.5208443693765, 1066.173715370594, 1162.581470670558, 1163.4764356039648, 1287.7102651903433, 14997.550073497812, 14998.95007349475, 15020.549383518512, 15378.154201519024, 15416.306266217824, 514859.0, 520647.0, 521254.0, 521998.0, 523262.0, 60158.0, 60783.69608151931, 60824.39175608276, 61021.38978610246, 61062.0, 1224.6693392783898, 1301.8738790945763, 1325.3505782166862, 1441.3369849868968, 1479.1568805780603, 29637.85181074167, 29716.10851674453, 29811.10566683003, 30459.0, 30607.387852242384, 52541.7372913133, 53243.0, 53243.73378133085, 53246.0, 53322.0, 428817.0, 431092.0, 431516.0, 432400.0, 433058.0, 33587.83206083954, 35129.0, 35133.648663513035, 35146.485351464646, 35238.647613523535, 34565.65434345624, 45513.77243113763, 46421.76789116033, 46651.600451986495, 47872.281915770596, 30595.847020764755, 30915.227119322197, 37114.814425927696, 37209.813950930074, 37953.81023094867, 27804.721952781023, 36303.092422689646, 36432.0, 36864.26271474502, 37129.51481940692, 36178.8191059043, 36539.26921461609, 36679.81660091683, 36815.26369472649, 37096.629033709316, 30261.31103479205, 32327.0, 32465.0, 32742.0, 32884.849030283825, 24282.51434971326, 24291.271261862174, 24608.384790380383, 24738.0, 24743.876280618482], "unit": "score", "name": "ext.html", "value": 20067.34821126942}, {"lowerIsBetter": false, "replicates": [323.51795824221904, 359.67269784496114, 359.80210884013786, 367.2361488104742, 368.06511460889345, 19912.013198020286, 19922.601547969032, 21454.24910128144, 21455.57088858222, 21477.892610536925, 19343.129559169836, 20104.793712377268, 20353.38939831804, 20370.083346249416, 20480.38558843237, 5849.7367618457165, 6024.397560243984, 6066.120412540179, 6069.817905462844, 6076.817695469143, 4224.408582798395, 4502.504724480321, 5993.640381577097, 6521.380468855451, 6536.281009088996, 5086.745662716868, 5146.176611742122, 5185.948140518584, 5200.29795977542, 5573.526250268732, 6096.51227901769, 6182.474489668383, 6360.395762402542, 6449.935500645028, 6494.0583615375745, 5538.584606154554, 5545.223668686387, 5558.666480011212, 5560.277163968699, 5571.637843540157, 24790.752092479026, 25388.826396700413, 25453.109141180154, 25649.102281420248, 25694.229173124837, 2311.7572654871333, 2356.917507887216, 2390.0, 2442.4992876460283, 2704.945901081987, 14376.353064112036, 14437.13377197361, 14592.0, 15079.170645614488, 15200.087994720352, 1742.7473016412675, 1787.1421717575506, 1795.1293622593032, 1812.1482903035685, 1932.7970563090955, 83289.58355208185, 93769.5311523438, 95240.0, 103891.0, 110964.4451777744, 19157.233710651697, 19410.0, 19608.019599019994, 19690.70463943042, 19841.900790495954, 29105.563416548768, 29227.123186304445, 29231.56152657712, 29234.415311693647, 29316.0, 8801.91198088011, 10267.281290309607, 10573.89426105729, 10601.363918164934, 10617.469126543796, 8553.0, 8553.44402613828, 8992.55037248135, 9083.318751093695, 9125.581720843982, 8826.514541700268, 8903.866442003375, 8970.0, 8991.730248092437, 9004.774880628036, 2999.805012674169, 3382.1082974057317, 3539.2567560812004, 3540.6105328413855, 3568.5896121946307, 922.3543519536352, 944.471096186138, 985.5072463768116, 988.7280997725683, 1030.4538594544904, 19526.511837204183, 19707.4672825251, 19760.505987350432, 19995.400137995883, 20237.79762202359, 929.934904556688, 936.1106948399048, 956.53129966316, 971.5232846074069, 995.1392045880261, 10710.036096751173, 11031.779364412827, 11047.337159770439, 11330.894009032707, 11401.087912966943, 633518.0, 634258.0, 639130.0, 648267.0, 655356.0, 120229.0, 122361.0, 124793.0, 125879.74120258863, 130335.0, 1040.484959944817, 1059.772148987956, 1076.7415820203096, 1078.6116997880756, 1080.0387654987069, 16196.757048644044, 18509.81490185081, 18815.341463048728, 18909.621807564046, 18913.905430472758, 51831.44505664836, 51834.74082629563, 52833.7358313206, 52870.735646321526, 53862.0, 63219.367806321345, 74785.6260718693, 75411.24588754043, 76440.23559764332, 80477.19522804697, 7854.921450785419, 8032.598370081356, 8043.115257321573, 8235.0, 8244.505329680238, 11065.778684426105, 11891.94054029759, 13056.934715326362, 13314.733705326033, 13459.0, 11281.548738050715, 11442.256253343507, 11464.484098215433, 11685.474153663276, 11815.822762658396, 11084.722881928017, 11167.329960202414, 11198.328100314007, 11249.21255512139, 11420.486078126338, 11488.080953523866, 11534.59628912984, 11728.70678233051, 11816.172867899164, 11822.0, 6828.7268509259075, 7954.5624990626075, 8006.399520036137, 8092.271695547429, 8310.21052999964, 9790.85313720309, 10634.787304253718, 10920.890791091988, 11299.661010169708, 11418.885811141783], "unit": "score", "name": "jquery.html", "value": 10378.0315758902}, {"lowerIsBetter": false, "replicates": [1450.057462649277, 1592.3948899418224, 1617.223732608348, 1907.2847682119204, 2034.8575599708008, 7938.40461965352, 8667.176618221267, 8870.911290887088, 8874.645014199441, 8879.64481420744, 8561.957190214056, 8793.076726943675, 8806.735797926072, 8816.735497935073, 8818.823623527525, 2140.1332460353583, 2431.8905649245826, 2485.391079185593, 2501.7498250174926, 2507.1976967370447, 2488.4525404411, 2534.3410713214603, 2539.898404063835, 2541.834780739255, 2543.249741326304, 2435.281591930385, 2480.9255722328357, 2513.710923243832, 2514.107491840398, 2515.0065724038996, 2445.144199530168, 2473.146764366291, 2491.676082109323, 2502.323443292998, 2518.4837108392735, 2470.6664600278914, 2493.6010238361955, 2519.1183085919965, 2522.911698090558, 2523.6971563412326, 8610.44032137909, 8715.433496822687, 8723.476591404473, 8723.476591404537, 8729.563521823884, 5428.782848686048, 5581.8604534886545, 5589.245451863987, 5607.158926161068, 5612.831615051514, 2965.569992351119, 3629.927401451956, 3634.745567810254, 3674.1365779041903, 3695.7412981091334, 974.1719538392381, 1054.4991129213638, 1056.3186744549723, 1071.4963966935527, 1076.56399158341, 11675.94916457523, 11824.645260642195, 11887.821682674767, 11900.940495297555, 11917.986971107379, 4957.702537847741, 4962.702237865739, 4985.825496107619, 4997.375328083989, 5021.0, 8727.738167854974, 10283.07452329294, 10313.793724125475, 10320.948395257976, 10333.689989300183, 5529.502344788988, 5562.082256427644, 5567.8886422272135, 5575.553955683536, 5580.944190558123, 4418.072204836956, 4600.470945841271, 4816.614670826326, 4929.802807887644, 5002.724850133278, 3561.8753343632848, 3897.395903634941, 3930.0, 3998.420229066769, 4033.69747268956, 1310.8164856920039, 1324.582756431721, 1325.191633103806, 1336.4854531005633, 1340.604521666111, 1135.330155208431, 1151.268944220426, 1218.622227109599, 1357.056845492393, 1360.0547619404617, 8089.31240844523, 8269.21442462965, 8279.172082791792, 8282.8343433131, 8307.37694672902, 476.3783262841955, 504.51818513319694, 507.16571240309486, 512.8692183493185, 513.668683699012, 6225.937740622627, 6239.500839932794, 6290.433860952537, 6306.306306306303, 6307.653079080695, 10244.282900197064, 10583.100436462986, 10649.680509584725, 10763.56945722178, 10788.568457261621, 8460.323174146053, 10517.894821051692, 10576.259661823598, 10614.575416983389, 10638.468076596138, 7994.720184793504, 8249.917500825035, 8283.213094755989, 8359.331253499706, 8361.122082181406, 7810.726624568113, 7855.33229675484, 7871.252231038042, 7906.090799557895, 7940.126586075412, 9311.44131352121, 9398.248140148635, 9445.574949127169, 9484.905150948402, 9694.272929530454, 9471.384360016576, 9814.312998090065, 9852.802943940938, 9978.10197082237, 9987.400755954666, 6785.93214067853, 6961.547499412522, 7189.317014883578, 7489.13874904393, 7567.621618918922, 8078.353731701567, 8159.755207343789, 8167.550784706898, 8187.754367368989, 8207.548584827891, 7245.420366370783, 7349.669264882986, 7351.081114860643, 7473.17795042534, 7521.774346769387, 7198.438724425911, 7328.413726901728, 7404.074490688664, 7424.331810137113, 7476.25237476248, 6664.8000559983275, 7666.884996724942, 7675.194104619158, 7698.422618303762, 7737.535747855147, 6940.514164008471, 6947.513674042769, 6947.687354068978, 7008.614526201108, 7009.894851577128, 7087.043249161297, 7161.39128174111, 7165.749198778018, 7179.138503379628, 7182.533135346186], "unit": "score", "name": "mootools.html", "value": 4838.885255365149}, {"lowerIsBetter": false, "replicates": [275.41474366970186, 329.379120358125, 331.02513098923674, 335.41135307535274, 337.5072394304316, 6289.937100628998, 6397.264314603822, 6440.5491615586925, 6447.903281450782, 6451.161349024632, 6321.810345689625, 6340.0, 6350.0, 6355.618662880231, 6360.968195159017, 4506.932396014063, 4608.354830323758, 4616.584507394334, 4748.145333839908, 4765.0, 4236.703430759832, 4397.670174736892, 4692.366530518388, 4709.764511774415, 4718.598919091882, 4679.227927391977, 4702.717836929795, 4703.0593881223895, 4703.6237101032, 4705.223638099709, 4480.103979204156, 4611.884702882421, 4617.7691115444095, 4629.467611224719, 4688.648351373644, 3967.4247234151176, 4051.129007263423, 4057.2696914555368, 4068.8779336619655, 4072.7963601819793, 6017.368176341465, 6050.122732203806, 6055.697215139269, 6070.787522436738, 6104.816855494342, 4722.787474563618, 5383.892322153574, 5534.418886016951, 5542.86142846428, 5560.805371811967, 5488.067028605146, 6117.449429551317, 6154.261488621394, 6758.12144421227, 6762.492813038993, 4264.637505811978, 4419.204543182226, 4465.151621191995, 4545.340925565807, 4554.840580579664, 7096.503244772868, 7136.571805691623, 7176.892346614753, 7212.675429605628, 7229.1686456057705, 4518.615917646971, 4525.321201819754, 4526.411566496335, 4529.365888775574, 4532.116237333688, 4599.7470139142, 4606.078784243098, 4610.76946152691, 4615.661458177091, 4626.329182268552, 5423.376311724123, 5432.7555260012605, 5434.864128396822, 5445.809396671098, 5448.536874365724, 6591.736330546821, 6819.931800681929, 6832.726690932307, 6834.487413443912, 6845.212800527904, 1321.5770953294852, 1578.1162548972611, 1589.5628702107012, 1597.8482044206014, 1598.7362085256036, 1014.624588902111, 1014.9289549731595, 1027.5067967375553, 1038.1072277841051, 1040.8542804007445, 6085.330613632497, 6282.0, 6290.968545157245, 6390.201224846895, 6395.584287021329, 6879.6216208108035, 6967.82580435483, 6982.860342793116, 7017.263187365355, 7067.71729130829, 6401.647909364937, 6409.102725618417, 6414.166158399378, 6421.325760795143, 6444.387783160592, 3704.49989251453, 3753.549574051077, 3765.3975363942186, 3767.9434808477895, 3770.2271034437877, 7071.858562828715, 7347.155077166088, 7444.069491313586, 7454.627268636655, 7456.217097204824, 6124.755009799647, 7219.675114619855, 7272.96363518179, 7280.854382912312, 7298.379637730853, 6018.518518518508, 7297.087864016998, 7442.06974128234, 7444.069491313586, 7456.552606843498, 5705.914411283751, 7074.115735533059, 7076.540024898365, 7078.646067696697, 7087.893681594677, 6680.2651708313015, 6910.861782764216, 6916.79249622492, 6946.16646002483, 6970.198427180939, 7302.160251570925, 7340.486165968331, 7347.926520734938, 7366.300201480851, 7446.851062978819, 4688.0, 4754.833580824655, 4755.2153894607, 4766.666333356632, 4767.642426818072, 7002.879539273692, 7012.824679382852, 7024.438044956289, 7027.051348067946, 7027.156741190885, 6560.540762146795, 6807.863842723217, 6812.523123381316, 6816.693248803716, 6827.2490026098085, 5183.870403239949, 6789.981502774624, 6790.7623233186605, 6807.217170025312, 6827.351401616838, 5159.458256883124, 6642.20293564756, 6663.633500157538, 6663.966680166568, 6667.766628167991, 5621.297337832771, 6764.526483146133, 6786.491013174131, 6790.796276111724, 6791.45668346541, 6389.456896163878, 6624.933750662624, 6639.203295604559, 6647.0, 6670.899936501053], "unit": "score", "name": "prototype.html", "value": 4952.5450855348045}, {"lowerIsBetter": false, "replicates": [682.4813142012073, 691.5193940211552, 710.1974768511581, 723.3020135569175, 817.4768148385035, 14844.183569903651, 15181.16503592302, 15203.391864325442, 15221.162836044014, 15223.771643425358, 13977.580672579814, 15756.212189390542, 16198.35206591738, 16208.865379423445, 16255.837441625581, 706.0609389511962, 907.3693782820942, 917.4495302818323, 925.5696101312889, 927.958241879117, 720.2509390234151, 905.8777065096193, 919.4529255093208, 921.6543796076471, 924.3991405586355, 960.9375390599623, 961.6970654243926, 965.1988849255137, 966.2752935298527, 967.3228739882076, 747.5103807006419, 946.4179529589322, 956.5073986896754, 960.8174446855145, 961.3270710502641, 715.4133610439442, 716.5808002318598, 716.7276434954736, 717.2504732554441, 719.0329007484977, 15502.379904803794, 15530.611734706723, 15540.533783986499, 15578.22108894562, 15593.37626494939, 12261.448234829453, 12362.567310144192, 12371.319577423239, 12516.311602861839, 12703.301318427482, 9884.950575247078, 10136.290459667825, 10263.79472410555, 10583.31208471447, 11063.170262230366, 3596.1369271374942, 3630.146915474861, 3681.4109742441083, 3766.472693822867, 3769.5099637047283, 67157.3284267156, 73408.06367745338, 81574.18425815726, 81662.9999999994, 82785.0, 9017.143371379709, 9302.302327325478, 9362.110599493037, 9370.10983956523, 9571.138597526256, 20972.0, 21253.0, 21259.36221913345, 21309.68035479469, 21338.78661213399, 7281.0, 7490.887636685454, 7581.962090189514, 7593.6582853771715, 7639.732609358757, 4032.4757781488806, 4041.8383264669083, 4052.797360131982, 4062.5937406259727, 4092.5293591237387, 3624.1483251435893, 3675.8345874435713, 3681.834317455721, 3681.9815900920858, 3687.1519550503535, 662.6686656671665, 666.8032930285577, 670.2191946382508, 683.0642020431941, 687.0244253160524, 452.9297958816389, 569.792025910548, 573.292869484283, 581.5870731780399, 606.130203158469, 7937.325327347125, 8011.639476223584, 8130.390220733469, 8173.386995975326, 8321.916780832235, 541.8889127728806, 580.1645630292365, 597.2344368755041, 605.2253116011424, 617.5831313863124, 3742.7754334740002, 3771.5904104671304, 3799.8290076946605, 3874.341361968472, 3897.902552436155, 87353.56323218471, 89794.0, 89993.0, 90124.19751605063, 90219.54890225508, 75783.0, 76951.61524192455, 77183.61408192923, 78015.0, 78577.0, 65757.01364479537, 65765.67117164383, 66095.0, 66630.66684666643, 66910.99633505501, 7649.273319034683, 7675.078990521173, 7778.299953004257, 7800.765977020698, 7873.37013038944, 48721.512784871695, 49551.752241238566, 49875.75062124666, 50010.749946250035, 51297.0, 62084.68957655183, 66004.33995659983, 66489.33510664832, 66636.33363666301, 67897.66051169712, 9815.509224538888, 9853.802923941337, 9900.900990989998, 9917.0, 10290.073893349634, 10792.298500597437, 10807.783844323227, 10841.783164336512, 11158.44207789591, 11328.94335528317, 10292.588296468057, 10305.53625086858, 10360.740981475523, 10561.788764224519, 10625.840612390666, 8610.569471526524, 10280.588776448858, 10368.792624147625, 10597.576096956036, 10744.151529791574, 9900.950495247478, 9914.603415863285, 9957.651482198089, 10260.127889129508, 10294.279400442198, 8358.916410836056, 8371.32241694903, 8651.264642505457, 8655.82688346217, 8812.427192232484, 8532.829343413221, 8564.143585641386, 8702.390832641655, 8719.564021799011, 8774.298056155365], "unit": "score", "name": "yui.html", "value": 6755.9316086500385}], "name": "dromaeo_css", "value": 7581.4158423155595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 110.0, 112.0, 110.0, 117.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 120.0, 142.0, 154.0, 116.0, 140.0, 138.0, 114.0, 154.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 134.9}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 184.0, 180.0, 186.0, 184.0, 188.0, 184.0, 185.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 84.0, 77.0, 56.0, 58.0, 59.0, 81.0, 84.0, 77.0], "unit": "score", "name": "audio-fft", "value": 72.8}, {"lowerIsBetter": true, "replicates": [89.0, 95.0, 125.0, 80.0, 78.0, 86.0, 114.0, 75.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 91.0, 87.0, 91.0, 86.0, 91.0, 88.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 86.0, 87.0, 87.0, 86.0, 88.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 54.0, 54.0, 54.0, 55.0, 54.0, 63.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 71.0, 74.0, 79.0, 57.0, 65.0, 69.0, 86.0, 97.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 83.0, 82.0, 83.0, 80.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 131.0, 110.0, 120.0, 126.0, 127.0, 125.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 137.0, 172.0, 121.0, 152.0, 171.0, 170.0, 165.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1414.1}]} 18:39:17 INFO - Return code: 0 18:39:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:39:17 ERROR - # TBPL SUCCESS # 18:39:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:39:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:39:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:39:17 INFO - 2016-03-10 18:39:17.741 screenresolution[1822:9855] starting screenresolution argv=screenresolution get 18:39:17 INFO - 2016-03-10 18:39:17.743 screenresolution[1822:9855] Display 0: 1600x1200x32@60 18:39:17 INFO - 2016-03-10 18:39:17.749 screenresolution[1823:9858] starting screenresolution argv=screenresolution list 18:39:17 INFO - Available Modes on Display 0 18:39:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:39:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:39:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:39:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:39:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:39:17 INFO - Intel Iris: 18:39:17 INFO - Chipset Model: Intel Iris 18:39:17 INFO - Type: GPU 18:39:17 INFO - Bus: Built-In 18:39:17 INFO - VRAM (Dynamic, Max): 1536 MB 18:39:17 INFO - Vendor: Intel (0x8086) 18:39:17 INFO - Device ID: 0x0a2e 18:39:17 INFO - Revision ID: 0x0009 18:39:17 INFO - Displays: 18:39:17 INFO - Display: 18:39:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:39:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:39:17 INFO - Display Serial Number: 1600x1200 60 18:39:17 INFO - Main Display: Yes 18:39:17 INFO - Mirror: Off 18:39:17 INFO - Online: Yes 18:39:17 INFO - Rotation: Supported 18:39:17 INFO - Return code: 0 18:39:17 INFO - Running post-action listener: _resource_record_post_action 18:39:17 INFO - Running post-run listener: _resource_record_post_run 18:39:19 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39400960; Write bytes: 704093184; Read time: 441; Write time: 1830 18:39:19 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378673664; Write bytes: 373704192; Read time: 28434; Write time: 642 18:39:19 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 38368768; Write bytes: 300320256; Read time: 420; Write time: 1120 18:39:19 INFO - Running post-run listener: _upload_blobber_files 18:39:19 INFO - Blob upload gear active. 18:39:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:19 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:20 INFO - (blobuploader) - INFO - Done attempting. 18:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:21 INFO - (blobuploader) - INFO - Done attempting. 18:39:21 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:21 INFO - Return code: 0 18:39:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163b872ea70bbf80109fcf959b393956784f0ca180c7513cef7a98d28507ab1a636d6656051123c19788272c02b58ca36c29f2e2234c2b82f9aa5a27574fdb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12fcf1900f44005832c04935bebdfc5343c467f93f5fdbcda9207367d6444fb2a92e094b00389041c7a5b08428e926070a31bd705552b3b619eed4c5d6a959a7"} 18:39:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:21 INFO - Contents: 18:39:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163b872ea70bbf80109fcf959b393956784f0ca180c7513cef7a98d28507ab1a636d6656051123c19788272c02b58ca36c29f2e2234c2b82f9aa5a27574fdb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12fcf1900f44005832c04935bebdfc5343c467f93f5fdbcda9207367d6444fb2a92e094b00389041c7a5b08428e926070a31bd705552b3b619eed4c5d6a959a7"} 18:39:21 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:21 INFO - Copying logs to upload dir... 18:39:21 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.875842 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-10 18:39:21.360323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 18:39:21.364327) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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/163b872ea70bbf80109fcf959b393956784f0ca180c7513cef7a98d28507ab1a636d6656051123c19788272c02b58ca36c29f2e2234c2b82f9aa5a27574fdb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12fcf1900f44005832c04935bebdfc5343c467f93f5fdbcda9207367d6444fb2a92e094b00389041c7a5b08428e926070a31bd705552b3b619eed4c5d6a959a7"} build_url:https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011059 build_url: 'https://queue.taskcluster.net/v1/task/N3XvdXjGR9CgUt7WEYv1VA/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/163b872ea70bbf80109fcf959b393956784f0ca180c7513cef7a98d28507ab1a636d6656051123c19788272c02b58ca36c29f2e2234c2b82f9aa5a27574fdb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12fcf1900f44005832c04935bebdfc5343c467f93f5fdbcda9207367d6444fb2a92e094b00389041c7a5b08428e926070a31bd705552b3b619eed4c5d6a959a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 18:39:21.392593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:39:21.392986) ========= 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.cM5MazIxzI/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.L1LWRqRm1W/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:39:21.442258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 18:39:21.442609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 18:39:21.443252) ========= ========= Total master_lag: 0.52 =========