builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0170 starttime: 1459299857.72 results: success (0) buildid: 20160329152330 builduid: 9e4d6af6a07c46289ce57ceec74457d7 revision: 39b92bd043997494e37c13943eeea480b6339607 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.718241) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.718794) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.719088) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005738 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.750357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.750784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.771115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.771543) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005357 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.824941) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.825266) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.828706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:17.829092) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-29 18:04:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.90M=0.001s 2016-03-29 18:04:18 (7.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:18.018443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:18.021876) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.019567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:18.075679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-29 18:04:18.076067) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39b92bd043997494e37c13943eeea480b6339607 --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 39b92bd043997494e37c13943eeea480b6339607 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-29 18:04:18,158 truncating revision to first 12 chars 2016-03-29 18:04:18,159 Setting DEBUG logging. 2016-03-29 18:04:18,159 attempt 1/10 2016-03-29 18:04:18,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39b92bd04399?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 18:04:20,265 unpacking tar archive at: fx-team-39b92bd04399/testing/mozharness/ program finished with exit code 0 elapsedTime=2.351612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-29 18:04:20.451663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:20.452027) ========= echo 39b92bd043997494e37c13943eeea480b6339607 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'39b92bd043997494e37c13943eeea480b6339607'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 39b92bd043997494e37c13943eeea480b6339607 program finished with exit code 0 elapsedTime=0.005293 script_repo_revision: '39b92bd043997494e37c13943eeea480b6339607' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:20.504021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:20.504330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 18:04:20.521329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-29 18:04:20.521681) ========= /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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:20 INFO - MultiFileLogger online at 20160329 18:04:20 in /builds/slave/test 18:04:20 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:04:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:20 INFO - {'append_to_log': False, 18:04:20 INFO - 'base_work_dir': '/builds/slave/test', 18:04:20 INFO - 'blob_upload_branch': 'Fx-Team', 18:04:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:20 INFO - 'branch': 'Fx-Team', 18:04:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:20 INFO - 'config_files': ('talos/mac_config.py',), 18:04:20 INFO - 'default_actions': ('clobber', 18:04:20 INFO - 'read-buildbot-config', 18:04:20 INFO - 'download-and-extract', 18:04:20 INFO - 'populate-webroot', 18:04:20 INFO - 'create-virtualenv', 18:04:20 INFO - 'install', 18:04:20 INFO - 'run-tests'), 18:04:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:20 INFO - 'download_minidump_stackwalk': True, 18:04:20 INFO - 'download_symbols': 'ondemand', 18:04:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:20 INFO - 'installer_path': 'installer.exe', 18:04:20 INFO - 'log_level': 'info', 18:04:20 INFO - 'log_name': 'talos', 18:04:20 INFO - 'log_to_console': True, 18:04:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:04:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:04:20 INFO - 'opt_config_files': (), 18:04:20 INFO - 'pip_index': False, 18:04:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:20 INFO - 'cmd': ('bash', 18:04:20 INFO - '-c', 18:04:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:20 INFO - 'enabled': True, 18:04:20 INFO - 'halt_on_failure': False, 18:04:20 INFO - 'name': 'check_screen_resolution'},), 18:04:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:20 INFO - 'cmd': ('bash', 18:04:20 INFO - '-c', 18:04:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:20 INFO - 'enabled': True, 18:04:20 INFO - 'halt_on_failure': False, 18:04:20 INFO - 'name': 'check_screen_resolution'},), 18:04:20 INFO - 'run_cmd_checks_enabled': True, 18:04:20 INFO - 'sps_profile': False, 18:04:20 INFO - 'sps_profile_interval': 0, 18:04:20 INFO - 'suite': 'dromaeojs', 18:04:20 INFO - 'system_bits': '32', 18:04:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:20 INFO - 'title': 't-yosemite-r7-0170', 18:04:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:20 INFO - 'use_talos_json': True, 18:04:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:20 INFO - 'work_dir': 'build'} 18:04:20 INFO - ##### 18:04:20 INFO - ##### Running clobber step. 18:04:20 INFO - ##### 18:04:20 INFO - Running pre-action listener: _resource_record_pre_action 18:04:20 INFO - Running main action method: clobber 18:04:20 INFO - rmtree: /builds/slave/test/build 18:04:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:22 INFO - Running post-action listener: _resource_record_post_action 18:04:22 INFO - ##### 18:04:22 INFO - ##### Running read-buildbot-config step. 18:04:22 INFO - ##### 18:04:22 INFO - Running pre-action listener: _resource_record_pre_action 18:04:22 INFO - Running main action method: read_buildbot_config 18:04:22 INFO - Using buildbot properties: 18:04:22 INFO - { 18:04:22 INFO - "project": "", 18:04:22 INFO - "product": "firefox", 18:04:22 INFO - "script_repo_revision": "production", 18:04:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:04:22 INFO - "repository": "", 18:04:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:04:22 INFO - "buildid": "20160329152330", 18:04:22 INFO - "pgo_build": "False", 18:04:22 INFO - "basedir": "/builds/slave/test", 18:04:22 INFO - "buildnumber": 648, 18:04:22 INFO - "slavename": "t-yosemite-r7-0170", 18:04:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:04:22 INFO - "platform": "yosemite_r7", 18:04:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:04:22 INFO - "branch": "fx-team", 18:04:22 INFO - "repo_path": "integration/fx-team", 18:04:22 INFO - "revision": "39b92bd043997494e37c13943eeea480b6339607", 18:04:22 INFO - "stage_platform": "macosx64", 18:04:22 INFO - "builduid": "9e4d6af6a07c46289ce57ceec74457d7", 18:04:22 INFO - "slavebuilddir": "test" 18:04:22 INFO - } 18:04:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:04:22 INFO - Running post-action listener: _resource_record_post_action 18:04:22 INFO - ##### 18:04:22 INFO - ##### Running download-and-extract step. 18:04:22 INFO - ##### 18:04:22 INFO - Running pre-action listener: _resource_record_pre_action 18:04:22 INFO - Running main action method: download_and_extract 18:04:22 INFO - mkdir: /builds/slave/test/build/tests 18:04: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:04:22 INFO - https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:24 INFO - Downloaded 1199 bytes. 18:04:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:24 INFO - Using the following test package requirements: 18:04:24 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:04:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:04:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:04:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'jsshell-mac.zip'], 18:04:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:04:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:04:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:04:24 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:04:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:04:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:24 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:04:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:24 INFO - https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:25 INFO - Downloaded 17944888 bytes. 18:04:25 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:04:25 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:04:28 INFO - Return code: 0 18:04:28 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:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:28 INFO - https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:29 INFO - Downloaded 17944888 bytes. 18:04: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:04: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:04:33 INFO - Return code: 0 18:04: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:04:33 INFO - https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:34 INFO - Downloaded 10847531 bytes. 18:04:34 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:04:34 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:04:34 INFO - Return code: 0 18:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:34 INFO - https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E70InFX6Q1izbpt5DFSrJg/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:04:38 INFO - Downloaded 111403448 bytes. 18:04:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:04:38 INFO - mkdir: /builds/slave/test/properties 18:04:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:38 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:38 INFO - Contents: 18:04:38 INFO - build_url:https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:04:39 INFO - Running post-action listener: _resource_record_post_action 18:04:39 INFO - Running post-action listener: set_extra_try_arguments 18:04:39 INFO - ##### 18:04:39 INFO - ##### Running populate-webroot step. 18:04:39 INFO - ##### 18:04:39 INFO - Running pre-action listener: _resource_record_pre_action 18:04:39 INFO - Running main action method: populate_webroot 18:04:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:39 INFO - '--tppagecycles', 18:04:39 INFO - '7'], 18:04:39 INFO - 'tests': ['tsvgm']}}, 18:04:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:04:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:04:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:04:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'tests': ['damp', 'tps']}, 18:04:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['damp', 'tps']}, 18:04:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:04:39 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['dromaeo_dom']}, 18:04:39 INFO - 'other': {'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'other_l64': {'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'other_nol64': {'tests': ['a11yr', 18:04:39 INFO - 'ts_paint', 18:04:39 INFO - 'tpaint', 18:04:39 INFO - 'sessionrestore', 18:04:39 INFO - 'sessionrestore_no_auto_restore', 18:04:39 INFO - 'tabpaint']}, 18:04:39 INFO - 'svgr': {'tests': ['tsvgx', 18:04:39 INFO - 'tsvgr_opacity', 18:04:39 INFO - 'tart', 18:04:39 INFO - 'tscrollx', 18:04:39 INFO - 'cart']}, 18:04:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['tsvgx', 18:04:39 INFO - 'tsvgr_opacity', 18:04:39 INFO - 'tart', 18:04:39 INFO - 'tscrollx', 18:04:39 INFO - 'cart']}, 18:04:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'tests': ['tp5o']}, 18:04:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'talos_options': ['--e10s'], 18:04:39 INFO - 'tests': ['tp5o']}, 18:04:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'talos_options': ['--xperf_path', 18:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:39 INFO - 'tests': ['tp5n']}, 18:04:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:39 INFO - 'talos_options': ['--e10s', 18:04:39 INFO - '--xperf_path', 18:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:39 INFO - 'tests': ['tp5n']}}, 18:04:39 INFO - 'talos.zip': {'path': '', 18:04:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:39 INFO - Running post-action listener: _resource_record_post_action 18:04:39 INFO - ##### 18:04:39 INFO - ##### Running create-virtualenv step. 18:04:39 INFO - ##### 18:04:39 INFO - Running pre-action listener: _resource_record_pre_action 18:04:39 INFO - Running main action method: create_virtualenv 18:04:39 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:39 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:04:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:39 INFO - Using real prefix '/tools/python27' 18:04:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:40 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:43 INFO - Installing pip.................done. 18:04:43 INFO - Return code: 0 18:04:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:43 INFO - 'HOME': '/Users/cltbld', 18:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:43 INFO - 'LOGNAME': 'cltbld', 18:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:43 INFO - 'MOZ_NO_REMOTE': '1', 18:04:43 INFO - 'NO_EM_RESTART': '1', 18:04:43 INFO - 'PAGER': '/bin/cat', 18:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:43 INFO - 'PWD': '/builds/slave/test', 18:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:43 INFO - 'SHELL': '/bin/bash', 18:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:04:43 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:43 INFO - 'USER': 'cltbld', 18:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:43 INFO - 'XPC_FLAGS': '0x0', 18:04:43 INFO - 'XPC_SERVICE_NAME': '0', 18:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:43 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:04:43 INFO - Cleaning up... 18:04:43 INFO - Return code: 0 18:04:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:43 INFO - 'HOME': '/Users/cltbld', 18:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:43 INFO - 'LOGNAME': 'cltbld', 18:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:43 INFO - 'MOZ_NO_REMOTE': '1', 18:04:43 INFO - 'NO_EM_RESTART': '1', 18:04:43 INFO - 'PAGER': '/bin/cat', 18:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:43 INFO - 'PWD': '/builds/slave/test', 18:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:43 INFO - 'SHELL': '/bin/bash', 18:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:04:43 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:43 INFO - 'USER': 'cltbld', 18:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:43 INFO - 'XPC_FLAGS': '0x0', 18:04:43 INFO - 'XPC_SERVICE_NAME': '0', 18:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:43 INFO - Downloading/unpacking psutil>=0.7.1 18:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:46 INFO - Installing collected packages: psutil 18:04:46 INFO - Running setup.py install for psutil 18:04:46 INFO - building 'psutil._psutil_osx' extension 18:04:46 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:04:47 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:04:47 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:04:47 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:04:47 INFO - building 'psutil._psutil_posix' extension 18:04:47 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:04:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:04:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:04:47 INFO - ^ 18:04:47 INFO - 1 warning generated. 18:04:47 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:04:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:47 INFO - Successfully installed psutil 18:04:47 INFO - Cleaning up... 18:04:47 INFO - Return code: 0 18:04:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:04:47 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:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:47 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:04:47 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:04:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:04:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:47 INFO - 'HOME': '/Users/cltbld', 18:04:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:47 INFO - 'LOGNAME': 'cltbld', 18:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:47 INFO - 'MOZ_NO_REMOTE': '1', 18:04:47 INFO - 'NO_EM_RESTART': '1', 18:04:47 INFO - 'PAGER': '/bin/cat', 18:04:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:47 INFO - 'PWD': '/builds/slave/test', 18:04:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:47 INFO - 'SHELL': '/bin/bash', 18:04:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:04:47 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:04:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:47 INFO - 'USER': 'cltbld', 18:04:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:47 INFO - 'XPC_FLAGS': '0x0', 18:04:47 INFO - 'XPC_SERVICE_NAME': '0', 18:04:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:04:47 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:04:47 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:04:47 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:04:47 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:04:47 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:04:47 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:04:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:04:50 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:04:50 INFO - Installing collected packages: mozsystemmonitor 18:04:50 INFO - Running setup.py install for mozsystemmonitor 18:04:50 INFO - Successfully installed mozsystemmonitor 18:04:50 INFO - Cleaning up... 18:04:50 INFO - Return code: 0 18:04:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:50 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:50 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:04:50 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:04:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:50 INFO - 'HOME': '/Users/cltbld', 18:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:50 INFO - 'LOGNAME': 'cltbld', 18:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:50 INFO - 'MOZ_NO_REMOTE': '1', 18:04:50 INFO - 'NO_EM_RESTART': '1', 18:04:50 INFO - 'PAGER': '/bin/cat', 18:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:50 INFO - 'PWD': '/builds/slave/test', 18:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:50 INFO - 'SHELL': '/bin/bash', 18:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:04:50 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:50 INFO - 'USER': 'cltbld', 18:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:50 INFO - 'XPC_FLAGS': '0x0', 18:04:50 INFO - 'XPC_SERVICE_NAME': '0', 18:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:04: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:04: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:04: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:04: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:04: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:04: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:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:04:54 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:04:54 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:04:54 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:04:54 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:04:54 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:04:54 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:04:54 INFO - Downloading docopt-0.6.1.tar.gz 18:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:04:54 INFO - Running setup.py install for blobuploader 18:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:04:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:04:54 INFO - Running setup.py install for requests 18:04:55 INFO - Running setup.py install for docopt 18:04:55 INFO - Successfully installed blobuploader requests docopt 18:04:55 INFO - Cleaning up... 18:04:55 INFO - Return code: 0 18:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:55 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:04:55 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:04:55 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:04:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:04:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:55 INFO - 'HOME': '/Users/cltbld', 18:04:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:55 INFO - 'LOGNAME': 'cltbld', 18:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:55 INFO - 'MOZ_NO_REMOTE': '1', 18:04:55 INFO - 'NO_EM_RESTART': '1', 18:04:55 INFO - 'PAGER': '/bin/cat', 18:04:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:55 INFO - 'PWD': '/builds/slave/test', 18:04:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:55 INFO - 'SHELL': '/bin/bash', 18:04:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:04:55 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:04:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:55 INFO - 'USER': 'cltbld', 18:04:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:55 INFO - 'XPC_FLAGS': '0x0', 18:04:55 INFO - 'XPC_SERVICE_NAME': '0', 18:04:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:55 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Rbhl4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-mUVrry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-B9JYnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-LqfrSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-VPYiNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-qGbnmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-n6zLhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-RROc3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-DKH3cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-xK6uvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-gRfml3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-GoIrx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-blgM95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Ikfnyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-qlfZQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-PtDuab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-4EmItf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:04:57 INFO - Running setup.py install for manifestparser 18:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Running setup.py install for mozcrash 18:04:58 INFO - Running setup.py install for mozdebug 18:04:58 INFO - Running setup.py install for mozdevice 18:04:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozfile 18:04:58 INFO - Running setup.py install for mozhttpd 18:04:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozinfo 18:04:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozInstall 18:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozleak 18:04:59 INFO - Running setup.py install for mozlog 18:04:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Running setup.py install for moznetwork 18:04:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Running setup.py install for mozprocess 18:04:59 INFO - Running setup.py install for mozprofile 18:04:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Running setup.py install for mozrunner 18:04:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Running setup.py install for mozscreenshot 18:05:00 INFO - Running setup.py install for moztest 18:05:00 INFO - Running setup.py install for mozversion 18:05:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:00 INFO - Cleaning up... 18:05:00 INFO - Return code: 0 18:05:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:00 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:05:00 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:05:00 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:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:00 INFO - 'HOME': '/Users/cltbld', 18:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:00 INFO - 'LOGNAME': 'cltbld', 18:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:00 INFO - 'MOZ_NO_REMOTE': '1', 18:05:00 INFO - 'NO_EM_RESTART': '1', 18:05:00 INFO - 'PAGER': '/bin/cat', 18:05:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:00 INFO - 'PWD': '/builds/slave/test', 18:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:00 INFO - 'SHELL': '/bin/bash', 18:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:05:00 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:00 INFO - 'USER': 'cltbld', 18:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:00 INFO - 'XPC_FLAGS': '0x0', 18:05:00 INFO - 'XPC_SERVICE_NAME': '0', 18:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:00 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-85cX_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:00 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:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:00 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-NCVNRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:00 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:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:00 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-MScdLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:00 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:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:00 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-PEiEwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-TsFuP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-8mBR76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-UjnpzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-K87L8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-zHY6Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-XsE4V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-D768aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-1GbqDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:01 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:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:01 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-FiAmBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:02 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:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:02 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cgwBNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:02 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:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:02 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Uqn1eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:02 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:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:02 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-JPwml1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:02 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:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:02 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cs6B4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:02 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:05:02 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:05:02 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:05:02 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:05:02 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:05:02 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:05:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:04 INFO - Downloading blessings-1.6.tar.gz 18:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:04 INFO - Installing collected packages: blessings 18:05:04 INFO - Running setup.py install for blessings 18:05:05 INFO - Successfully installed blessings 18:05:05 INFO - Cleaning up... 18:05:05 INFO - Return code: 0 18:05:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:05 INFO - Reading from file tmpfile_stdout 18:05:05 INFO - Current package versions: 18:05:05 INFO - blessings == 1.6 18:05:05 INFO - blobuploader == 1.2.4 18:05:05 INFO - docopt == 0.6.1 18:05:05 INFO - manifestparser == 1.1 18:05:05 INFO - mozInstall == 1.12 18:05:05 INFO - mozcrash == 0.17 18:05:05 INFO - mozdebug == 0.1 18:05:05 INFO - mozdevice == 0.48 18:05:05 INFO - mozfile == 1.2 18:05:05 INFO - mozhttpd == 0.7 18:05:05 INFO - mozinfo == 0.9 18:05:05 INFO - mozleak == 0.1 18:05:05 INFO - mozlog == 3.1 18:05:05 INFO - moznetwork == 0.27 18:05:05 INFO - mozprocess == 0.22 18:05:05 INFO - mozprofile == 0.28 18:05:05 INFO - mozrunner == 6.11 18:05:05 INFO - mozscreenshot == 0.1 18:05:05 INFO - mozsystemmonitor == 0.0 18:05:05 INFO - moztest == 0.7 18:05:05 INFO - mozversion == 1.4 18:05:05 INFO - psutil == 3.1.1 18:05:05 INFO - requests == 1.2.3 18:05:05 INFO - wsgiref == 0.1.2 18:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:05:05 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:05:05 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:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:05 INFO - 'HOME': '/Users/cltbld', 18:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:05 INFO - 'LOGNAME': 'cltbld', 18:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:05 INFO - 'MOZ_NO_REMOTE': '1', 18:05:05 INFO - 'NO_EM_RESTART': '1', 18:05:05 INFO - 'PAGER': '/bin/cat', 18:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:05 INFO - 'PWD': '/builds/slave/test', 18:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:05 INFO - 'SHELL': '/bin/bash', 18:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:05:05 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:05 INFO - 'USER': 'cltbld', 18:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:05 INFO - 'XPC_FLAGS': '0x0', 18:05:05 INFO - 'XPC_SERVICE_NAME': '0', 18:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 INFO - Cleaning up... 18:05:05 INFO - Return code: 0 18:05:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:05:05 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:05:05 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:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:05 INFO - 'HOME': '/Users/cltbld', 18:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:05 INFO - 'LOGNAME': 'cltbld', 18:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:05 INFO - 'MOZ_NO_REMOTE': '1', 18:05:05 INFO - 'NO_EM_RESTART': '1', 18:05:05 INFO - 'PAGER': '/bin/cat', 18:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:05 INFO - 'PWD': '/builds/slave/test', 18:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:05 INFO - 'SHELL': '/bin/bash', 18:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:05:05 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:05 INFO - 'USER': 'cltbld', 18:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:05 INFO - 'XPC_FLAGS': '0x0', 18:05:05 INFO - 'XPC_SERVICE_NAME': '0', 18:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:05 INFO - Downloading/unpacking jsonschema 18:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:08 INFO - Downloading/unpacking functools32 (from jsonschema) 18:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:08 INFO - warning: no files found matching '*.txt' 18:05:08 INFO - no previously-included directories found matching 'build' 18:05:08 INFO - no previously-included directories found matching 'dist' 18:05:08 INFO - no previously-included directories found matching '.git*' 18:05:08 INFO - Installing collected packages: jsonschema, functools32 18:05:08 INFO - Running setup.py install for functools32 18:05:09 INFO - warning: no files found matching '*.txt' 18:05:09 INFO - no previously-included directories found matching 'build' 18:05:09 INFO - no previously-included directories found matching 'dist' 18:05:09 INFO - no previously-included directories found matching '.git*' 18:05:09 INFO - Successfully installed jsonschema functools32 18:05:09 INFO - Cleaning up... 18:05:09 INFO - Return code: 0 18:05:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:09 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 0x109068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92bd6c5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, '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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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:05:09 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:05:09 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:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:09 INFO - 'HOME': '/Users/cltbld', 18:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:09 INFO - 'LOGNAME': 'cltbld', 18:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:09 INFO - 'MOZ_NO_REMOTE': '1', 18:05:09 INFO - 'NO_EM_RESTART': '1', 18:05:09 INFO - 'PAGER': '/bin/cat', 18:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:09 INFO - 'PWD': '/builds/slave/test', 18:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:09 INFO - 'SHELL': '/bin/bash', 18:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:05:09 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:09 INFO - 'USER': 'cltbld', 18:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:09 INFO - 'XPC_FLAGS': '0x0', 18:05:09 INFO - 'XPC_SERVICE_NAME': '0', 18:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:09 INFO - Downloading/unpacking flake8 18:05: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:05: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:05: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:05: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:05: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:05: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:05:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:05:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:05:11 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:05:11 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:05:11 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:05:11 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:05:11 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:05:11 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:05:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:05:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:05:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:05:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:05:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:05:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:05:12 INFO - no previously-included directories found matching 'docs/_build' 18:05:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:05:13 INFO - Running setup.py install for pep8 18:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:05:13 INFO - no previously-included directories found matching 'docs/_build' 18:05:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:05:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:05:13 INFO - Cleaning up... 18:05:13 INFO - Return code: 0 18:05:13 INFO - Running post-action listener: _resource_record_post_action 18:05:13 INFO - Running post-action listener: _start_resource_monitoring 18:05:13 INFO - Starting resource monitoring. 18:05:13 INFO - ##### 18:05:13 INFO - ##### Running install step. 18:05:13 INFO - ##### 18:05:13 INFO - Running pre-action listener: _resource_record_pre_action 18:05:13 INFO - Running main action method: install 18:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:13 INFO - Reading from file tmpfile_stdout 18:05:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:13 INFO - Reading from file tmpfile_stdout 18:05:13 INFO - Output received: 18:05:13 INFO - Usage: mozinstall [options] installer 18:05:13 INFO - Options: 18:05:13 INFO - -h, --help show this help message and exit 18:05:13 INFO - -d DEST, --destination=DEST 18:05:13 INFO - Directory to install application into. [default: 18:05:13 INFO - "/builds/slave/test"] 18:05:13 INFO - --app=APP Application being installed. [default: firefox] 18:05:13 INFO - mkdir: /builds/slave/test/build/application 18:05:13 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:05:13 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:05:47 INFO - Reading from file tmpfile_stdout 18:05:47 INFO - Output received: 18:05:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:05:47 INFO - Running post-action listener: _resource_record_post_action 18:05:47 INFO - ##### 18:05:47 INFO - ##### Running run-tests step. 18:05:47 INFO - ##### 18:05:47 INFO - Running pre-action listener: _resource_record_pre_action 18:05:47 INFO - Running main action method: run_tests 18:05:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:05:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:05:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:05:47 INFO - 2016-03-29 18:05:47.490 screenresolution[2203:15062] starting screenresolution argv=screenresolution get 18:05:47 INFO - 2016-03-29 18:05:47.492 screenresolution[2203:15062] Display 0: 1600x1200x32@60 18:05:47 INFO - 2016-03-29 18:05:47.497 screenresolution[2204:15065] starting screenresolution argv=screenresolution list 18:05:47 INFO - Available Modes on Display 0 18:05:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:05:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:05:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:05:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:05:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:05:47 INFO - Intel Iris: 18:05:47 INFO - Chipset Model: Intel Iris 18:05:47 INFO - Type: GPU 18:05:47 INFO - Bus: Built-In 18:05:47 INFO - VRAM (Dynamic, Max): 1536 MB 18:05:47 INFO - Vendor: Intel (0x8086) 18:05:47 INFO - Device ID: 0x0a2e 18:05:47 INFO - Revision ID: 0x0009 18:05:47 INFO - Displays: 18:05:47 INFO - Display: 18:05:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:05:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:05:47 INFO - Display Serial Number: 1600x1200 60 18:05:47 INFO - Main Display: Yes 18:05:47 INFO - Mirror: Off 18:05:47 INFO - Online: Yes 18:05:47 INFO - Rotation: Supported 18:05:47 INFO - Return code: 0 18:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:47 INFO - Python 2.7.3 18:05:47 INFO - Return code: 0 18:05:47 INFO - grabbing minidump binary from tooltool 18:05:47 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:05:47 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 0x108f07e00>, '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 0x108d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:47 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:05:47 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:05:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:47 INFO - Return code: 0 18:05:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:05:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:05:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:05:49 INFO - Return code: 0 18:05:49 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/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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:05:49 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/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --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:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qE5LRBlyFR/Render', 18:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:49 INFO - 'HOME': '/Users/cltbld', 18:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:49 INFO - 'LOGNAME': 'cltbld', 18:05:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:49 INFO - 'MOZ_NO_REMOTE': '1', 18:05:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:49 INFO - 'NO_EM_RESTART': '1', 18:05:49 INFO - 'PAGER': '/bin/cat', 18:05:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:49 INFO - 'PWD': '/builds/slave/test', 18:05:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:49 INFO - 'SHELL': '/bin/bash', 18:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCQXNnf0LN/Listeners', 18:05:49 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 18:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:49 INFO - 'USER': 'cltbld', 18:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:49 INFO - 'XPC_FLAGS': '0x0', 18:05:49 INFO - 'XPC_SERVICE_NAME': '0', 18:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:49 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/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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:05:49 INFO - mozversion application_buildid: 20160329152330 18:05:49 INFO - mozversion application_changeset: 39b92bd043997494e37c13943eeea480b6339607 18:05:49 INFO - mozversion application_display_name: Nightly 18:05:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:49 INFO - mozversion application_name: Firefox 18:05:49 INFO - mozversion application_remotingname: firefox 18:05:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:05:49 INFO - mozversion application_vendor: Mozilla 18:05:49 INFO - mozversion application_version: 48.0a1 18:05:49 INFO - mozversion platform_buildid: 20160329152330 18:05:49 INFO - mozversion platform_changeset: 39b92bd043997494e37c13943eeea480b6339607 18:05:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:05:49 INFO - mozversion platform_version: 48.0a1 18:05:49 INFO - using testdate: 1459299949 18:05:49 INFO - actual date: 1459299949 18:05:49 INFO - starting webserver on 'localhost:49851' 18:05:49 INFO - SUITE-START | Running 2 tests 18:05:49 INFO - TEST-START | dromaeo_css 18:05:49 INFO - operating with platform_type : mac_ 18:05:49 INFO - Initialising browser for dromaeo_css test... 18:05:49 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp9jXBT_/profile http://localhost:49851/getInfo.html) 18:05:51 INFO - PROCESS | 2222 | __metrics Screen width/height:1600/1200 18:05:51 INFO - PROCESS | 2222 | colorDepth:24 18:05:51 INFO - PROCESS | 2222 | Browser inner width/height: 1024/689 18:05:51 INFO - PROCESS | 2222 | __metrics 18:05:51 INFO - PROCESS | 2222 | 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:05:51 ERROR - PROCESS | 2222 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:05:52 INFO - TEST-INFO | 2222: exit 0 18:05:52 INFO - Browser initialized. 18:05:52 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:52 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp9jXBT_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:04 INFO - PROCESS | 2225 | RSS: Main: 244314112 18:06:04 INFO - PROCESS | 2225 | 18:06:55 INFO - PROCESS | 2225 | 1459300015392 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:09:05 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49851/tests/dromaeo/cssquery-ext.html) 18:09:07 INFO - PROCESS | 2225 | RSS: Main: 329969664 18:09:07 INFO - PROCESS | 2225 | 18:12:09 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-ext.html (next: http://localhost:49851/tests/dromaeo/cssquery-jquery.html) 18:12:10 INFO - PROCESS | 2225 | RSS: Main: 371134464 18:12:10 INFO - PROCESS | 2225 | 18:15:12 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49851/tests/dromaeo/cssquery-mootools.html) 18:15:12 INFO - PROCESS | 2225 | RSS: Main: 372068352 18:15:12 INFO - PROCESS | 2225 | 18:18:14 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49851/tests/dromaeo/cssquery-prototype.html) 18:18:15 INFO - PROCESS | 2225 | RSS: Main: 330498048 18:18:15 INFO - PROCESS | 2225 | 18:21:18 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49851/tests/dromaeo/cssquery-yui.html) 18:21:19 INFO - PROCESS | 2225 | RSS: Main: 332709888 18:21:19 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-yui.html (next: http://localhost:49851/tests/dromaeo/cssquery-dojo.html) 18:24:21 INFO - PROCESS | 2225 | RSS: Main: 379064320 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | __start_tp_report 18:24:21 INFO - PROCESS | 2225 | _x_x_mozilla_page_load 18:24:21 INFO - PROCESS | 2225 | _x_x_mozilla_page_load_details 18:24:21 INFO - PROCESS | 2225 | |i|pagename|runs| 18:24:21 INFO - PROCESS | 2225 | |0;dojo.html;3385.9322813543727;3441.9139521511943;3469.3234819210265;3470.774399664021;3527.541419615451;5551.139573366125;5644.927463781879;5676.347220069693;5703.258576385069;5737.627054241471;5658.490735833774;5673.631213971089;5677.48902598766;5839.883202335961;5840.853978650525;5037.244413337992;5060.924086138711;5095.79616815327;5102.948970510284;5215.608829337815;4270.957290427087;5231.084560201968;5249.448807875176;5272.525472707455;5292.497212764801;5054.974725126388;5088.847334579968;5150.845474635767;5154.433012368637;5161.741912904358;5157.277981082651;5163.483651634844;5179.974100129513;5235.633505654606;5237.47625237477;5097.286379906779;5143.819966301199;5150.665206761586;5165.690058596459;5215.687058776485;4531.297648864432;5627.549796016309;5632.662040277555;5653.1520271959125;5674.716264186774;6134.5092392608485;6183.845403864894;6193.225846769154;6193.783217587408;6195.535334849904;6157.199564056644;6210.751569937197;6220.160278362454;6223.097650840648;6233.532485063638;5650.067738823048;5748.712564371848;5782.913256301201;5807.883842323172;5821.912671309934;6177.4749146322165;6218.9378106219265;6219.222597175353;6226.813195604139;6229.0967809667345;6022.337542870281;6044.395560443921;6062.969685151635;6113.938860611426;6122.7857025004805;6100.30868792748;6171.382861713882;6197.81406557804;6218.595791273553;6240.937590624036;6099.370313949828;6115.696722738819;6121.696863452088;6123.343628574293;6126.731429653714;6153.046277826944;6153.077038444179;6155.7688462307715;6175.413335733098;6219.533534984895;4756.904861902743;4829.396325459317;4837.129316722953;4838.491958344393;4875.488073752276;4393.428854248991;4400.185965596375;4455;4459.1304695584695;4462.263726485158;5608.775648974077;5674.177244299636;5687.0616348302065;5694.1458781183155;5712.143178523172;6144.556029333103;6208.596441231305;6227.937720622826;6229.3770622937345;6236.03341482071;5669.489745922804;5712.742926568314;5726.570507211975;5735.483806457439;5742.13867919807;5089.949100509021;5345.33183352081;5355.3841308249275;5355.7054362009685;5364.14173732201;6112.327643959161;6231.719572619243;6242.625442473466;6249.937500624936;6263.4362907338555;6175.413335733098;6209.875802484015;6221.222347206599;6223.284322302812;6226.283977342664;6152.446279834658;6217.720202590804;6234.875302494015;6247.937520624736;6416.326285740117;6081.695915204311;6106.15732346443;6116.548817443993;6121.208497748031;6136.447719705248;6122.063299448936;6154.292256390393;6163.982942814565;6167.876642467215;6190.1952746142715;5870.9412905872105;5934.732937017759;6008.788262456106;6051.878962420815;6098.237720284965;5960.403959604005;5974.671393073423;5976.282846058501;5977.043673012471;5988.28140623128;5736.996025695403;5814.156947242711;5819.79630712923;5858.443447872445;5872.588918775645;5874.706264686663;5974.761009559569;6043.758249669964;6108.602940808833;6138.0179171332375;4269.594388533084;5901.203337549376;5905.025670764276;5915.792947246998;5921.733521991435 18:24:21 INFO - PROCESS | 2225 | |1;ext.html;474.2696247778421;577.8902008618362;585.8780435466083;630.8012975912587;634.7968650031988;38144.427833582486;38676.41985370218;38684.80657596715;38726.031849203784;38760.418593721115;41921.58078419223;42096.57903420965;42187.99999999992;42313.57686423135;42338;9516.953135155145;9730.513474326292;9748.853767193497;9756.804863902718;9775.706728798148;9481;9603.231741460666;9626.711198664016;9627.422354658744;9650.758731031745;9683.370580912253;9765.072318129802;9770.804583908317;9772.511374431286;9791.657291994781;9662.227021838236;9718.61125554977;9731.805363892683;9734.075262850018;9749.610015599368;9617.27870409722;9777.951110244474;9779.315447918649;9781.510924453749;9787.559559819825;40540.18919621591;40543.18913621741;40949.18101637951;41019;41140.38289425661;3218.7103160715646;3236.7410607151373;3241.3355262171435;3259.2916658380723;3478.565179352581;28361.85819070912;28362.716372836214;28514.857425712948;28991.42017159645;29105.70894291051;2568.486302739441;2583.547879121165;2590.7020692620404;2643.73562643736;2660.414708764069;497841;498954;500628;500683.4965825184;501469.99999999633;35745.64254357475;44284.55715442805;61841.69079154665;63162;63233.68383158147;43999.78000110043;44050.55949440529;44096.55903440989;44139.77930110393;44174.33738493925;14971.877109216852;15084;15091.245437728288;15098.54704358871;15107.39570417193;12008;12047.33739644328;12071.758564828655;12073.939630301968;12076.939615301868;14087.295635218197;14304;14341.498047568284;14391.424343026161;14433.35049922756;6124.326324104345;6181.103739957681;6212.161358216583;6219.0982307566055;6232.3144454110015;899.5592159841631;974.8440249560036;1091.3942761767296;1099.197585762398;1099.2030777686114;23444.944977476054;25515.10697125592;28637.427251454854;28727.13818585446;28835;1051.0960573906434;1059.2532264753331;1088.3252383522108;1091.8143915534379;1164.1618035014776;12534.185277956904;14357;14489.420423182955;14586.708265834835;14893.32980015902;503828;511597;513212;514447;515239;47079.76460117677;56199.43800561942;57788;57929.710351447975;58050;1317.7957416600443;1342.7381660576289;1449.5723761490385;1450.3618407900701;1487.2935355705954;27461.03886363968;28346.574801378407;28358;28443.28891777722;29291.707082928897;44252.77873610611;44352;44622.77688611536;44693.55306446894;44734;355518;358038;358478.2076089603;358658;360776;32559.837200814793;32796.67203327936;33055.50416743703;33442.66557334493;33452.832735836164;43909.56090439055;44421.55578444174;44661.330080049476;45321.86695332643;45821;32484;34455.655443446245;35329.470057949664;37020.44469332908;37215;35317.82341088278;35769.28461430809;35807.46288805722;36576;36709;30991.69008309888;35158.82420587881;36230.81884590666;36263.637363626025;36521.817390912875;27853.721462785925;30267.243318917204;30476.390472190877;31079.533806992462;31081.067567972997;22861.31416057521;23383.766162338157;23579.29262122139;23626.64560031635;23681.289561313188 18:24:21 INFO - PROCESS | 2225 | |2;jquery.html;362.72976632408853;365.82440428594293;366.7451121470578;369.9574548926874;377.8261999480239;19168.233270669174;19236.807631923675;20101.497462563442;20107.396778096645;20109.899450502744;17188.742168867444;19022.61954760904;19734.130511428808;19928.800711992877;19985.400437986882;5660.405657405975;5800.970995145019;5817.680027598481;5862.97068514659;5871.911921321183;4170.332746760519;4366.476022877243;5759.424057594249;6103.084537319415;6391.392817682313;6291.622502649833;6316.715747791361;6326.841828954267;6330.430261276484;6361.363863613625;6013.1581578579035;6320.652364119972;6327.1458353122425;6331.55679102463;6337.271213810424;3657.4148136298063;3836.232753449321;3836.884893453173;3838.5777564467885;5401.4868587484125;22819.973101210486;23471.295861124192;23807.047718091428;24941.750582494125;25036.624450633255;2458.987705061481;2594.3125071855975;2617.751313625203;2830.8301501909746;2841.318083659927;14173.291335433187;14430.062045966979;14600.050996685182;15131.773023404658;15165.772513412308;1628.812686541051;1653.9586510337217;1770.2299499717535;1816.409666858263;1979.4853338132045;91531;95967.52016239944;96268.51865740697;96544.51727741386;97686;10655.360678359324;10828.62099826518;10931.617393391192;10964.287321324247;11011.669649910515;13479.730405391838;13493.301339732092;13525.661858453617;13527.729445411036;13536.796948045787;8089.797755056053;8266.008079030555;8280.668773249123;8353.457025293337;8355.248027677539;8289.58552072394;8309.210624990616;8335.083140854502;8421.031581368099;8430.199131082538;4310.568943105727;4329.696921215547;4338.806828122229;4361.629261512743;4378.387025816388;1556.9844301557066;1710.1705672748708;1772.060807771883;1790.64187162568;1791.6595846789069;919.3727103027604;969.4280374579032;996.2627655534997;998.0618218874235;1012.2610494339174;13691.863081369058;18355.990420526734;18593.90703046503;18982.861028338342;19227.61544769125;950.5769932380025;958.3052287091803;964.9565769540387;970.4468452981873;979.7011911366959;10190;10491.318064325947;10525.9473702631;10533.578656853793;10544.26190166681;602404;615029;625940;635794;646018;104061.43907841388;104700.47649761703;106575.46712266545;109054.90945090448;110961.78076438425;903.7830920579145;950.6530116507425;1085.9294145880492;1110.2006555280186;1112.093643680398;16871.325146993982;17074.743878842077;17144.22850971734;17157.227924743165;17472.825271747628;46515.53484465112;47813.804654883905;47991.52008479871;48020;49930.75034624804;67703;67909.64180716457;68710.65644671944;70058.29941700518;71275;6933.930660693329;7250.238724933806;7287.9635601823775;7442.330190282901;7468.663910124166;9278.257739380968;11031.779364412507;11321.943390282995;11347.943260283646;11570.363630000431;9779.657711980331;9863.901360986298;10087.445190514592;10225;10241.92459791741;9609.855852162364;9837.704868853945;9904.25718071162;10003.699889003341;10062.195024398177;10260.640877569249;10305.484725763832;10336.283185840708;10495.47522623881;10597.47012649349;7295.781126566211;7371.115466144097;7520.366827670029;7553.32020118192;7692.653830577749;10078.244131690006;10201.693949181536;10268.229882758973;10331.483425828828;10497.265191436527 18:24:21 INFO - PROCESS | 2225 | |3;mootools.html;1447.0449503327807;1611.0816834404386;1636.509047285814;1903.8572107091964;2014.6071516054376;8065.91934080659;8582.970043594769;8897.91102088979;8926.732198034062;8933;8549.87175192371;8777.736667899973;8791.604377802998;8796.340274479424;8802.207801297882;1781.4566557200048;2418.9395265118337;2452.239805660251;2484.4534202475425;2486.11742831295;2294.598445272079;2313.560423519526;2319.246244970383;2323.4075310795806;2326.0695721711368;2200.713907192063;2231.241377931503;2258.06290389489;2260.954780904381;2261.7738226177335;2352.6000579901374;2357.387079359362;2361.551305251997;2427.599446091393;2429.708434987795;2368.2066507719933;2394;2396.7962723168553;2401.615741481372;2444.4255599934;8799.780005499913;8886.60010299538;8887.422317549403;8901.510416927067;8924;5419.891602167974;5538.169274608801;5566;5570;5588.245586845765;3557.2529768748595;3632.54593175853;3658.0854786303425;3710.3877860153043;3722.8324725387424;1052.984205236922;1066.6693325069175;1069.1660504806264;1084.9620263290826;1085.5223701571363;12022.879771202352;12029.398530073462;12031.879681203163;12038.939805300917;12045.939770301093;4031.5565287818317;4780.402449693788;4792.640551958617;4894.730789806595;4924.113659541317;9852.753681157885;10081.790185177826;10121.493925303705;10123.696289111338;10133.341332813343;5491.121420572769;5494.203340515603;5503.449655034465;5508.44915508446;5510.393856675762;4424.867253982386;4601.884952876205;4828.03439312139;4932.136876046749;4941.950580494149;3107.37852429515;3739.915424526857;3869.5743468218475;3899.473571067926;3938.9212215755524;1137.351709525579;1301.8633043530483;1304.1066869194633;1317.2952470428274;1324.2848861614814;1146.8853114688632;1150.649052039136;1158.7276989907366;1339.7923321885123;1416.7024924765708;8242.958785206156;8278.586070696441;8321.791955201168;8362.749117526484;8423.115572864883;523.769541401782;531.7607076815449;536.0538649284017;536.9006733754268;540.1546579602909;6153.353897840662;6156.507479401637;6244.469220116341;6254.437100660963;6263.154474145932;10700.090492308085;11010.953959373846;11120.721981950515;11132.10943124548;11152.776944461066;10563.788724225473;10962.561497540168;10971.83542246867;10976.012158905736;10979.286346387618;8439.324854011664;8472.110428405053;8510.531920744419;8530.232279094911;8546.188112129337;7788.376929845712;8020.518768873886;8022.358211342962;8108.797280068045;8126.106128325761;9454.24366050728;9642.614295428104;9664.806703866025;9813.950930245303;9944.651937182163;8277.255047045795;8349.415540912078;9830.508474576385;10184.134348580454;10284.382937023802;6634.767783127568;6773.458123350219;6788.898166527407;7576.128745194374;7631.275028872248;7731.652075656497;8317.376196785144;8347.332213423033;8351.29014033814;8363.414560980673;7246.782596522113;7326.120865496175;7365.226651201761;7405.666744996381;7493.400527957641;7219.9278007221355;7240.239774823568;7325.523840950321;7352.485326027127;7381.630918454163;7570.507916985378;7786.065672119382;7859;7882.172371900868;7889.289963903047;7042.119735033121;7062.435005199469;7091.574505529685;7108.3602475777425;7126;7053;7160;7215.8556828864175;7234.96382518084;7240.782776516713 18:24:21 INFO - PROCESS | 2225 | |4;prototype.html;298.581985220691;326.8986614149614;334.12792611284544;335.0467918771095;340.63041599864147;5932.673702946337;6293.716782744776;6655.401013908747;6698.832529186767;6740.898886516707;5971.641701497913;6075.6937258489415;6674.933250667492;6696.330366963313;6714.96642516788;4671.439427268732;4775.450823155329;4811.927821082687;4900.950990490085;4958.206686930101;4862.07620552094;4884.389451318585;4895.55939965403;4898.485659005806;4922.360093187898;4806.567408933195;4819.975900120512;4820.180569303209;4822.938953430257;4826.155422801014;4621.1219868224925;4706.199946009152;4732.077244937239;4774.427068751737;4812.350332705075;4156.293430116887;4164.229617520738;4169.124483858393;4182.330827067654;4188.39268306097;6293.300808781649;6415.8396040098905;6420.93579064208;6445.00102484111;6445.967770161166;5812.099124635688;5832.737526811304;5833.125031245305;5834.241548598655;5858.443447872445;6808.761693340759;7047.89428158578;7077.3984211341585;7077.610731409771;7103.680334384913;4721.598664113554;4734.479207287196;4736.502667219961;4749.358836557055;4754.572088512016;7417.925820741778;7429.257074292582;7452.552846829208;7475.327220550176;7482.176960534337;4792.2811578262845;4793.23308270682;4797.832075877328;4814.037192561502;4819.759012049383;4869.902601947942;4881.804727810919;4885.706857588556;4888.2178851384315;4896.853094407174;5606.803761868315;5809.477147056785;5814.215080964101;5824.359320474744;5828.591998560145;5772.336181339116;7126.572405655677;7136.179339376038;7147.463940204506;7168.569885806868;1662.1606088925016;1697.618035941928;1699.7705309783269;1705.829417058309;1712.5376148439852;899.919007289334;911.366600212859;1081.1296905990596;1104.5471356743697;1108.257467496779;5849;5999.680070384508;6364.681765911686;6608.041833934149;6661.766838160738;7426.145993210742;7453.962730186423;7455.627218639046;7461.216572259943;7476;6620.602763834186;6622.503312251601;6625.3374662534325;6635.87190177671;6646;3902.590228026073;3944.4674968878835;3954.60453954608;3956.3274243378696;3961.544422391462;7395.889061664079;7780.844383112306;7786.260305271104;7817.843643127219;7822.374210063182;6168.907466388007;6306.716197771111;7634.274743899321;7670.654820533089;7689.730859419893;7770.572618505923;7775.883361749465;7783.961080194563;7802;7817.296443320015;7456.701731930662;7458.216887226763;7481.66332515049;7488.063992001;7488.138864030489;6951.9304806953305;7266.346028857428;7307.159676637255;7319.5242309249725;7351.338379545867;7698.653560589675;7771.33943614799;7794.766157015299;7803;7806.609669516388;3988.561258261647;4606.309053641847;4658.324542941323;4665.343802949904;4674.11191873543;7292.671829767779;7388.224236455309;7407.333339999426;7594.430417718803;7608.467407281437;6931.202911665021;7229.09636295463;7243.710251589878;7256.020437241116;7271.672774725044;7107.573545587281;7148.9285107150345;7180.7845764627145;7192.604406757679;7234.638268086469;5755.65466072037;7081.398081163159;7086.468514861509;7091.82270443243;7100.644967751695;5832.533397328119;6992.510524263253;7217.6752046157;7222.602756848424;7235.782926512213;6159.753609855735;6666.600003999775;6694.163229596301;7053.153621565445;7082 18:24:21 INFO - PROCESS | 2225 | |5;yui.html;602.3013304566703;731.2175971710269;743.8958545803586;757.9848403031936;802.9277365037142;15093.396264149435;15130.773038404433;15318.540443786676;15321.693566128672;15325.15711635861;10054.447005414699;14110;14348.282585870717;14365;15032.473863414783;762.8893810397489;778.3034184404954;922.6770630279399;937.779621788879;958.4967891856796;960.1071003966308;962.4417837654144;962.7496850818802;964.6816550538306;966.6278482784144;1001.4542074569341;1002.1982414068752;1003.19744204636;1005.5977608956439;1006.9194464442827;790.3874497264609;806.6208881825532;808.2241048593357;983.9754006149832;998.1266391907081;749.0225256040865;750.6434443639282;751.0574229342195;752.7478294771258;753.7135888362442;15035.624109397244;15062.849371506363;15104.320305586274;15137.394504219817;15169.848301516953;12234.632961011184;12388.256704597752;12392.56626018085;12478.875211247861;12649;9736.902630973671;10030.147437467751;10278;10667.359958402521;10875.945620271848;3531.081918701156;3552.5381700379044;3568.1614820517157;3571.39286321326;3643.0710168906758;85703;86391.13608863894;86627.56686216591;87081.69377459343;88062.55968720179;9032.412893162054;9173.678921237724;9205.723828285161;9207.723768286962;9735.00864645492;21134.260300889397;21144.577108457746;21158.47103822386;21183;21183.046762895705;7273.490855640054;7376.520526165782;7387.85224295511;7432.479726419207;7506.099268087755;3797.4873392091713;4058.350663893822;4065.2682517146604;4070.653994410449;4419.049904270597;3009.8946536871103;3562.412201986643;3594.7483676142942;3596.5863925648364;3601.657842504958;640.794945617398;648.9026646003043;651.5341530805402;666.4002397841884;666.5933780393956;486.7152715661378;536.7262696025056;602.403620415794;610.5024405109822;617.4874853871365;8046.597670116471;8174.836503269901;8241.464304820287;8296.626651800683;8310.501369917823;551.7765305051461;556.4518948835394;557.3061538384737;618.2704408797572;622.7166639179253;3806.676432503268;3853.4818997077173;3886.417037444406;3889.9611003890163;3943.5859234779937;97510;98793;99955.50022249842;100006;100549.49725251473;79005;82516;85803.70355557372;87185.5640721805;87659.56170219109;73961.63019184978;75171;75961.62019189759;76214;76372;7125.82185445368;7619.847603048019;7640.923590764021;7734.381249499914;8038.316743076904;47194.52805471901;48923;49055.75472122616;49210.75394623004;49734.75132624459;63618.36381636124;63677.43449198521;64962;66059;67678.66160669165;10715.089217416295;10721.678349649523;10795.6221532246;10881.619143329945;11123.499442525268;9252.95373523128;11871.471691754186;11900.285982841056;11953.163278570417;12286.81569776472;11327.490262938352;11428.428578570873;11508.021818145551;11664.6500604982;11994;11281.830772538582;11366.772664546828;11370.829437558608;11625.18623696367;11959.402029898645;8765.693200737944;9968.40189588627;10547.894521054997;11114.888851111386;11217;9259.259259259421;9490.572924218288;9569.90430095718;9665.154782263693;9917;7910.327622151951;9441.905580944378;9575.425474471554;9647.421154730739;9694.272929530454 18:24:21 INFO - PROCESS | 2225 | __end_tp_report 18:24:21 INFO - PROCESS | 2225 | __start_cc_report 18:24:21 INFO - PROCESS | 2225 | _x_x_mozilla_cycle_collect,1148 18:24:21 INFO - PROCESS | 2225 | __end_cc_report 18:24:21 INFO - PROCESS | 2225 | __startTimestamp1459301061940__endTimestamp 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | ------- Summary: start ------- 18:24:21 INFO - PROCESS | 2225 | Number of tests: 6 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#0] dojo.html Cycles:165 Average:5677.47 Median:5874.71 stddev:639.85 (10.9%) stddev-sans-first:616.04 18:24:21 INFO - PROCESS | 2225 | Values: 3385.9 3441.9 3469.3 3470.8 3527.5 5551.1 5644.9 5676.3 5703.3 5737.6 5658.5 5673.6 5677.5 5839.9 5840.9 5037.2 5060.9 5095.8 5102.9 5215.6 4271.0 5231.1 5249.4 5272.5 5292.5 5055.0 5088.8 5150.8 5154.4 5161.7 5157.3 5163.5 5180.0 5235.6 5237.5 5097.3 5143.8 5150.7 5165.7 5215.7 4531.3 5627.5 5632.7 5653.2 5674.7 6134.5 6183.8 6193.2 6193.8 6195.5 6157.2 6210.8 6220.2 6223.1 6233.5 5650.1 5748.7 5782.9 5807.9 5821.9 6177.5 6218.9 6219.2 6226.8 6229.1 6022.3 6044.4 6063.0 6113.9 6122.8 6100.3 6171.4 6197.8 6218.6 6240.9 6099.4 6115.7 6121.7 6123.3 6126.7 6153.0 6153.1 6155.8 6175.4 6219.5 4756.9 4829.4 4837.1 4838.5 4875.5 4393.4 4400.2 4455.0 4459.1 4462.3 5608.8 5674.2 5687.1 5694.1 5712.1 6144.6 6208.6 6227.9 6229.4 6236.0 5669.5 5712.7 5726.6 5735.5 5742.1 5089.9 5345.3 5355.4 5355.7 5364.1 6112.3 6231.7 6242.6 6249.9 6263.4 6175.4 6209.9 6221.2 6223.3 6226.3 6152.4 6217.7 6234.9 6247.9 6416.3 6081.7 6106.2 6116.5 6121.2 6136.4 6122.1 6154.3 6164.0 6167.9 6190.2 5870.9 5934.7 6008.8 6051.9 6098.2 5960.4 5974.7 5976.3 5977.0 5988.3 5737.0 5814.2 5819.8 5858.4 5872.6 5874.7 5974.8 6043.8 6108.6 6138.0 4269.6 5901.2 5905.0 5915.8 5921.7 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#1] ext.html Cycles:180 Average:59206.29 Median:36642.50 stddev:122917.90 (335.5%) stddev-sans-first:123183.62 18:24:21 INFO - PROCESS | 2225 | Values: 474.3 577.9 585.9 630.8 634.8 38144.4 38676.4 38684.8 38726.0 38760.4 41921.6 42096.6 42188.0 42313.6 42338.0 9517.0 9730.5 9748.9 9756.8 9775.7 9481.0 9603.2 9626.7 9627.4 9650.8 9683.4 9765.1 9770.8 9772.5 9791.7 9662.2 9718.6 9731.8 9734.1 9749.6 9617.3 9778.0 9779.3 9781.5 9787.6 40540.2 40543.2 40949.2 41019.0 41140.4 3218.7 3236.7 3241.3 3259.3 3478.6 28361.9 28362.7 28514.9 28991.4 29105.7 2568.5 2583.5 2590.7 2643.7 2660.4 497841.0 498954.0 500628.0 500683.5 501470.0 35745.6 44284.6 61841.7 63162.0 63233.7 43999.8 44050.6 44096.6 44139.8 44174.3 14971.9 15084.0 15091.2 15098.5 15107.4 12008.0 12047.3 12071.8 12073.9 12076.9 14087.3 14304.0 14341.5 14391.4 14433.4 6124.3 6181.1 6212.2 6219.1 6232.3 899.6 974.8 1091.4 1099.2 1099.2 23444.9 25515.1 28637.4 28727.1 28835.0 1051.1 1059.3 1088.3 1091.8 1164.2 12534.2 14357.0 14489.4 14586.7 14893.3 503828.0 511597.0 513212.0 514447.0 515239.0 47079.8 56199.4 57788.0 57929.7 58050.0 1317.8 1342.7 1449.6 1450.4 1487.3 27461.0 28346.6 28358.0 28443.3 29291.7 44252.8 44352.0 44622.8 44693.6 44734.0 355518.0 358038.0 358478.2 358658.0 360776.0 32559.8 32796.7 33055.5 33442.7 33452.8 43909.6 44421.6 44661.3 45321.9 45821.0 32484.0 34455.7 35329.5 37020.4 37215.0 35317.8 35769.3 35807.5 36576.0 36709.0 30991.7 35158.8 36230.8 36263.6 36521.8 27853.7 30267.2 30476.4 31079.5 31081.1 22861.3 23383.8 23579.3 23626.6 23681.3 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#2] jquery.html Cycles:180 Average:33802.85 Median:2012.08 stddev:103166.02 (5127.3%) stddev-sans-first:103424.87 18:24:21 INFO - PROCESS | 2225 | Values: 362.7 365.8 366.7 370.0 377.8 19168.2 19236.8 20101.5 20107.4 20109.9 17188.7 19022.6 19734.1 19928.8 19985.4 5660.4 5801.0 5817.7 5863.0 5871.9 4170.3 4366.5 5759.4 6103.1 6391.4 6291.6 6316.7 6326.8 6330.4 6361.4 6013.2 6320.7 6327.1 6331.6 6337.3 3657.4 3836.2 3836.9 3838.6 5401.5 22820.0 23471.3 23807.0 24941.8 25036.6 2459.0 2594.3 2617.8 2830.8 2841.3 14173.3 14430.1 14600.1 15131.8 15165.8 1628.8 1654.0 1770.2 1816.4 1979.5 91531.0 95967.5 96268.5 96544.5 97686.0 10655.4 10828.6 10931.6 10964.3 11011.7 13479.7 13493.3 13525.7 13527.7 13536.8 8089.8 8266.0 8280.7 8353.5 8355.2 8289.6 8309.2 8335.1 8421.0 8430.2 4310.6 4329.7 4338.8 4361.6 4378.4 1557.0 1710.2 1772.1 1790.6 1791.7 919.4 969.4 996.3 998.1 1012.3 13691.9 18356.0 18593.9 18982.9 19227.6 950.6 958.3 965.0 970.4 979.7 10190.0 10491.3 10525.9 10533.6 10544.3 602404.0 615029.0 625940.0 635794.0 646018.0 104061.4 104700.5 106575.5 109054.9 110961.8 903.8 950.7 1085.9 1110.2 1112.1 16871.3 17074.7 17144.2 17157.2 17472.8 46515.5 47813.8 47991.5 48020.0 49930.8 67703.0 67909.6 68710.7 70058.3 71275.0 6933.9 7250.2 7288.0 7442.3 7468.7 9278.3 11031.8 11321.9 11347.9 11570.4 9779.7 9863.9 10087.4 10225.0 10241.9 9609.9 9837.7 9904.3 10003.7 10062.2 10260.6 10305.5 10336.3 10495.5 10597.5 7295.8 7371.1 7520.4 7553.3 7692.7 10078.2 10201.7 10268.2 10331.5 10497.3 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#3] mootools.html Cycles:180 Average:6051.37 Median:2980.02 stddev:3267.47 (109.6%) stddev-sans-first:3258.31 18:24:21 INFO - PROCESS | 2225 | Values: 1447.0 1611.1 1636.5 1903.9 2014.6 8065.9 8583.0 8897.9 8926.7 8933.0 8549.9 8777.7 8791.6 8796.3 8802.2 1781.5 2418.9 2452.2 2484.5 2486.1 2294.6 2313.6 2319.2 2323.4 2326.1 2200.7 2231.2 2258.1 2261.0 2261.8 2352.6 2357.4 2361.6 2427.6 2429.7 2368.2 2394.0 2396.8 2401.6 2444.4 8799.8 8886.6 8887.4 8901.5 8924.0 5419.9 5538.2 5566.0 5570.0 5588.2 3557.3 3632.5 3658.1 3710.4 3722.8 1053.0 1066.7 1069.2 1085.0 1085.5 12022.9 12029.4 12031.9 12038.9 12045.9 4031.6 4780.4 4792.6 4894.7 4924.1 9852.8 10081.8 10121.5 10123.7 10133.3 5491.1 5494.2 5503.4 5508.4 5510.4 4424.9 4601.9 4828.0 4932.1 4942.0 3107.4 3739.9 3869.6 3899.5 3938.9 1137.4 1301.9 1304.1 1317.3 1324.3 1146.9 1150.6 1158.7 1339.8 1416.7 8243.0 8278.6 8321.8 8362.7 8423.1 523.8 531.8 536.1 536.9 540.2 6153.4 6156.5 6244.5 6254.4 6263.2 10700.1 11011.0 11120.7 11132.1 11152.8 10563.8 10962.6 10971.8 10976.0 10979.3 8439.3 8472.1 8510.5 8530.2 8546.2 7788.4 8020.5 8022.4 8108.8 8126.1 9454.2 9642.6 9664.8 9814.0 9944.7 8277.3 8349.4 9830.5 10184.1 10284.4 6634.8 6773.5 6788.9 7576.1 7631.3 7731.7 8317.4 8347.3 8351.3 8363.4 7246.8 7326.1 7365.2 7405.7 7493.4 7219.9 7240.2 7325.5 7352.5 7381.6 7570.5 7786.1 7859.0 7882.2 7889.3 7042.1 7062.4 7091.6 7108.4 7126.0 7053.0 7160.0 7215.9 7235.0 7240.8 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#4] prototype.html Cycles:180 Average:5815.76 Median:6527.00 stddev:1862.80 (28.5%) stddev-sans-first:1821.41 18:24:21 INFO - PROCESS | 2225 | Values: 298.6 326.9 334.1 335.0 340.6 5932.7 6293.7 6655.4 6698.8 6740.9 5971.6 6075.7 6674.9 6696.3 6715.0 4671.4 4775.5 4811.9 4901.0 4958.2 4862.1 4884.4 4895.6 4898.5 4922.4 4806.6 4820.0 4820.2 4822.9 4826.2 4621.1 4706.2 4732.1 4774.4 4812.4 4156.3 4164.2 4169.1 4182.3 4188.4 6293.3 6415.8 6420.9 6445.0 6446.0 5812.1 5832.7 5833.1 5834.2 5858.4 6808.8 7047.9 7077.4 7077.6 7103.7 4721.6 4734.5 4736.5 4749.4 4754.6 7417.9 7429.3 7452.6 7475.3 7482.2 4792.3 4793.2 4797.8 4814.0 4819.8 4869.9 4881.8 4885.7 4888.2 4896.9 5606.8 5809.5 5814.2 5824.4 5828.6 5772.3 7126.6 7136.2 7147.5 7168.6 1662.2 1697.6 1699.8 1705.8 1712.5 899.9 911.4 1081.1 1104.5 1108.3 5849.0 5999.7 6364.7 6608.0 6661.8 7426.1 7454.0 7455.6 7461.2 7476.0 6620.6 6622.5 6625.3 6635.9 6646.0 3902.6 3944.5 3954.6 3956.3 3961.5 7395.9 7780.8 7786.3 7817.8 7822.4 6168.9 6306.7 7634.3 7670.7 7689.7 7770.6 7775.9 7784.0 7802.0 7817.3 7456.7 7458.2 7481.7 7488.1 7488.1 6951.9 7266.3 7307.2 7319.5 7351.3 7698.7 7771.3 7794.8 7803.0 7806.6 3988.6 4606.3 4658.3 4665.3 4674.1 7292.7 7388.2 7407.3 7594.4 7608.5 6931.2 7229.1 7243.7 7256.0 7271.7 7107.6 7148.9 7180.8 7192.6 7234.6 5755.7 7081.4 7086.5 7091.8 7100.6 5832.5 6992.5 7217.7 7222.6 7235.8 6159.8 6666.6 6694.2 7053.2 7082.0 18:24:21 INFO - PROCESS | 2225 | 18:24:21 INFO - PROCESS | 2225 | [#5] yui.html Cycles:180 Average:18806.66 Median:613.99 stddev:27280.62 (4443.1%) stddev-sans-first:27322.91 18:24:21 INFO - PROCESS | 2225 | Values: 602.3 731.2 743.9 758.0 802.9 15093.4 15130.8 15318.5 15321.7 15325.2 10054.4 14110.0 14348.3 14365.0 15032.5 762.9 778.3 922.7 937.8 958.5 960.1 962.4 962.7 964.7 966.6 1001.5 1002.2 1003.2 1005.6 1006.9 790.4 806.6 808.2 984.0 998.1 749.0 750.6 751.1 752.7 753.7 15035.6 15062.8 15104.3 15137.4 15169.8 12234.6 12388.3 12392.6 12478.9 12649.0 9736.9 10030.1 10278.0 10667.4 10875.9 3531.1 3552.5 3568.2 3571.4 3643.1 85703.0 86391.1 86627.6 87081.7 88062.6 9032.4 9173.7 9205.7 9207.7 9735.0 21134.3 21144.6 21158.5 21183.0 21183.0 7273.5 7376.5 7387.9 7432.5 7506.1 3797.5 4058.4 4065.3 4070.7 4419.0 3009.9 3562.4 3594.7 3596.6 3601.7 640.8 648.9 651.5 666.4 666.6 486.7 536.7 602.4 610.5 617.5 8046.6 8174.8 8241.5 8296.6 8310.5 551.8 556.5 557.3 618.3 622.7 3806.7 3853.5 3886.4 3890.0 3943.6 97510.0 98793.0 99955.5 100006.0 100549.5 79005.0 82516.0 85803.7 87185.6 87659.6 73961.6 75171.0 75961.6 76214.0 76372.0 7125.8 7619.8 7640.9 7734.4 8038.3 47194.5 48923.0 49055.8 49210.8 49734.8 63618.4 63677.4 64962.0 66059.0 67678.7 10715.1 10721.7 10795.6 10881.6 11123.5 9253.0 11871.5 11900.3 11953.2 12286.8 11327.5 11428.4 11508.0 11664.7 11994.0 11281.8 11366.8 11370.8 11625.2 11959.4 8765.7 9968.4 10547.9 11114.9 11217.0 9259.3 9490.6 9569.9 9665.2 9917.0 7910.3 9441.9 9575.4 9647.4 9694.3 18:24:21 INFO - PROCESS | 2225 | -------- Summary: end -------- 18:24:21 INFO - PROCESS | 2225 | 18:24:22 INFO - TEST-INFO | 2225: exit 0 18:24:22 INFO - TEST-OK | dromaeo_css | took 1113241ms 18:24:22 INFO - TEST-START | kraken 18:24:22 INFO - operating with platform_type : mac_ 18:24:22 INFO - Initialising browser for kraken test... 18:24:22 INFO - TEST-INFO | started process 2227 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpMy7P_o/profile http://localhost:49851/getInfo.html) 18:24:24 INFO - PROCESS | 2227 | __metrics Screen width/height:1600/1200 18:24:24 INFO - PROCESS | 2227 | colorDepth:24 18:24:24 INFO - PROCESS | 2227 | Browser inner width/height: 1024/689 18:24:24 INFO - PROCESS | 2227 | __metrics 18:24:24 INFO - PROCESS | 2227 | 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:24:24 ERROR - PROCESS | 2227 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:24:25 INFO - TEST-INFO | 2227: exit 0 18:24:25 INFO - Browser initialized. 18:24:25 INFO - Running cycle 1/1 for kraken test... 18:24:25 INFO - TEST-INFO | started process 2229 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpMy7P_o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:37 INFO - PROCESS | 2229 | RSS: Main: 244244480 18:24:37 INFO - PROCESS | 2229 | 18:24:40 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:40 INFO - PROCESS | 2229 | RSS: Main: 290529280 18:24:40 INFO - PROCESS | 2229 | 18:24:43 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-dft) 18:24:43 INFO - PROCESS | 2229 | RSS: Main: 301051904 18:24:43 INFO - PROCESS | 2229 | 18:24:47 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-fft) 18:24:47 INFO - PROCESS | 2229 | RSS: Main: 284798976 18:24:47 INFO - PROCESS | 2229 | 18:24:49 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-oscillator) 18:24:50 INFO - PROCESS | 2229 | RSS: Main: 286588928 18:24:50 INFO - PROCESS | 2229 | 18:24:52 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:52 INFO - PROCESS | 2229 | RSS: Main: 288088064 18:24:52 INFO - PROCESS | 2229 | 18:24:55 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:56 INFO - PROCESS | 2229 | RSS: Main: 288514048 18:24:56 INFO - PROCESS | 2229 | 18:24:59 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-desaturate) 18:24:59 INFO - PROCESS | 2229 | RSS: Main: 288284672 18:24:59 INFO - PROCESS | 2229 | 18:25:02 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49851/tests/kraken/driver.html?testName=json-parse-financial) 18:25:03 INFO - PROCESS | 2229 | RSS: Main: 288952320 18:25:03 INFO - PROCESS | 2229 | 18:25:04 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:25:05 INFO - PROCESS | 2229 | RSS: Main: 325373952 18:25:05 INFO - PROCESS | 2229 | 18:25:07 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:25:07 INFO - PROCESS | 2229 | RSS: Main: 324210688 18:25:07 INFO - PROCESS | 2229 | 18:25:09 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:25:10 INFO - PROCESS | 2229 | RSS: Main: 329515008 18:25:10 INFO - PROCESS | 2229 | 18:25:13 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:13 INFO - PROCESS | 2229 | RSS: Main: 331112448 18:25:13 INFO - PROCESS | 2229 | 18:25:16 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:16 INFO - PROCESS | 2229 | RSS: Main: 330829824 18:25:16 INFO - PROCESS | 2229 | 18:25:18 INFO - PROCESS | 2229 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49851/tests/kraken/driver.html?testName=ai-astar) 18:25:19 INFO - PROCESS | 2229 | RSS: Main: 393428992 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | __start_tp_report 18:25:19 INFO - PROCESS | 2229 | _x_x_mozilla_page_load 18:25:19 INFO - PROCESS | 2229 | _x_x_mozilla_page_load_details 18:25:19 INFO - PROCESS | 2229 | |i|pagename|runs| 18:25:19 INFO - PROCESS | 2229 | |0;ai-astar;111;109;110;112;110;113;117;111;111;111 18:25:19 INFO - PROCESS | 2229 | |1;audio-beat-detection;159;127;144;162;119;144;141;120;164;120 18:25:19 INFO - PROCESS | 2229 | |2;audio-dft;187;186;185;184;185;187;187;184;183;182 18:25:19 INFO - PROCESS | 2229 | |3;audio-fft;78;76;83;80;56;57;57;78;79;56 18:25:19 INFO - PROCESS | 2229 | |4;audio-oscillator;92;93;129;79;84;85;116;80;80;121 18:25:19 INFO - PROCESS | 2229 | |5;imaging-gaussian-blur;87;84;87;85;88;85;88;85;90;85 18:25:19 INFO - PROCESS | 2229 | |6;imaging-darkroom;96;92;93;94;92;92;93;94;94;92 18:25:19 INFO - PROCESS | 2229 | |7;imaging-desaturate;87;85;98;117;124;137;85;81;88;85 18:25:19 INFO - PROCESS | 2229 | |8;json-parse-financial;54;52;53;51;52;53;52;65;55;50 18:25:19 INFO - PROCESS | 2229 | |9;json-stringify-tinderbox;62;68;64;79;71;72;67;68;67;68 18:25:19 INFO - PROCESS | 2229 | |10;stanford-crypto-aes;82;85;84;84;81;81;81;111;110;110 18:25:19 INFO - PROCESS | 2229 | |11;stanford-crypto-ccm;123;125;124;134;138;135;130;122;118;126 18:25:19 INFO - PROCESS | 2229 | |12;stanford-crypto-pbkdf2;138;132;140;138;139;131;144;129;138;138 18:25:19 INFO - PROCESS | 2229 | |13;stanford-crypto-sha256-iterative;68;72;94;97;96;75;67;66;66;67 18:25:19 INFO - PROCESS | 2229 | __end_tp_report 18:25:19 INFO - PROCESS | 2229 | __start_cc_report 18:25:19 INFO - PROCESS | 2229 | _x_x_mozilla_cycle_collect,1273 18:25:19 INFO - PROCESS | 2229 | __end_cc_report 18:25:19 INFO - PROCESS | 2229 | __startTimestamp1459301119032__endTimestamp 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | ------- Summary: start ------- 18:25:19 INFO - PROCESS | 2229 | Number of tests: 14 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:2.22 (2.0%) stddev-sans-first:2.35 18:25:19 INFO - PROCESS | 2229 | Values: 111.0 109.0 110.0 112.0 110.0 113.0 117.0 111.0 111.0 111.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:144.00 stddev:17.84 (12.4%) stddev-sans-first:17.55 18:25:19 INFO - PROCESS | 2229 | Values: 159.0 127.0 144.0 162.0 119.0 144.0 141.0 120.0 164.0 120.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:1.76 (1.0%) stddev-sans-first:1.72 18:25:19 INFO - PROCESS | 2229 | Values: 187.0 186.0 185.0 184.0 185.0 187.0 187.0 184.0 183.0 182.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#3] audio-fft Cycles:10 Average:70.00 Median:78.00 stddev:11.76 (15.1%) stddev-sans-first:12.11 18:25:19 INFO - PROCESS | 2229 | Values: 78.0 76.0 83.0 80.0 56.0 57.0 57.0 78.0 79.0 56.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:82.00 stddev:18.87 (23.0%) stddev-sans-first:19.96 18:25:19 INFO - PROCESS | 2229 | Values: 92.0 93.0 129.0 79.0 84.0 85.0 116.0 80.0 80.0 121.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:1.90 (2.2%) stddev-sans-first:2.00 18:25:19 INFO - PROCESS | 2229 | Values: 87.0 84.0 87.0 85.0 88.0 85.0 88.0 85.0 90.0 85.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.50 stddev:1.32 (1.4%) stddev-sans-first:0.93 18:25:19 INFO - PROCESS | 2229 | Values: 96.0 92.0 93.0 94.0 92.0 92.0 93.0 94.0 94.0 92.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:85.00 stddev:19.92 (23.4%) stddev-sans-first:20.67 18:25:19 INFO - PROCESS | 2229 | Values: 87.0 85.0 98.0 117.0 124.0 137.0 85.0 81.0 88.0 85.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:4.22 (8.0%) stddev-sans-first:4.47 18:25:19 INFO - PROCESS | 2229 | Values: 54.0 52.0 53.0 51.0 52.0 53.0 52.0 65.0 55.0 50.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:4.67 (6.9%) stddev-sans-first:4.30 18:25:19 INFO - PROCESS | 2229 | Values: 62.0 68.0 64.0 79.0 71.0 72.0 67.0 68.0 67.0 68.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:81.50 stddev:13.49 (16.5%) stddev-sans-first:13.91 18:25:19 INFO - PROCESS | 2229 | Values: 82.0 85.0 84.0 84.0 81.0 81.0 81.0 111.0 110.0 110.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.00 stddev:6.47 (5.1%) stddev-sans-first:6.65 18:25:19 INFO - PROCESS | 2229 | Values: 123.0 125.0 124.0 134.0 138.0 135.0 130.0 122.0 118.0 126.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:138.00 stddev:4.60 (3.3%) stddev-sans-first:4.85 18:25:19 INFO - PROCESS | 2229 | Values: 138.0 132.0 140.0 138.0 139.0 131.0 144.0 129.0 138.0 138.0 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - PROCESS | 2229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:73.50 stddev:13.34 (18.1%) stddev-sans-first:13.76 18:25:19 INFO - PROCESS | 2229 | Values: 68.0 72.0 94.0 97.0 96.0 75.0 67.0 66.0 66.0 67.0 18:25:19 INFO - PROCESS | 2229 | -------- Summary: end -------- 18:25:19 INFO - PROCESS | 2229 | 18:25:19 INFO - TEST-INFO | 2229: exit 0 18:25:19 INFO - TEST-OK | kraken | took 57291ms 18:25:19 INFO - SUITE-END | took 1170s 18:25:20 INFO - Completed test suite (00:19:30) 18:25:20 INFO - javascript benchmark 18:25:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3385.9322813543727, 3441.9139521511943, 3469.3234819210265, 3470.774399664021, 3527.541419615451, 5551.139573366125, 5644.927463781879, 5676.347220069693, 5703.258576385069, 5737.627054241471, 5658.490735833774, 5673.631213971089, 5677.48902598766, 5839.883202335961, 5840.853978650525, 5037.244413337992, 5060.924086138711, 5095.79616815327, 5102.948970510284, 5215.608829337815, 4270.957290427087, 5231.084560201968, 5249.448807875176, 5272.525472707455, 5292.497212764801, 5054.974725126388, 5088.847334579968, 5150.845474635767, 5154.433012368637, 5161.741912904358, 5157.277981082651, 5163.483651634844, 5179.974100129513, 5235.633505654606, 5237.47625237477, 5097.286379906779, 5143.819966301199, 5150.665206761586, 5165.690058596459, 5215.687058776485, 4531.297648864432, 5627.549796016309, 5632.662040277555, 5653.1520271959125, 5674.716264186774, 6134.5092392608485, 6183.845403864894, 6193.225846769154, 6193.783217587408, 6195.535334849904, 6157.199564056644, 6210.751569937197, 6220.160278362454, 6223.097650840648, 6233.532485063638, 5650.067738823048, 5748.712564371848, 5782.913256301201, 5807.883842323172, 5821.912671309934, 6177.4749146322165, 6218.9378106219265, 6219.222597175353, 6226.813195604139, 6229.0967809667345, 6022.337542870281, 6044.395560443921, 6062.969685151635, 6113.938860611426, 6122.7857025004805, 6100.30868792748, 6171.382861713882, 6197.81406557804, 6218.595791273553, 6240.937590624036, 6099.370313949828, 6115.696722738819, 6121.696863452088, 6123.343628574293, 6126.731429653714, 6153.046277826944, 6153.077038444179, 6155.7688462307715, 6175.413335733098, 6219.533534984895, 4756.904861902743, 4829.396325459317, 4837.129316722953, 4838.491958344393, 4875.488073752276, 4393.428854248991, 4400.185965596375, 4455.0, 4459.1304695584695, 4462.263726485158, 5608.775648974077, 5674.177244299636, 5687.0616348302065, 5694.1458781183155, 5712.143178523172, 6144.556029333103, 6208.596441231305, 6227.937720622826, 6229.3770622937345, 6236.03341482071, 5669.489745922804, 5712.742926568314, 5726.570507211975, 5735.483806457439, 5742.13867919807, 5089.949100509021, 5345.33183352081, 5355.3841308249275, 5355.7054362009685, 5364.14173732201, 6112.327643959161, 6231.719572619243, 6242.625442473466, 6249.937500624936, 6263.4362907338555, 6175.413335733098, 6209.875802484015, 6221.222347206599, 6223.284322302812, 6226.283977342664, 6152.446279834658, 6217.720202590804, 6234.875302494015, 6247.937520624736, 6416.326285740117, 6081.695915204311, 6106.15732346443, 6116.548817443993, 6121.208497748031, 6136.447719705248, 6122.063299448936, 6154.292256390393, 6163.982942814565, 6167.876642467215, 6190.1952746142715, 5870.9412905872105, 5934.732937017759, 6008.788262456106, 6051.878962420815, 6098.237720284965, 5960.403959604005, 5974.671393073423, 5976.282846058501, 5977.043673012471, 5988.28140623128, 5736.996025695403, 5814.156947242711, 5819.79630712923, 5858.443447872445, 5872.588918775645, 5874.706264686663, 5974.761009559569, 6043.758249669964, 6108.602940808833, 6138.0179171332375, 4269.594388533084, 5901.203337549376, 5905.025670764276, 5915.792947246998, 5921.733521991435], "unit": "score", "name": "dojo.html", "value": 5638.470873394066}, {"lowerIsBetter": false, "replicates": [474.2696247778421, 577.8902008618362, 585.8780435466083, 630.8012975912587, 634.7968650031988, 38144.427833582486, 38676.41985370218, 38684.80657596715, 38726.031849203784, 38760.418593721115, 41921.58078419223, 42096.57903420965, 42187.99999999992, 42313.57686423135, 42338.0, 9516.953135155145, 9730.513474326292, 9748.853767193497, 9756.804863902718, 9775.706728798148, 9481.0, 9603.231741460666, 9626.711198664016, 9627.422354658744, 9650.758731031745, 9683.370580912253, 9765.072318129802, 9770.804583908317, 9772.511374431286, 9791.657291994781, 9662.227021838236, 9718.61125554977, 9731.805363892683, 9734.075262850018, 9749.610015599368, 9617.27870409722, 9777.951110244474, 9779.315447918649, 9781.510924453749, 9787.559559819825, 40540.18919621591, 40543.18913621741, 40949.18101637951, 41019.0, 41140.38289425661, 3218.7103160715646, 3236.7410607151373, 3241.3355262171435, 3259.2916658380723, 3478.565179352581, 28361.85819070912, 28362.716372836214, 28514.857425712948, 28991.42017159645, 29105.70894291051, 2568.486302739441, 2583.547879121165, 2590.7020692620404, 2643.73562643736, 2660.414708764069, 497841.0, 498954.0, 500628.0, 500683.4965825184, 501469.99999999633, 35745.64254357475, 44284.55715442805, 61841.69079154665, 63162.0, 63233.68383158147, 43999.78000110043, 44050.55949440529, 44096.55903440989, 44139.77930110393, 44174.33738493925, 14971.877109216852, 15084.0, 15091.245437728288, 15098.54704358871, 15107.39570417193, 12008.0, 12047.33739644328, 12071.758564828655, 12073.939630301968, 12076.939615301868, 14087.295635218197, 14304.0, 14341.498047568284, 14391.424343026161, 14433.35049922756, 6124.326324104345, 6181.103739957681, 6212.161358216583, 6219.0982307566055, 6232.3144454110015, 899.5592159841631, 974.8440249560036, 1091.3942761767296, 1099.197585762398, 1099.2030777686114, 23444.944977476054, 25515.10697125592, 28637.427251454854, 28727.13818585446, 28835.0, 1051.0960573906434, 1059.2532264753331, 1088.3252383522108, 1091.8143915534379, 1164.1618035014776, 12534.185277956904, 14357.0, 14489.420423182955, 14586.708265834835, 14893.32980015902, 503828.0, 511597.0, 513212.0, 514447.0, 515239.0, 47079.76460117677, 56199.43800561942, 57788.0, 57929.710351447975, 58050.0, 1317.7957416600443, 1342.7381660576289, 1449.5723761490385, 1450.3618407900701, 1487.2935355705954, 27461.03886363968, 28346.574801378407, 28358.0, 28443.28891777722, 29291.707082928897, 44252.77873610611, 44352.0, 44622.77688611536, 44693.55306446894, 44734.0, 355518.0, 358038.0, 358478.2076089603, 358658.0, 360776.0, 32559.837200814793, 32796.67203327936, 33055.50416743703, 33442.66557334493, 33452.832735836164, 43909.56090439055, 44421.55578444174, 44661.330080049476, 45321.86695332643, 45821.0, 32484.0, 34455.655443446245, 35329.470057949664, 37020.44469332908, 37215.0, 35317.82341088278, 35769.28461430809, 35807.46288805722, 36576.0, 36709.0, 30991.69008309888, 35158.82420587881, 36230.81884590666, 36263.637363626025, 36521.817390912875, 27853.721462785925, 30267.243318917204, 30476.390472190877, 31079.533806992462, 31081.067567972997, 22861.31416057521, 23383.766162338157, 23579.29262122139, 23626.64560031635, 23681.289561313188], "unit": "score", "name": "ext.html", "value": 18663.562027344222}, {"lowerIsBetter": false, "replicates": [362.72976632408853, 365.82440428594293, 366.7451121470578, 369.9574548926874, 377.8261999480239, 19168.233270669174, 19236.807631923675, 20101.497462563442, 20107.396778096645, 20109.899450502744, 17188.742168867444, 19022.61954760904, 19734.130511428808, 19928.800711992877, 19985.400437986882, 5660.405657405975, 5800.970995145019, 5817.680027598481, 5862.97068514659, 5871.911921321183, 4170.332746760519, 4366.476022877243, 5759.424057594249, 6103.084537319415, 6391.392817682313, 6291.622502649833, 6316.715747791361, 6326.841828954267, 6330.430261276484, 6361.363863613625, 6013.1581578579035, 6320.652364119972, 6327.1458353122425, 6331.55679102463, 6337.271213810424, 3657.4148136298063, 3836.232753449321, 3836.884893453173, 3838.5777564467885, 5401.4868587484125, 22819.973101210486, 23471.295861124192, 23807.047718091428, 24941.750582494125, 25036.624450633255, 2458.987705061481, 2594.3125071855975, 2617.751313625203, 2830.8301501909746, 2841.318083659927, 14173.291335433187, 14430.062045966979, 14600.050996685182, 15131.773023404658, 15165.772513412308, 1628.812686541051, 1653.9586510337217, 1770.2299499717535, 1816.409666858263, 1979.4853338132045, 91531.0, 95967.52016239944, 96268.51865740697, 96544.51727741386, 97686.0, 10655.360678359324, 10828.62099826518, 10931.617393391192, 10964.287321324247, 11011.669649910515, 13479.730405391838, 13493.301339732092, 13525.661858453617, 13527.729445411036, 13536.796948045787, 8089.797755056053, 8266.008079030555, 8280.668773249123, 8353.457025293337, 8355.248027677539, 8289.58552072394, 8309.210624990616, 8335.083140854502, 8421.031581368099, 8430.199131082538, 4310.568943105727, 4329.696921215547, 4338.806828122229, 4361.629261512743, 4378.387025816388, 1556.9844301557066, 1710.1705672748708, 1772.060807771883, 1790.64187162568, 1791.6595846789069, 919.3727103027604, 969.4280374579032, 996.2627655534997, 998.0618218874235, 1012.2610494339174, 13691.863081369058, 18355.990420526734, 18593.90703046503, 18982.861028338342, 19227.61544769125, 950.5769932380025, 958.3052287091803, 964.9565769540387, 970.4468452981873, 979.7011911366959, 10190.0, 10491.318064325947, 10525.9473702631, 10533.578656853793, 10544.26190166681, 602404.0, 615029.0, 625940.0, 635794.0, 646018.0, 104061.43907841388, 104700.47649761703, 106575.46712266545, 109054.90945090448, 110961.78076438425, 903.7830920579145, 950.6530116507425, 1085.9294145880492, 1110.2006555280186, 1112.093643680398, 16871.325146993982, 17074.743878842077, 17144.22850971734, 17157.227924743165, 17472.825271747628, 46515.53484465112, 47813.804654883905, 47991.52008479871, 48020.0, 49930.75034624804, 67703.0, 67909.64180716457, 68710.65644671944, 70058.29941700518, 71275.0, 6933.930660693329, 7250.238724933806, 7287.9635601823775, 7442.330190282901, 7468.663910124166, 9278.257739380968, 11031.779364412507, 11321.943390282995, 11347.943260283646, 11570.363630000431, 9779.657711980331, 9863.901360986298, 10087.445190514592, 10225.0, 10241.92459791741, 9609.855852162364, 9837.704868853945, 9904.25718071162, 10003.699889003341, 10062.195024398177, 10260.640877569249, 10305.484725763832, 10336.283185840708, 10495.47522623881, 10597.47012649349, 7295.781126566211, 7371.115466144097, 7520.366827670029, 7553.32020118192, 7692.653830577749, 10078.244131690006, 10201.693949181536, 10268.229882758973, 10331.483425828828, 10497.265191436527], "unit": "score", "name": "jquery.html", "value": 9128.828922602645}, {"lowerIsBetter": false, "replicates": [1447.0449503327807, 1611.0816834404386, 1636.509047285814, 1903.8572107091964, 2014.6071516054376, 8065.91934080659, 8582.970043594769, 8897.91102088979, 8926.732198034062, 8933.0, 8549.87175192371, 8777.736667899973, 8791.604377802998, 8796.340274479424, 8802.207801297882, 1781.4566557200048, 2418.9395265118337, 2452.239805660251, 2484.4534202475425, 2486.11742831295, 2294.598445272079, 2313.560423519526, 2319.246244970383, 2323.4075310795806, 2326.0695721711368, 2200.713907192063, 2231.241377931503, 2258.06290389489, 2260.954780904381, 2261.7738226177335, 2352.6000579901374, 2357.387079359362, 2361.551305251997, 2427.599446091393, 2429.708434987795, 2368.2066507719933, 2394.0, 2396.7962723168553, 2401.615741481372, 2444.4255599934, 8799.780005499913, 8886.60010299538, 8887.422317549403, 8901.510416927067, 8924.0, 5419.891602167974, 5538.169274608801, 5566.0, 5570.0, 5588.245586845765, 3557.2529768748595, 3632.54593175853, 3658.0854786303425, 3710.3877860153043, 3722.8324725387424, 1052.984205236922, 1066.6693325069175, 1069.1660504806264, 1084.9620263290826, 1085.5223701571363, 12022.879771202352, 12029.398530073462, 12031.879681203163, 12038.939805300917, 12045.939770301093, 4031.5565287818317, 4780.402449693788, 4792.640551958617, 4894.730789806595, 4924.113659541317, 9852.753681157885, 10081.790185177826, 10121.493925303705, 10123.696289111338, 10133.341332813343, 5491.121420572769, 5494.203340515603, 5503.449655034465, 5508.44915508446, 5510.393856675762, 4424.867253982386, 4601.884952876205, 4828.03439312139, 4932.136876046749, 4941.950580494149, 3107.37852429515, 3739.915424526857, 3869.5743468218475, 3899.473571067926, 3938.9212215755524, 1137.351709525579, 1301.8633043530483, 1304.1066869194633, 1317.2952470428274, 1324.2848861614814, 1146.8853114688632, 1150.649052039136, 1158.7276989907366, 1339.7923321885123, 1416.7024924765708, 8242.958785206156, 8278.586070696441, 8321.791955201168, 8362.749117526484, 8423.115572864883, 523.769541401782, 531.7607076815449, 536.0538649284017, 536.9006733754268, 540.1546579602909, 6153.353897840662, 6156.507479401637, 6244.469220116341, 6254.437100660963, 6263.154474145932, 10700.090492308085, 11010.953959373846, 11120.721981950515, 11132.10943124548, 11152.776944461066, 10563.788724225473, 10962.561497540168, 10971.83542246867, 10976.012158905736, 10979.286346387618, 8439.324854011664, 8472.110428405053, 8510.531920744419, 8530.232279094911, 8546.188112129337, 7788.376929845712, 8020.518768873886, 8022.358211342962, 8108.797280068045, 8126.106128325761, 9454.24366050728, 9642.614295428104, 9664.806703866025, 9813.950930245303, 9944.651937182163, 8277.255047045795, 8349.415540912078, 9830.508474576385, 10184.134348580454, 10284.382937023802, 6634.767783127568, 6773.458123350219, 6788.898166527407, 7576.128745194374, 7631.275028872248, 7731.652075656497, 8317.376196785144, 8347.332213423033, 8351.29014033814, 8363.414560980673, 7246.782596522113, 7326.120865496175, 7365.226651201761, 7405.666744996381, 7493.400527957641, 7219.9278007221355, 7240.239774823568, 7325.523840950321, 7352.485326027127, 7381.630918454163, 7570.507916985378, 7786.065672119382, 7859.0, 7882.172371900868, 7889.289963903047, 7042.119735033121, 7062.435005199469, 7091.574505529685, 7108.3602475777425, 7126.0, 7053.0, 7160.0, 7215.8556828864175, 7234.96382518084, 7240.782776516713], "unit": "score", "name": "mootools.html", "value": 4820.29876871886}, {"lowerIsBetter": false, "replicates": [298.581985220691, 326.8986614149614, 334.12792611284544, 335.0467918771095, 340.63041599864147, 5932.673702946337, 6293.716782744776, 6655.401013908747, 6698.832529186767, 6740.898886516707, 5971.641701497913, 6075.6937258489415, 6674.933250667492, 6696.330366963313, 6714.96642516788, 4671.439427268732, 4775.450823155329, 4811.927821082687, 4900.950990490085, 4958.206686930101, 4862.07620552094, 4884.389451318585, 4895.55939965403, 4898.485659005806, 4922.360093187898, 4806.567408933195, 4819.975900120512, 4820.180569303209, 4822.938953430257, 4826.155422801014, 4621.1219868224925, 4706.199946009152, 4732.077244937239, 4774.427068751737, 4812.350332705075, 4156.293430116887, 4164.229617520738, 4169.124483858393, 4182.330827067654, 4188.39268306097, 6293.300808781649, 6415.8396040098905, 6420.93579064208, 6445.00102484111, 6445.967770161166, 5812.099124635688, 5832.737526811304, 5833.125031245305, 5834.241548598655, 5858.443447872445, 6808.761693340759, 7047.89428158578, 7077.3984211341585, 7077.610731409771, 7103.680334384913, 4721.598664113554, 4734.479207287196, 4736.502667219961, 4749.358836557055, 4754.572088512016, 7417.925820741778, 7429.257074292582, 7452.552846829208, 7475.327220550176, 7482.176960534337, 4792.2811578262845, 4793.23308270682, 4797.832075877328, 4814.037192561502, 4819.759012049383, 4869.902601947942, 4881.804727810919, 4885.706857588556, 4888.2178851384315, 4896.853094407174, 5606.803761868315, 5809.477147056785, 5814.215080964101, 5824.359320474744, 5828.591998560145, 5772.336181339116, 7126.572405655677, 7136.179339376038, 7147.463940204506, 7168.569885806868, 1662.1606088925016, 1697.618035941928, 1699.7705309783269, 1705.829417058309, 1712.5376148439852, 899.919007289334, 911.366600212859, 1081.1296905990596, 1104.5471356743697, 1108.257467496779, 5849.0, 5999.680070384508, 6364.681765911686, 6608.041833934149, 6661.766838160738, 7426.145993210742, 7453.962730186423, 7455.627218639046, 7461.216572259943, 7476.0, 6620.602763834186, 6622.503312251601, 6625.3374662534325, 6635.87190177671, 6646.0, 3902.590228026073, 3944.4674968878835, 3954.60453954608, 3956.3274243378696, 3961.544422391462, 7395.889061664079, 7780.844383112306, 7786.260305271104, 7817.843643127219, 7822.374210063182, 6168.907466388007, 6306.716197771111, 7634.274743899321, 7670.654820533089, 7689.730859419893, 7770.572618505923, 7775.883361749465, 7783.961080194563, 7802.0, 7817.296443320015, 7456.701731930662, 7458.216887226763, 7481.66332515049, 7488.063992001, 7488.138864030489, 6951.9304806953305, 7266.346028857428, 7307.159676637255, 7319.5242309249725, 7351.338379545867, 7698.653560589675, 7771.33943614799, 7794.766157015299, 7803.0, 7806.609669516388, 3988.561258261647, 4606.309053641847, 4658.324542941323, 4665.343802949904, 4674.11191873543, 7292.671829767779, 7388.224236455309, 7407.333339999426, 7594.430417718803, 7608.467407281437, 6931.202911665021, 7229.09636295463, 7243.710251589878, 7256.020437241116, 7271.672774725044, 7107.573545587281, 7148.9285107150345, 7180.7845764627145, 7192.604406757679, 7234.638268086469, 5755.65466072037, 7081.398081163159, 7086.468514861509, 7091.82270443243, 7100.644967751695, 5832.533397328119, 6992.510524263253, 7217.6752046157, 7222.602756848424, 7235.782926512213, 6159.753609855735, 6666.600003999775, 6694.163229596301, 7053.153621565445, 7082.0], "unit": "score", "name": "prototype.html", "value": 5189.213115422868}, {"lowerIsBetter": false, "replicates": [602.3013304566703, 731.2175971710269, 743.8958545803586, 757.9848403031936, 802.9277365037142, 15093.396264149435, 15130.773038404433, 15318.540443786676, 15321.693566128672, 15325.15711635861, 10054.447005414699, 14110.0, 14348.282585870717, 14365.0, 15032.473863414783, 762.8893810397489, 778.3034184404954, 922.6770630279399, 937.779621788879, 958.4967891856796, 960.1071003966308, 962.4417837654144, 962.7496850818802, 964.6816550538306, 966.6278482784144, 1001.4542074569341, 1002.1982414068752, 1003.19744204636, 1005.5977608956439, 1006.9194464442827, 790.3874497264609, 806.6208881825532, 808.2241048593357, 983.9754006149832, 998.1266391907081, 749.0225256040865, 750.6434443639282, 751.0574229342195, 752.7478294771258, 753.7135888362442, 15035.624109397244, 15062.849371506363, 15104.320305586274, 15137.394504219817, 15169.848301516953, 12234.632961011184, 12388.256704597752, 12392.56626018085, 12478.875211247861, 12649.0, 9736.902630973671, 10030.147437467751, 10278.0, 10667.359958402521, 10875.945620271848, 3531.081918701156, 3552.5381700379044, 3568.1614820517157, 3571.39286321326, 3643.0710168906758, 85703.0, 86391.13608863894, 86627.56686216591, 87081.69377459343, 88062.55968720179, 9032.412893162054, 9173.678921237724, 9205.723828285161, 9207.723768286962, 9735.00864645492, 21134.260300889397, 21144.577108457746, 21158.47103822386, 21183.0, 21183.046762895705, 7273.490855640054, 7376.520526165782, 7387.85224295511, 7432.479726419207, 7506.099268087755, 3797.4873392091713, 4058.350663893822, 4065.2682517146604, 4070.653994410449, 4419.049904270597, 3009.8946536871103, 3562.412201986643, 3594.7483676142942, 3596.5863925648364, 3601.657842504958, 640.794945617398, 648.9026646003043, 651.5341530805402, 666.4002397841884, 666.5933780393956, 486.7152715661378, 536.7262696025056, 602.403620415794, 610.5024405109822, 617.4874853871365, 8046.597670116471, 8174.836503269901, 8241.464304820287, 8296.626651800683, 8310.501369917823, 551.7765305051461, 556.4518948835394, 557.3061538384737, 618.2704408797572, 622.7166639179253, 3806.676432503268, 3853.4818997077173, 3886.417037444406, 3889.9611003890163, 3943.5859234779937, 97510.0, 98793.0, 99955.50022249842, 100006.0, 100549.49725251473, 79005.0, 82516.0, 85803.70355557372, 87185.5640721805, 87659.56170219109, 73961.63019184978, 75171.0, 75961.62019189759, 76214.0, 76372.0, 7125.82185445368, 7619.847603048019, 7640.923590764021, 7734.381249499914, 8038.316743076904, 47194.52805471901, 48923.0, 49055.75472122616, 49210.75394623004, 49734.75132624459, 63618.36381636124, 63677.43449198521, 64962.0, 66059.0, 67678.66160669165, 10715.089217416295, 10721.678349649523, 10795.6221532246, 10881.619143329945, 11123.499442525268, 9252.95373523128, 11871.471691754186, 11900.285982841056, 11953.163278570417, 12286.81569776472, 11327.490262938352, 11428.428578570873, 11508.021818145551, 11664.6500604982, 11994.0, 11281.830772538582, 11366.772664546828, 11370.829437558608, 11625.18623696367, 11959.402029898645, 8765.693200737944, 9968.40189588627, 10547.894521054997, 11114.888851111386, 11217.0, 9259.259259259421, 9490.572924218288, 9569.90430095718, 9665.154782263693, 9917.0, 7910.327622151951, 9441.905580944378, 9575.425474471554, 9647.421154730739, 9694.272929530454], "unit": "score", "name": "yui.html", "value": 6912.658811799932}], "name": "dromaeo_css", "value": 7414.310314600236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 112.0, 110.0, 113.0, 117.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 144.0, 162.0, 119.0, 144.0, 141.0, 120.0, 164.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 185.0, 184.0, 185.0, 187.0, 187.0, 184.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 83.0, 80.0, 56.0, 57.0, 57.0, 78.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 129.0, 79.0, 84.0, 85.0, 116.0, 80.0, 80.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 95.9}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 85.0, 88.0, 85.0, 90.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 93.0, 94.0, 92.0, 92.0, 93.0, 94.0, 94.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 98.0, 117.0, 124.0, 137.0, 85.0, 81.0, 88.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 98.7}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 53.0, 51.0, 52.0, 53.0, 52.0, 65.0, 55.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 64.0, 79.0, 71.0, 72.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 84.0, 84.0, 81.0, 81.0, 81.0, 111.0, 110.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.9}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 124.0, 134.0, 138.0, 135.0, 130.0, 122.0, 118.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [138.0, 132.0, 140.0, 138.0, 139.0, 131.0, 144.0, 129.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 94.0, 97.0, 96.0, 75.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.8}], "name": "kraken", "value": 1434.9}]} 18:25:20 INFO - Return code: 0 18:25:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:25:20 ERROR - # TBPL SUCCESS # 18:25:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:25:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:25:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:25:20 INFO - 2016-03-29 18:25:20.338 screenresolution[2233:16887] starting screenresolution argv=screenresolution get 18:25:20 INFO - 2016-03-29 18:25:20.340 screenresolution[2233:16887] Display 0: 1600x1200x32@60 18:25:20 INFO - 2016-03-29 18:25:20.346 screenresolution[2234:16890] starting screenresolution argv=screenresolution list 18:25:20 INFO - Available Modes on Display 0 18:25:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:25:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:25:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:25:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:25:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:25:20 INFO - Intel Iris: 18:25:20 INFO - Chipset Model: Intel Iris 18:25:20 INFO - Type: GPU 18:25:20 INFO - Bus: Built-In 18:25:20 INFO - VRAM (Dynamic, Max): 1536 MB 18:25:20 INFO - Vendor: Intel (0x8086) 18:25:20 INFO - Device ID: 0x0a2e 18:25:20 INFO - Revision ID: 0x0009 18:25:20 INFO - Displays: 18:25:20 INFO - Display: 18:25:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:25:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:25:20 INFO - Display Serial Number: 1600x1200 60 18:25:20 INFO - Main Display: Yes 18:25:20 INFO - Mirror: Off 18:25:20 INFO - Online: Yes 18:25:20 INFO - Rotation: Supported 18:25:20 INFO - Return code: 0 18:25:20 INFO - Running post-action listener: _resource_record_post_action 18:25:20 INFO - Running post-run listener: _resource_record_post_run 18:25:21 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2293760; Write bytes: 702696448; Read time: 33; Write time: 2065 18:25:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403048960; Write bytes: 404571136; Read time: 30238; Write time: 853 18:25:21 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2293760; Write bytes: 297277440; Read time: 33; Write time: 1209 18:25:21 INFO - Running post-run listener: _upload_blobber_files 18:25:21 INFO - Blob upload gear active. 18:25:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:21 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:25:21 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:25:21 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:25:22 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:25:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:25:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:23 INFO - (blobuploader) - INFO - Done attempting. 18:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:24 INFO - (blobuploader) - INFO - Done attempting. 18:25:24 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:24 INFO - Return code: 0 18:25:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/087ab18b097d8cea4c1d5e3d30e6a55b0fcc3c38406666d8ec2f2f9de14b4054b444f9be80c3bef633eececaad53290d08bc99301b29646692eee34a130c94a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fbeceb797027227195ff286281b18c47f3652aef3dc9615ba60f771c5f98e98e824e89368280673d0003967d1806607162b485ad687a411326afb7a766e1da7"} 18:25:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:24 INFO - Contents: 18:25:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/087ab18b097d8cea4c1d5e3d30e6a55b0fcc3c38406666d8ec2f2f9de14b4054b444f9be80c3bef633eececaad53290d08bc99301b29646692eee34a130c94a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fbeceb797027227195ff286281b18c47f3652aef3dc9615ba60f771c5f98e98e824e89368280673d0003967d1806607162b485ad687a411326afb7a766e1da7"} 18:25:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:24 INFO - Copying logs to upload dir... 18:25:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.751021 ========= master_lag: 7.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-29 18:25:31.334909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-29 18:25:31.336139) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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/087ab18b097d8cea4c1d5e3d30e6a55b0fcc3c38406666d8ec2f2f9de14b4054b444f9be80c3bef633eececaad53290d08bc99301b29646692eee34a130c94a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fbeceb797027227195ff286281b18c47f3652aef3dc9615ba60f771c5f98e98e824e89368280673d0003967d1806607162b485ad687a411326afb7a766e1da7"} build_url:https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/E70InFX6Q1izbpt5DFSrJg/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/087ab18b097d8cea4c1d5e3d30e6a55b0fcc3c38406666d8ec2f2f9de14b4054b444f9be80c3bef633eececaad53290d08bc99301b29646692eee34a130c94a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fbeceb797027227195ff286281b18c47f3652aef3dc9615ba60f771c5f98e98e824e89368280673d0003967d1806607162b485ad687a411326afb7a766e1da7"}' ========= master_lag: 1.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-29 18:25:32.795161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-29 18:25:32.795495) ========= 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.qE5LRBlyFR/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.yCQXNnf0LN/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005273 ========= master_lag: 9.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-29 18:25:41.970993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 18:25:41.971363) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 18:25:42.041117) ========= ========= Total master_lag: 17.87 =========