builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1459343410.5 results: success (0) buildid: 20160330040937 builduid: 96fa7cf3d24f403faf24d573f63e7bc0 revision: 48d54c93dcf3c14dff0788b85703341b45e510a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.503321) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.503763) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.504060) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005936 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.531488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.531761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.548712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.549004) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005461 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.597789) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.598129) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.598478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.598754) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-30 06:10:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-03-30 06:10:10 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.724426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.724752) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.020429 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:10.774058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 06:10:10.774405) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48d54c93dcf3c14dff0788b85703341b45e510a9 --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 48d54c93dcf3c14dff0788b85703341b45e510a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-30 06:10:10,864 truncating revision to first 12 chars 2016-03-30 06:10:10,864 Setting DEBUG logging. 2016-03-30 06:10:10,864 attempt 1/10 2016-03-30 06:10:10,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48d54c93dcf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 06:10:11,937 unpacking tar archive at: fx-team-48d54c93dcf3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321515 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 06:10:12.136438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:12.136781) ========= echo 48d54c93dcf3c14dff0788b85703341b45e510a9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'48d54c93dcf3c14dff0788b85703341b45e510a9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 48d54c93dcf3c14dff0788b85703341b45e510a9 program finished with exit code 0 elapsedTime=0.005217 script_repo_revision: '48d54c93dcf3c14dff0788b85703341b45e510a9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:12.187013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:12.187348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 06:10:12.202443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-30 06:10:12.202710) ========= /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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:12 INFO - MultiFileLogger online at 20160330 06:10:12 in /builds/slave/test 06:10:12 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 06:10:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:10:12 INFO - {'append_to_log': False, 06:10:12 INFO - 'base_work_dir': '/builds/slave/test', 06:10:12 INFO - 'blob_upload_branch': 'Fx-Team', 06:10:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:10:12 INFO - 'branch': 'Fx-Team', 06:10:12 INFO - 'buildbot_json_path': 'buildprops.json', 06:10:12 INFO - 'config_files': ('talos/mac_config.py',), 06:10:12 INFO - 'default_actions': ('clobber', 06:10:12 INFO - 'read-buildbot-config', 06:10:12 INFO - 'download-and-extract', 06:10:12 INFO - 'populate-webroot', 06:10:12 INFO - 'create-virtualenv', 06:10:12 INFO - 'install', 06:10:12 INFO - 'run-tests'), 06:10:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:10:12 INFO - 'download_minidump_stackwalk': True, 06:10:12 INFO - 'download_symbols': 'ondemand', 06:10:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:10:12 INFO - 'tooltool.py': '/tools/tooltool.py', 06:10:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:10:12 INFO - '/tools/misc-python/virtualenv.py')}, 06:10:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:10:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:10:12 INFO - 'installer_path': 'installer.exe', 06:10:12 INFO - 'log_level': 'info', 06:10:12 INFO - 'log_name': 'talos', 06:10:12 INFO - 'log_to_console': True, 06:10:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:10:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:10:12 INFO - 'opt_config_files': (), 06:10:12 INFO - 'pip_index': False, 06:10:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:12 INFO - 'cmd': ('bash', 06:10:12 INFO - '-c', 06:10:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:12 INFO - 'enabled': True, 06:10:12 INFO - 'halt_on_failure': False, 06:10:12 INFO - 'name': 'check_screen_resolution'},), 06:10:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:12 INFO - 'cmd': ('bash', 06:10:12 INFO - '-c', 06:10:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:12 INFO - 'enabled': True, 06:10:12 INFO - 'halt_on_failure': False, 06:10:12 INFO - 'name': 'check_screen_resolution'},), 06:10:12 INFO - 'run_cmd_checks_enabled': True, 06:10:12 INFO - 'sps_profile': False, 06:10:12 INFO - 'sps_profile_interval': 0, 06:10:12 INFO - 'suite': 'dromaeojs', 06:10:12 INFO - 'system_bits': '32', 06:10:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:10:12 INFO - 'title': 't-yosemite-r7-0143', 06:10:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:10:12 INFO - 'use_talos_json': True, 06:10:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:10:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:10:12 INFO - 'work_dir': 'build'} 06:10:12 INFO - ##### 06:10:12 INFO - ##### Running clobber step. 06:10:12 INFO - ##### 06:10:12 INFO - Running pre-action listener: _resource_record_pre_action 06:10:12 INFO - Running main action method: clobber 06:10:12 INFO - rmtree: /builds/slave/test/build 06:10:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:10:14 INFO - Running post-action listener: _resource_record_post_action 06:10:14 INFO - ##### 06:10:14 INFO - ##### Running read-buildbot-config step. 06:10:14 INFO - ##### 06:10:14 INFO - Running pre-action listener: _resource_record_pre_action 06:10:14 INFO - Running main action method: read_buildbot_config 06:10:14 INFO - Using buildbot properties: 06:10:14 INFO - { 06:10:14 INFO - "project": "", 06:10:14 INFO - "product": "firefox", 06:10:14 INFO - "script_repo_revision": "production", 06:10:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:10:14 INFO - "repository": "", 06:10:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:10:14 INFO - "buildid": "20160330040937", 06:10:14 INFO - "pgo_build": "False", 06:10:14 INFO - "basedir": "/builds/slave/test", 06:10:14 INFO - "buildnumber": 582, 06:10:14 INFO - "slavename": "t-yosemite-r7-0143", 06:10:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:10:14 INFO - "platform": "yosemite_r7", 06:10:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:10:14 INFO - "branch": "fx-team", 06:10:14 INFO - "repo_path": "integration/fx-team", 06:10:14 INFO - "revision": "48d54c93dcf3c14dff0788b85703341b45e510a9", 06:10:14 INFO - "stage_platform": "macosx64", 06:10:14 INFO - "builduid": "96fa7cf3d24f403faf24d573f63e7bc0", 06:10:14 INFO - "slavebuilddir": "test" 06:10:14 INFO - } 06:10:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:10:14 INFO - Running post-action listener: _resource_record_post_action 06:10:14 INFO - ##### 06:10:14 INFO - ##### Running download-and-extract step. 06:10:14 INFO - ##### 06:10:14 INFO - Running pre-action listener: _resource_record_pre_action 06:10:14 INFO - Running main action method: download_and_extract 06:10:14 INFO - mkdir: /builds/slave/test/build/tests 06:10:14 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')]} 06:10:14 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:15 INFO - Downloaded 1199 bytes. 06:10:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:10:15 INFO - Using the following test package requirements: 06:10:15 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:10:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:10:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:10:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'jsshell-mac.zip'], 06:10:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:10:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:10:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:10:15 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:10:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:10:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:10:15 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:10:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:10:15 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')]} 06:10:15 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:16 INFO - Downloaded 17946676 bytes. 06:10:16 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'] 06:10:16 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 06:10:19 INFO - Return code: 0 06:10:19 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 06:10:19 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')]} 06:10:19 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:21 INFO - Downloaded 17946676 bytes. 06:10:21 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'] 06:10:21 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 06:10:24 INFO - Return code: 0 06:10: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')]} 06:10:24 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:25 INFO - Downloaded 10847531 bytes. 06:10:25 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'] 06:10:25 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 06:10:26 INFO - Return code: 0 06:10:26 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')]} 06:10:26 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:10:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 06:10:30 INFO - Downloaded 111429329 bytes. 06:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:30 INFO - mkdir: /builds/slave/test/properties 06:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:30 INFO - Contents: 06:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:31 INFO - Running post-action listener: _resource_record_post_action 06:10:31 INFO - Running post-action listener: set_extra_try_arguments 06:10:31 INFO - ##### 06:10:31 INFO - ##### Running populate-webroot step. 06:10:31 INFO - ##### 06:10:31 INFO - Running pre-action listener: _resource_record_pre_action 06:10:31 INFO - Running main action method: populate_webroot 06:10:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:31 INFO - '--tppagecycles', 06:10:31 INFO - '7'], 06:10:31 INFO - 'tests': ['tsvgm']}}, 06:10:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:10:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:10:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'tests': ['damp', 'tps']}, 06:10:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['damp', 'tps']}, 06:10:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:10:31 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['dromaeo_dom']}, 06:10:31 INFO - 'other': {'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'other_l64': {'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'other_nol64': {'tests': ['a11yr', 06:10:31 INFO - 'ts_paint', 06:10:31 INFO - 'tpaint', 06:10:31 INFO - 'sessionrestore', 06:10:31 INFO - 'sessionrestore_no_auto_restore', 06:10:31 INFO - 'tabpaint']}, 06:10:31 INFO - 'svgr': {'tests': ['tsvgx', 06:10:31 INFO - 'tsvgr_opacity', 06:10:31 INFO - 'tart', 06:10:31 INFO - 'tscrollx', 06:10:31 INFO - 'cart']}, 06:10:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['tsvgx', 06:10:31 INFO - 'tsvgr_opacity', 06:10:31 INFO - 'tart', 06:10:31 INFO - 'tscrollx', 06:10:31 INFO - 'cart']}, 06:10:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'tests': ['tp5o']}, 06:10:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'talos_options': ['--e10s'], 06:10:31 INFO - 'tests': ['tp5o']}, 06:10:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'talos_options': ['--xperf_path', 06:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:31 INFO - 'tests': ['tp5n']}, 06:10:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:31 INFO - 'talos_options': ['--e10s', 06:10:31 INFO - '--xperf_path', 06:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:31 INFO - 'tests': ['tp5n']}}, 06:10:31 INFO - 'talos.zip': {'path': '', 06:10:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:31 INFO - Running post-action listener: _resource_record_post_action 06:10:31 INFO - ##### 06:10:31 INFO - ##### Running create-virtualenv step. 06:10:31 INFO - ##### 06:10:31 INFO - Running pre-action listener: _resource_record_pre_action 06:10:31 INFO - Running main action method: create_virtualenv 06:10:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:31 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 06:10:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:32 INFO - Using real prefix '/tools/python27' 06:10:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:32 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:35 INFO - Installing pip.................done. 06:10:35 INFO - Return code: 0 06:10:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:35 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 06:10:35 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 06:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:35 INFO - 'HOME': '/Users/cltbld', 06:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:35 INFO - 'LOGNAME': 'cltbld', 06:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:35 INFO - 'MOZ_NO_REMOTE': '1', 06:10:35 INFO - 'NO_EM_RESTART': '1', 06:10:35 INFO - 'PAGER': '/bin/cat', 06:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:35 INFO - 'PWD': '/builds/slave/test', 06:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:35 INFO - 'SHELL': '/bin/bash', 06:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:35 INFO - 'USER': 'cltbld', 06:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:35 INFO - 'XPC_FLAGS': '0x0', 06:10:35 INFO - 'XPC_SERVICE_NAME': '0', 06:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:35 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 06:10:35 INFO - Cleaning up... 06:10:35 INFO - Return code: 0 06:10:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:35 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 06:10:35 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 06:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:35 INFO - 'HOME': '/Users/cltbld', 06:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:35 INFO - 'LOGNAME': 'cltbld', 06:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:35 INFO - 'MOZ_NO_REMOTE': '1', 06:10:35 INFO - 'NO_EM_RESTART': '1', 06:10:35 INFO - 'PAGER': '/bin/cat', 06:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:35 INFO - 'PWD': '/builds/slave/test', 06:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:35 INFO - 'SHELL': '/bin/bash', 06:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:35 INFO - 'USER': 'cltbld', 06:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:35 INFO - 'XPC_FLAGS': '0x0', 06:10:35 INFO - 'XPC_SERVICE_NAME': '0', 06:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:36 INFO - Downloading/unpacking psutil>=0.7.1 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:39 INFO - Installing collected packages: psutil 06:10:39 INFO - Running setup.py install for psutil 06:10:39 INFO - building 'psutil._psutil_osx' extension 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 INFO - building 'psutil._psutil_posix' extension 06:10:39 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 06:10:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:10:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:10:39 INFO - ^ 06:10:39 INFO - 1 warning generated. 06:10:39 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 06:10:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:39 INFO - Successfully installed psutil 06:10:39 INFO - Cleaning up... 06:10:39 INFO - Return code: 0 06:10:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:39 INFO - 'HOME': '/Users/cltbld', 06:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:39 INFO - 'LOGNAME': 'cltbld', 06:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:39 INFO - 'MOZ_NO_REMOTE': '1', 06:10:39 INFO - 'NO_EM_RESTART': '1', 06:10:39 INFO - 'PAGER': '/bin/cat', 06:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:39 INFO - 'PWD': '/builds/slave/test', 06:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:39 INFO - 'SHELL': '/bin/bash', 06:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:39 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:39 INFO - 'USER': 'cltbld', 06:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:39 INFO - 'XPC_FLAGS': '0x0', 06:10:39 INFO - 'XPC_SERVICE_NAME': '0', 06:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:10:40 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 06:10:40 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 06:10:40 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 06:10:40 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 06:10:40 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 06:10:40 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 06:10:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:10:42 INFO - Installing collected packages: mozsystemmonitor 06:10:42 INFO - Running setup.py install for mozsystemmonitor 06:10:42 INFO - Successfully installed mozsystemmonitor 06:10:42 INFO - Cleaning up... 06:10:42 INFO - Return code: 0 06:10:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:42 INFO - 'HOME': '/Users/cltbld', 06:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:42 INFO - 'LOGNAME': 'cltbld', 06:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:42 INFO - 'MOZ_NO_REMOTE': '1', 06:10:42 INFO - 'NO_EM_RESTART': '1', 06:10:42 INFO - 'PAGER': '/bin/cat', 06:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:42 INFO - 'PWD': '/builds/slave/test', 06:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:42 INFO - 'SHELL': '/bin/bash', 06:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:42 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:42 INFO - 'USER': 'cltbld', 06:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:42 INFO - 'XPC_FLAGS': '0x0', 06:10:42 INFO - 'XPC_SERVICE_NAME': '0', 06:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:46 INFO - Downloading docopt-0.6.1.tar.gz 06:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:46 INFO - Running setup.py install for blobuploader 06:10:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:46 INFO - Running setup.py install for requests 06:10:47 INFO - Running setup.py install for docopt 06:10:47 INFO - Successfully installed blobuploader requests docopt 06:10:47 INFO - Cleaning up... 06:10:47 INFO - Return code: 0 06:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:47 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:47 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 06:10:47 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 06:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:47 INFO - 'HOME': '/Users/cltbld', 06:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:47 INFO - 'LOGNAME': 'cltbld', 06:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:47 INFO - 'MOZ_NO_REMOTE': '1', 06:10:47 INFO - 'NO_EM_RESTART': '1', 06:10:47 INFO - 'PAGER': '/bin/cat', 06:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:47 INFO - 'PWD': '/builds/slave/test', 06:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:47 INFO - 'SHELL': '/bin/bash', 06:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:47 INFO - 'USER': 'cltbld', 06:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:47 INFO - 'XPC_FLAGS': '0x0', 06:10:47 INFO - 'XPC_SERVICE_NAME': '0', 06:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:47 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-jDJvpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ADEVem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Pfncp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-vPMvj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AYcleR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-taAhLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-vg6lQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aARaje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kiuvzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NjrSyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:48 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-quH3XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-QvkfdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-oaLhMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-b6UpIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1NIFDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YveNlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:49 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-BMJauy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:49 INFO - Running setup.py install for manifestparser 06:10:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:49 INFO - Running setup.py install for mozcrash 06:10:50 INFO - Running setup.py install for mozdebug 06:10:50 INFO - Running setup.py install for mozdevice 06:10:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Running setup.py install for mozfile 06:10:50 INFO - Running setup.py install for mozhttpd 06:10:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Running setup.py install for mozinfo 06:10:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Running setup.py install for mozInstall 06:10:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:50 INFO - Running setup.py install for mozleak 06:10:51 INFO - Running setup.py install for mozlog 06:10:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Running setup.py install for moznetwork 06:10:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Running setup.py install for mozprocess 06:10:51 INFO - Running setup.py install for mozprofile 06:10:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Running setup.py install for mozrunner 06:10:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:51 INFO - Running setup.py install for mozscreenshot 06:10:51 INFO - Running setup.py install for moztest 06:10:52 INFO - Running setup.py install for mozversion 06:10:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:52 INFO - Cleaning up... 06:10:52 INFO - Return code: 0 06:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:52 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:52 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 06:10:52 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 06:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:52 INFO - 'HOME': '/Users/cltbld', 06:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:52 INFO - 'LOGNAME': 'cltbld', 06:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:52 INFO - 'MOZ_NO_REMOTE': '1', 06:10:52 INFO - 'NO_EM_RESTART': '1', 06:10:52 INFO - 'PAGER': '/bin/cat', 06:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:52 INFO - 'PWD': '/builds/slave/test', 06:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:52 INFO - 'SHELL': '/bin/bash', 06:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:52 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:52 INFO - 'USER': 'cltbld', 06:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:52 INFO - 'XPC_FLAGS': '0x0', 06:10:52 INFO - 'XPC_SERVICE_NAME': '0', 06:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gCK7Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:52 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)) 06:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-isl4MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:52 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)) 06:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-C9CvIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:52 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)) 06:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-d2DVbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-7vTlvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Ok9qjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-fhmPIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-qjvw2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-UhNcD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4VkVQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-VsIEzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-e1gTiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-WmQe53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:53 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)) 06:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-dBcLJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:54 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)) 06:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-qOJk_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:54 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)) 06:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Qu_7K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:54 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)) 06:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-qZ6jxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:54 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)) 06:10:54 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)) 06:10:54 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)) 06:10:54 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)) 06:10:54 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)) 06:10:54 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)) 06:10:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:56 INFO - Downloading blessings-1.6.tar.gz 06:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:56 INFO - Installing collected packages: blessings 06:10:56 INFO - Running setup.py install for blessings 06:10:57 INFO - Successfully installed blessings 06:10:57 INFO - Cleaning up... 06:10:57 INFO - Return code: 0 06:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:57 INFO - Reading from file tmpfile_stdout 06:10:57 INFO - Current package versions: 06:10:57 INFO - blessings == 1.6 06:10:57 INFO - blobuploader == 1.2.4 06:10:57 INFO - docopt == 0.6.1 06:10:57 INFO - manifestparser == 1.1 06:10:57 INFO - mozInstall == 1.12 06:10:57 INFO - mozcrash == 0.17 06:10:57 INFO - mozdebug == 0.1 06:10:57 INFO - mozdevice == 0.48 06:10:57 INFO - mozfile == 1.2 06:10:57 INFO - mozhttpd == 0.7 06:10:57 INFO - mozinfo == 0.9 06:10:57 INFO - mozleak == 0.1 06:10:57 INFO - mozlog == 3.1 06:10:57 INFO - moznetwork == 0.27 06:10:57 INFO - mozprocess == 0.22 06:10:57 INFO - mozprofile == 0.28 06:10:57 INFO - mozrunner == 6.11 06:10:57 INFO - mozscreenshot == 0.1 06:10:57 INFO - mozsystemmonitor == 0.0 06:10:57 INFO - moztest == 0.7 06:10:57 INFO - mozversion == 1.4 06:10:57 INFO - psutil == 3.1.1 06:10:57 INFO - requests == 1.2.3 06:10:57 INFO - wsgiref == 0.1.2 06:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:57 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')]} 06:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:57 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')]} 06:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:57 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:57 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 06:10:57 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 06:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:57 INFO - 'HOME': '/Users/cltbld', 06:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:57 INFO - 'LOGNAME': 'cltbld', 06:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:57 INFO - 'MOZ_NO_REMOTE': '1', 06:10:57 INFO - 'NO_EM_RESTART': '1', 06:10:57 INFO - 'PAGER': '/bin/cat', 06:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:57 INFO - 'PWD': '/builds/slave/test', 06:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:57 INFO - 'SHELL': '/bin/bash', 06:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:57 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:57 INFO - 'USER': 'cltbld', 06:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:57 INFO - 'XPC_FLAGS': '0x0', 06:10:57 INFO - 'XPC_SERVICE_NAME': '0', 06:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 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)) 06:10:57 INFO - Cleaning up... 06:10:57 INFO - Return code: 0 06:10:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:57 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')]} 06:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:57 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')]} 06:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:57 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:10:57 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 06:10:57 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 06:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:57 INFO - 'HOME': '/Users/cltbld', 06:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:57 INFO - 'LOGNAME': 'cltbld', 06:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:57 INFO - 'MOZ_NO_REMOTE': '1', 06:10:57 INFO - 'NO_EM_RESTART': '1', 06:10:57 INFO - 'PAGER': '/bin/cat', 06:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:57 INFO - 'PWD': '/builds/slave/test', 06:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:57 INFO - 'SHELL': '/bin/bash', 06:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:10:57 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:57 INFO - 'USER': 'cltbld', 06:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:57 INFO - 'XPC_FLAGS': '0x0', 06:10:57 INFO - 'XPC_SERVICE_NAME': '0', 06:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:57 INFO - Downloading/unpacking jsonschema 06:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:00 INFO - warning: no files found matching '*.txt' 06:11:00 INFO - no previously-included directories found matching 'build' 06:11:00 INFO - no previously-included directories found matching 'dist' 06:11:00 INFO - no previously-included directories found matching '.git*' 06:11:00 INFO - Installing collected packages: jsonschema, functools32 06:11:00 INFO - Running setup.py install for functools32 06:11:00 INFO - warning: no files found matching '*.txt' 06:11:00 INFO - no previously-included directories found matching 'build' 06:11:00 INFO - no previously-included directories found matching 'dist' 06:11:00 INFO - no previously-included directories found matching '.git*' 06:11:01 INFO - Successfully installed jsonschema functools32 06:11:01 INFO - Cleaning up... 06:11:01 INFO - Return code: 0 06:11:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:11:01 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')]} 06:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:01 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')]} 06:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:01 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 0x103101a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc40577790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, '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.eijT9YzCtI/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.kzRMA9lcFP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:11:01 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 06:11:01 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 06:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:01 INFO - 'HOME': '/Users/cltbld', 06:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:01 INFO - 'LOGNAME': 'cltbld', 06:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:01 INFO - 'MOZ_NO_REMOTE': '1', 06:11:01 INFO - 'NO_EM_RESTART': '1', 06:11:01 INFO - 'PAGER': '/bin/cat', 06:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:01 INFO - 'PWD': '/builds/slave/test', 06:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:01 INFO - 'SHELL': '/bin/bash', 06:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:11:01 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:01 INFO - 'USER': 'cltbld', 06:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:01 INFO - 'XPC_FLAGS': '0x0', 06:11:01 INFO - 'XPC_SERVICE_NAME': '0', 06:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:01 INFO - Downloading/unpacking flake8 06:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:11:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:03 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 06:11:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:11:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:11:04 INFO - no previously-included directories found matching 'docs/_build' 06:11:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:11:05 INFO - Running setup.py install for pep8 06:11:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:11:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:11:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:11:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:11:05 INFO - no previously-included directories found matching 'docs/_build' 06:11:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:11:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:11:05 INFO - Cleaning up... 06:11:05 INFO - Return code: 0 06:11:05 INFO - Running post-action listener: _resource_record_post_action 06:11:05 INFO - Running post-action listener: _start_resource_monitoring 06:11:05 INFO - Starting resource monitoring. 06:11:05 INFO - ##### 06:11:05 INFO - ##### Running install step. 06:11:05 INFO - ##### 06:11:05 INFO - Running pre-action listener: _resource_record_pre_action 06:11:05 INFO - Running main action method: install 06:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:05 INFO - Reading from file tmpfile_stdout 06:11:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:11:05 INFO - Reading from file tmpfile_stdout 06:11:05 INFO - Output received: 06:11:05 INFO - Usage: mozinstall [options] installer 06:11:05 INFO - Options: 06:11:05 INFO - -h, --help show this help message and exit 06:11:05 INFO - -d DEST, --destination=DEST 06:11:05 INFO - Directory to install application into. [default: 06:11:05 INFO - "/builds/slave/test"] 06:11:05 INFO - --app=APP Application being installed. [default: firefox] 06:11:05 INFO - mkdir: /builds/slave/test/build/application 06:11:05 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'] 06:11:05 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 06:11:39 INFO - Reading from file tmpfile_stdout 06:11:39 INFO - Output received: 06:11:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:11:39 INFO - Running post-action listener: _resource_record_post_action 06:11:39 INFO - ##### 06:11:39 INFO - ##### Running run-tests step. 06:11:39 INFO - ##### 06:11:39 INFO - Running pre-action listener: _resource_record_pre_action 06:11:39 INFO - Running main action method: run_tests 06:11:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:11:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:11:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:11:39 INFO - 2016-03-30 06:11:39.773 screenresolution[2603:36606] starting screenresolution argv=screenresolution get 06:11:39 INFO - 2016-03-30 06:11:39.775 screenresolution[2603:36606] Display 0: 1600x1200x32@60 06:11:39 INFO - 2016-03-30 06:11:39.782 screenresolution[2604:36608] starting screenresolution argv=screenresolution list 06:11:39 INFO - Available Modes on Display 0 06:11:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:11:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:11:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:11:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:11:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:11:40 INFO - Intel Iris: 06:11:40 INFO - Chipset Model: Intel Iris 06:11:40 INFO - Type: GPU 06:11:40 INFO - Bus: Built-In 06:11:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:11:40 INFO - Vendor: Intel (0x8086) 06:11:40 INFO - Device ID: 0x0a2e 06:11:40 INFO - Revision ID: 0x0009 06:11:40 INFO - Displays: 06:11:40 INFO - Display: 06:11:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:11:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:11:40 INFO - Display Serial Number: 1600x1200 60 06:11:40 INFO - Main Display: Yes 06:11:40 INFO - Mirror: Off 06:11:40 INFO - Online: Yes 06:11:40 INFO - Rotation: Supported 06:11:40 INFO - Return code: 0 06:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:11:40 INFO - Python 2.7.3 06:11:40 INFO - Return code: 0 06:11:40 INFO - grabbing minidump binary from tooltool 06:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:40 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 0x102fa0e00>, '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 0x102dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f9bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:11:40 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 06:11:40 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 06:11:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:11:40 INFO - Return code: 0 06:11:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:11:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:11:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:11:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:11:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:11:41 INFO - Return code: 0 06:11:41 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/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 06:11:41 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/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 06:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eijT9YzCtI/Render', 06:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:41 INFO - 'HOME': '/Users/cltbld', 06:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:41 INFO - 'LOGNAME': 'cltbld', 06:11:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:41 INFO - 'MOZ_NO_REMOTE': '1', 06:11:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:41 INFO - 'NO_EM_RESTART': '1', 06:11:41 INFO - 'PAGER': '/bin/cat', 06:11:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:41 INFO - 'PWD': '/builds/slave/test', 06:11:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:41 INFO - 'SHELL': '/bin/bash', 06:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kzRMA9lcFP/Listeners', 06:11:41 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:41 INFO - 'USER': 'cltbld', 06:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:41 INFO - 'XPC_FLAGS': '0x0', 06:11:41 INFO - 'XPC_SERVICE_NAME': '0', 06:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:41 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/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 06:11:41 INFO - mozversion application_buildid: 20160330040937 06:11:41 INFO - mozversion application_changeset: 48d54c93dcf3c14dff0788b85703341b45e510a9 06:11:41 INFO - mozversion application_display_name: Nightly 06:11:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:11:41 INFO - mozversion application_name: Firefox 06:11:41 INFO - mozversion application_remotingname: firefox 06:11:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:11:41 INFO - mozversion application_vendor: Mozilla 06:11:41 INFO - mozversion application_version: 48.0a1 06:11:41 INFO - mozversion platform_buildid: 20160330040937 06:11:41 INFO - mozversion platform_changeset: 48d54c93dcf3c14dff0788b85703341b45e510a9 06:11:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:11:41 INFO - mozversion platform_version: 48.0a1 06:11:41 INFO - using testdate: 1459343501 06:11:41 INFO - actual date: 1459343501 06:11:41 INFO - starting webserver on 'localhost:52434' 06:11:41 INFO - SUITE-START | Running 2 tests 06:11:41 INFO - TEST-START | dromaeo_css 06:11:41 INFO - operating with platform_type : mac_ 06:11:41 INFO - Initialising browser for dromaeo_css test... 06:11:41 INFO - TEST-INFO | started process 2622 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmprokLur/profile http://localhost:52434/getInfo.html) 06:11:43 INFO - PROCESS | 2622 | __metrics Screen width/height:1600/1200 06:11:43 INFO - PROCESS | 2622 | colorDepth:24 06:11:43 INFO - PROCESS | 2622 | Browser inner width/height: 1024/689 06:11:43 INFO - PROCESS | 2622 | __metrics 06:11:43 INFO - PROCESS | 2622 | 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" 06:11:43 ERROR - PROCESS | 2622 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:11:44 INFO - TEST-INFO | 2622: exit 0 06:11:44 INFO - Browser initialized. 06:11:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:44 INFO - TEST-INFO | started process 2625 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmprokLur/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:56 INFO - PROCESS | 2625 | RSS: Main: 244244480 06:11:56 INFO - PROCESS | 2625 | 06:12:47 INFO - PROCESS | 2625 | 1459343567345 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] 06:14:58 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52434/tests/dromaeo/cssquery-ext.html) 06:14:59 INFO - PROCESS | 2625 | RSS: Main: 336089088 06:14:59 INFO - PROCESS | 2625 | 06:18:02 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-ext.html (next: http://localhost:52434/tests/dromaeo/cssquery-jquery.html) 06:18:02 INFO - PROCESS | 2625 | RSS: Main: 374554624 06:18:02 INFO - PROCESS | 2625 | 06:21:04 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52434/tests/dromaeo/cssquery-mootools.html) 06:21:05 INFO - PROCESS | 2625 | RSS: Main: 376590336 06:21:05 INFO - PROCESS | 2625 | 06:24:07 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52434/tests/dromaeo/cssquery-prototype.html) 06:24:07 INFO - PROCESS | 2625 | RSS: Main: 333930496 06:24:07 INFO - PROCESS | 2625 | 06:27:10 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52434/tests/dromaeo/cssquery-yui.html) 06:27:11 INFO - PROCESS | 2625 | RSS: Main: 334921728 06:27:11 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | Cycle 1(1): loaded http://localhost:52434/tests/dromaeo/cssquery-yui.html (next: http://localhost:52434/tests/dromaeo/cssquery-dojo.html) 06:30:14 INFO - PROCESS | 2625 | RSS: Main: 383279104 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | __start_tp_report 06:30:14 INFO - PROCESS | 2625 | _x_x_mozilla_page_load 06:30:14 INFO - PROCESS | 2625 | _x_x_mozilla_page_load_details 06:30:14 INFO - PROCESS | 2625 | |i|pagename|runs| 06:30:14 INFO - PROCESS | 2625 | |0;dojo.html;2842.7441530262277;3324.0194142727896;3427.108951672564;3465.2549701814105;3500.947485787712;4645.3960985071935;5521.751521181546;5608.2428872102255;5609.242752228448;5656.57575681824;5662.094064949609;5668.348139963905;5791.652500849952;5799.681017544033;5844.064949608063;4179.787861520171;5033.421156566987;5048.318477005603;5086.567641750456;5241.344831896013;5164.793408263665;5171.663841850286;5198.428172900978;5218.373795144588;5232.189010703347;4769.904601907977;5005.199168133117;5081.74591270435;5134;5144.356955380577;5113.693178409308;5118.948810511922;5121.334226550524;5130.615203859726;5142.742862856842;5069.898602027975;5089.44016158226;5092.134337162654;5111.028904508132;5122.615803814729;5470.781168753245;5586.162075688639;5594.160875868612;5680.11958146488;5682.54539636828;6192.071189321638;6192.473639740628;6196.256449226076;6197.845053873644;6199.659018753967;6210.7826226082325;6281.623102613858;6282.277538083134;6287.182666253358;6304.936950630481;5639.520640745542;5748.913766293551;5762.481376676077;5782.971085144632;5853.473187413153;6253.249610046823;6256.343083976117;6262.436380725665;6279.309275979638;6286.245650521875;6051.394860513913;6102.603330783485;6114.847128821815;6130.724117414727;6131.724072416752;6078.270607527125;6111.834843226297;6145.569810113249;6155.692215389213;6174.475169610633;6112.680125321883;6126.4694000708;6145.661988590581;6149.84625384369;6151.108089327112;6149.8155055347515;6150.7232174552255;6152.077188421773;6154.78458253959;6163.8150855474405;4806.543378379049;4823.397075365579;4856.611471082305;4867.63492738039;4881.755912204447;4373.584509471595;4456.5766252205985;4475.597196252353;4476.1495315890525;4479.081788233404;4840.903181936342;5582.162675598612;5615.017371959891;5617.466340697627;5647.068233741469;6148.569600127948;6208.596441231305;6232.065190221503;6240.7503699852405;6246.406591373812;5654.943450565524;5657.971710141423;5669.461401166883;5680.517156041783;5690.374058853523;5163.948360516347;5232.633715639945;5240.868978275574;5266.631335806457;5346;6232.75068997235;6240.687965601611;6254.186955695731;6256.749730010749;6280.0893870389455;6198.876022479435;6207.782727604512;6210.5031597473;6211.099390588249;6225.28409232944;6161.291451483136;6184.845378865384;6260.029695397221;6271.937280627135;6287.434130928238;6129.785457508966;6150.384961503813;6151.661658608819;6155.84610384744;6174.722137503733;6222.408871157233;6240.12638230639;6250.874982500415;6252.874942501216;6261.123442718114;5929.436703513159;6035;6097.725602347994;6103.277060575968;6113.29387775398;4511.70673906195;5455.890882182255;5564.914841605848;6025;6028.457438830526;5793.188953546422;5860.472557469848;5900.616459930091;5915.526757859275;5932.406759324033;5945.554083443672;6095.922000763747;6096.390360963868;6102.883130681719;6120.938790612215;4878.487758785276;4879.463259041574;5947.613405128653;5963.70181490915;5971 06:30:14 INFO - PROCESS | 2625 | |1;ext.html;468.52444768559894;476.679597514884;578.9289813844389;624.8344188789971;642.8971364581666;36359;40085.99999999996;40167.79916100419;40201.19597608053;40245.19509609806;42938;43153;43232.135357292835;43265.91835204114;43323.78338108313;9565.521723913795;9791.706248812512;9801.950990245039;9802.852957205647;9809.50952452378;9623.807523849518;9730.367526110815;9777.41335519871;9869.802603947917;9883.802323953516;9869.802603947917;9938.900610993906;9944.453055082004;9945.850812237823;9949.801003979916;9837.852432213522;9911.653092141813;9913.90086099137;9931.30480866336;9940.80118397628;9687;9823.115919567274;9825.950870245675;9830.508474576314;9837.803243935154;41664.79167604173;41980.1603967922;42026.579734202875;42043.78978105121;42086.78956605228;3192.1062102611304;3211.0687900508824;3241.465158248886;3298.5711857458377;3648.343298206322;28830.423391532262;28842.567361489593;29459;29980.400391992258;30192.84903575468;2714.09077958884;2750.7661848742882;2774.819636723627;2791.7627001704877;2865.785066120049;473527;474226;475112.62443687906;475996;476288;45536.54463455323;46224.075518489444;46226.76886615546;66337;66678;45407.772961134986;45706.08587828225;45853.54146458493;46010.07979840384;46170.459544854835;15375.769363459556;15574.221288935509;15584.298706558233;15594.986325888782;15601.765973510406;12522.624321270376;12599.622011339674;12600.495980160691;12612.621621351374;12626.179298345578;14736;14911.254437278092;14951.1776852272;14965.551033469013;15055.247237638074;6080.2399700037495;6204.193454850931;6355.966090850883;6378.521610879203;6380.840478988062;937.554661535765;958.3291695812959;991.2961797123978;999.9350042247231;1032.9896701033044;29895.551566726517;30111.09666710002;31407.84296078505;31438.528422073687;32015.87944421934;1080.3679847289425;1080.8540846985557;1110.5502271580024;1115.369816053927;1150.1718762490993;14706.705865882837;14822.62943426423;14847.851521484863;15229.847701522844;15264.084154950739;410537;524835;528672;531718;533184;58856.41143588595;59459.405405945385;59483.10775338373;59559.702201489585;59578.40421595815;1334.426196735413;1364.2973868457752;1472.5950363649868;1476.852314768536;1502.3765137467828;29004.694788734978;29311.85344073266;29642.703572963994;29682.851585741933;29864.552031719108;48395;48630.75684621554;48905.755471222416;48966;49230.50769492259;364379;371257;372385;372966;373639;33356.833215833765;33507.66492335046;33672;34245.657543425245;34279.48580771241;44849.55150448454;45467.772661136485;45830.54169458263;46415.53584464112;46603;31301;36213.91358259256;37705.43441848319;38364.04089897775;38721.4191787129;28805.7119428803;36488.635113648525;36844.26311473809;37516.81241593884;37589.872303830925;29762.553561697026;31516.369672606877;37230.44154337633;37358.06604834901;37382;29337.413251735274;30883;30947.845260773553;30955;30959.380812383177;22666.660000100343;23394;23875.76124238805;24241.51516969686;24249 06:30:14 INFO - PROCESS | 2625 | |2;jquery.html;328.4268950681062;360.5871277387391;362.47260236356124;363.81627278224494;375.44059351566176;18497.16762745676;19618.56675081862;19855.702164467508;19885.701714474293;19888.40334789955;18140.546486337847;19394.515137121543;20057.799422005777;20064;20091;5708.77164913404;5875.735591898375;5923.644581325134;5930.851728706773;5932.555058370618;5667.716614169296;5877.059670452729;5911.231539899829;5946.197263369433;5949.1968584241;5819.388964158766;5850.122481627747;5864.648121112726;5873.559483038768;5877.559183061266;5510.531604813596;5751.597388182829;5836;5852.444017818321;5854.414558544154;4951.232558953368;5009.123403404426;5010.0981823271795;5013.573846223039;5013.774380152865;25204.495910081878;25221;25313.493730125294;25538.489230215477;25547.48905021908;2133.839962002856;2213.4687674957895;2229.977700222993;2425.454272788626;3038.8176709397508;6694.129763130762;6722.159730033746;6764.763233286861;7564.773056808304;14572.296917513522;1716.159082049799;1727.4731206981864;1743.747156662277;1773.2906837265198;1799.5051360875732;95092;95438.52280738621;97940.51029744805;98061;98709;10039.4478303694;10286.845697314397;10309.94845025785;10428.37429754202;10459.163266938627;12737.808932866015;12822.35888205586;12856.935715321551;12862.614121576367;12888.162269452456;8211.384146189059;8360.874586881202;8375.95812020936;8464.40749147566;8474.915250847536;8568.742937711879;8573.399862009725;8580.399372043898;8676.002259740084;8799.076097009722;5951.791687290924;6050;6063.151158837766;6065.451710749173;6120.60216085953;1657.7815305750505;1781.385422029398;1803.8083728270215;1812.9002904840097;1817.7727784026997;830.4311546590604;902.6660135749814;1009.4548943570536;1052.5737076484036;1062.2757942225692;20534.794652053588;20637;21502.354929352143;21715.674264886038;21719.239826605994;940.9764755881158;984;995.5619527407918;1021.0657248617432;1031.4636389077637;10573;11424.42877856104;11518.654440366803;11541.538338466535;11585.6524304271;511861;581358;591999;617788;623753;73000;88970;94859;116581;123534;1037.3775734559356;1058.439027315524;1075.3494136047734;1079.6707004363902;1080.02797482265;17832.32515122742;18305.359312424;18348.449546513624;18474.353397631017;18519.35182268614;50251.49748502468;50551.74724126356;51113;51436;51532;72761.27238727757;72933.27066729477;73867;74015;74353.6282318585;7542.660580273791;7698.807529811799;7722.339696965179;7814.492058016211;7990.121086680577;10616.416097114732;11994.520219191134;12269.325187114795;12362.567310144103;12500.624981250578;10300.742481437725;10756.462176890967;10916.01755841978;10955.726106847393;11062.778744425228;10624.246999245039;10632.468376580986;10751.731206719582;10787.298825576627;11024.889751102708;9292.535373231176;10842;10979.890201098206;11114.166437517057;11172.273802202832;7498.812529686801;7563.621818909142;7686.3082322591235;7732.226777322223;7838.686452541834;9192.54037298119;10713.410762408143;10726.624568140078;10940.452977350942;10956.397398142859 06:30:14 INFO - PROCESS | 2625 | |3;mootools.html;1445.877100446462;1603.8957467764594;1629.5437277562282;1913.6651086059935;2041.5712700332929;8121.309688676462;8661.307095432367;8852.822943541125;8882.333824963129;8885.733427997155;8518.446300990432;8770.386072974894;8777.648894044247;8785.033646298902;8801;1941.1847024249848;2002.9284332881912;2235.228846048119;2451.3503921460783;2482.937926551833;2415.6618073469726;2474.393773525489;2475.4306509502735;2481.131603938625;2481.727010028895;2406.193925035115;2430.1008626808107;2479.231438254147;2497.8001759859258;2519.370157460635;2461.2247142150345;2485.689288838895;2497.2882728422496;2512.648229247907;2513.6606558114786;2465.7287698353166;2488.701355837293;2497.1509686706427;2497.1509686706427;2517.5216708825265;8872.245859101984;8920;8928.910710892873;8937.553122343857;8942.955285223597;4790.496997815214;5501.312335958005;5609.439056094398;5659.122835960392;5662.943370566283;3240.8865689700747;3608.548931383577;3622.2936527377174;3775.716821238418;3788.7916164610933;1051.6371851711147;1061.6921092883056;1067.4929408530963;1076.2036093290988;1076.962306319275;12117.27296362221;12135.817962730565;12141.332226727527;12143.271403715806;12143.392830358534;4849.95150048495;4865.878353041131;4919.385076865392;4952.257161425815;4966.801327946914;10322.896771032343;10331.966803319758;10338.431386273827;10341.431221282752;10357.63748268807;5590.105583106683;5591.832245032656;5594.244776955059;5602.915956260659;5607.467290607386;4473.530279320689;4600.700954437951;4841.491643377394;4909.2881532177635;5070.721110338966;3822.9235415291537;3895.7078219133114;3909.237698648736;3910.787655826703;3956.742811717229;1306.719055403074;1312.9080964332595;1318.960431187066;1328.5482935801874;1328.9601311960657;1233.7224124572078;1276.5213045108085;1284.229462322599;1285.4279845468677;1299.4347458855427;8138.308243799225;8289.129641387688;8298.751037468886;8303.8339233215;8323.95838020806;518.1805667538548;526.8472143078465;535.0769921884795;538.7979507684619;539.3231494474488;6267.6866156692895;6283.497320214372;6308.179936608211;6316.905246421307;6326.778562750282;10246.6413675521;10721.571137154582;10741.979511946352;10752.516136773707;10752.677419677422;10439.478026098664;10559.102476289449;10619.20355973305;10631.574737010587;10638.361698297973;8238.670453181925;8320.791980200544;8344.916550834536;8380.329573634095;8396.286315663116;6458.483321334376;7881.527108373516;7890;7942.920570794449;7948.16544262844;7951.244631759973;9404.38871473352;9537.14165725088;9628.855567166358;9636.903630963881;9330.393524420891;9709.70870873875;9710.077542633438;9813.264005199495;9934.950325248328;6828.760993365208;6896.689648965708;7435.925640743523;7495.662695178621;7625.351845093007;8237.50574965504;8351.916480835114;8362.121977192308;8368.790780230544;8374.162583741578;7265.891011634724;7325.304096110861;7503.737369192052;7504.137024242282;7507.66215520292;7248.855022899407;7309.195988441374;7315.670794814353;7343.669534870837;7433.145188303198;7801.414893882868;7828.256315650005;7845.215478452109;7846.17615150401;7896;6972.742734453567;7055.929440705528;7104;7113.786586402416;7116.715331386687;7164.032855564432;7246;7252.38354739853;7254.5647261164495;7270.418366530771 06:30:14 INFO - PROCESS | 2625 | |4;prototype.html;321.163369422654;325.762193598673;329.586369106771;332.3270377485593;337.492074427986;6539.346065393458;6541.149650545434;6555.099021283828;6567.507436942236;6594.934050659492;6525.902111468332;6531.836704082389;6547.624998750256;6550.475961923046;6564.671766411684;4599.517050709677;4696.600788932928;4707.152712511746;4731.432228132629;4826.638002149844;4803.519648035203;4807.1587472192405;4830.758462076899;4834.2990266411525;4850.223964165734;4387.1225754849;4533.727976321431;4748.050389922012;4772.188727916246;4773.952260477386;4579.610733087691;4652.883308006054;4699.154152252593;4768.403949506329;4785.90428191436;4054.209429161315;4054.6958978076764;4113.115680128787;4114.218298523271;4122.649574786146;5070.3915530136255;6465;6467.644279564622;6476.579022363531;6493.253275873288;5742.511886489653;5746.396628354046;5746.683932383718;5756.510696590794;5775.884482310373;7044.753433629799;7060.435165186773;7075.681594328267;7076.575405475636;7077.964610176916;4547.909041819178;4715.386999690053;4719.386479757643;4764.475907650156;4774.594159496447;6089.208402907594;7258.947452619341;7390.926090739077;7422.6288685565505;7451.664675089634;4766.4280286365165;4786.401699787527;4786.497417771084;4793.880152996203;4806.567408933143;4854.5873600744335;4857.198562237262;4876.634252431082;4880.633952453581;4892.510748925079;4859.222524396079;5565.471280228372;5724.484796368347;5740.512056475163;5744;6799.252082270947;7080.079589653312;7086.964565177141;7137.857242855218;7151.678174482161;1689.6789609974312;1695.5422036050197;1710.4868539438366;1711.2898147268993;1716.5279548124365;987.151050096916;1042.9674622124194;1095.4741723972538;1114.0641860836936;1117.8379135025539;6383.808485745435;6537.411632953057;6629.801105966829;6646.534742567974;6666.133402657721;7219.458540609476;7448.851022979618;7451.515651482637;7476.1776204617445;7479.813004674927;6717.2946840581035;6738.764143255061;6826.488013398915;6844.555103918229;6867.381935625817;3869.7484663496784;3919.5884432134217;3925.842966281317;3926.980365098156;3927.3127202739406;6364.586301890362;7402.666879990414;7743.92256077432;7744.961275193588;7761.534307941542;6395.936040639627;7150.177729561063;7502.287282708134;7533.962330188314;7557.584332861746;7637.579933103732;7752.224777522316;7761.8447631047065;7762.650680719268;7769.417293702995;7388.298111679382;7413.925860741324;7423.8144046399275;7427.331540161412;7431.628418578941;7013.438924885895;7278.308560686726;7284.089488813898;7287;7302.306280903305;7706.7687969361;7711.11322197932;7743;7777.688892444466;7779.494332868346;3789.6399842014966;4637.3739545162325;4643.187442197669;4645.814167433265;4656.813727451;7375.11498620169;7384.741534046282;7396.4082873368925;7398.96300518494;7404.777856664308;6905.447564194752;7169.856602868018;7172.354488096096;7199.1001124859395;7216.242294558996;6579.769708060195;7099.183593886562;7138.214796372291;7143.178534468395;7168.9605007274695;6294.43350098475;6999.965000174967;7000.334968178015;7021.473389495911;7027.543209691558;7189.71241150369;7194.496385252982;7196.352328290479;7197.740395430884;7202.495825292389;5608.523275521627;6683.498737594603;6767.593944363354;7045.647717614202;7046.647667616701 06:30:14 INFO - PROCESS | 2625 | |5;yui.html;680.9455243580514;710.126544350449;711.5730561663006;717.5730440387969;770.9922900770994;15005.699886002274;15206;15214.163221022853;15231;15252.389904403824;13818.378172982215;13854.307284635779;14163.645908852284;14328.928355358235;14345.067570607904;656.6651007985914;760.39168665068;910.9498977556249;931.1433481197315;939.4973689076346;927.1655510040949;927.5918595817852;932.2681694869528;932.3380399916068;937.2221056523103;978.3885071830106;985.1773768902974;985.7486340983039;986.9981968302143;996.7707427291728;770.9113451953014;789.128013545036;790.5217343507153;966.2077096780572;985.5614251658016;722.5736815278958;724.102113379411;724.4457989637931;725.1370868666323;731.228553875661;14859.108453492825;14923.179225142612;14954.62613434662;14960.177190254532;14968.775468367983;12282.754344913052;12336.876631233663;12408.007359411225;12526.060545459128;12556.497740090386;9831.410115393099;10070.395776253448;10117.241206909437;10135.037171468699;10434;3466.6879980801596;3500.2474467989505;3527.876524321662;3546.042568506489;3594.748367614268;78365.60817195935;79230;80799.5960020202;81361.59319203366;81786.59106704428;9425.717228483156;9492.050794920591;9507.33448658601;9760.902390976;9876.65431709901;22269;22302.442438938833;22354.441138971655;22355.888220558794;22362.55274894493;7333.853322933618;7401.703931842773;7447.88828167578;7524.774256772305;7610.391168706601;3953.2488827122756;4020.0150963013666;4021.2158629067053;4032.5564187939303;4046.109855831712;3489.8953031409096;3545.2023294758988;3547.0600290922926;3553.200529880756;3554.289142171576;644.9193850768654;651.4853265919965;662.7017841971036;672.9938741581269;682.4199430484049;539.9352077750696;589.5254320272222;592.6473748119948;596.3916804859106;600.474584738354;7851.882221766678;7979.241972012649;7982.68069277234;8226.753197404087;8330.958345208357;529.219401382957;569.1548051144048;576.700115939709;603.5533705058225;620.8261686727724;3733.0667333166707;3805.0677583991546;3870.1679138985255;3878.6897048236074;3897.162110146332;96339;96504;98623;98717.50641246748;98805;83488;83571.74642380369;84428;84823.57588212143;88416;72387;73191;73276;73648.63175684087;74177;7723.575203363869;8095.595220239083;8248.83502329962;8298.751037468886;8357.206065423776;48446.51553484561;48576;48797;49041.754791225816;51637;62799.6860015697;65439.67280163569;66664.66667666825;69394;69566.65216673884;11084.113270938144;11184;11187.32876027441;11489.138314626269;11529;11943.522259109886;11954.222975506564;12017.09871759604;12110.515579376726;12159.635210943687;9680.612775489184;11365.31808091517;11366;11873.881261187278;11950.641480755592;11304.378259195495;11322.37726925027;11591.420428978687;11805;12264.32546209967;10180.847287290844;11089.390083545482;11389;11431.657050288504;11655.708607284547;9486.383385079947;9633.710988670351;9687.418754874448;10062.798744025225;10079.244056695923;9545.236381089357;9657.179139773198;9699.66051188205;9703.175230105238;9730.172935300296 06:30:14 INFO - PROCESS | 2625 | __end_tp_report 06:30:14 INFO - PROCESS | 2625 | __start_cc_report 06:30:14 INFO - PROCESS | 2625 | _x_x_mozilla_cycle_collect,1035 06:30:14 INFO - PROCESS | 2625 | __end_cc_report 06:30:14 INFO - PROCESS | 2625 | __startTimestamp1459344614529__endTimestamp 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | ------- Summary: start ------- 06:30:14 INFO - PROCESS | 2625 | Number of tests: 6 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#0] dojo.html Cycles:165 Average:5651.81 Median:5900.62 stddev:676.31 (11.5%) stddev-sans-first:641.48 06:30:14 INFO - PROCESS | 2625 | Values: 2842.7 3324.0 3427.1 3465.3 3500.9 4645.4 5521.8 5608.2 5609.2 5656.6 5662.1 5668.3 5791.7 5799.7 5844.1 4179.8 5033.4 5048.3 5086.6 5241.3 5164.8 5171.7 5198.4 5218.4 5232.2 4769.9 5005.2 5081.7 5134.0 5144.4 5113.7 5118.9 5121.3 5130.6 5142.7 5069.9 5089.4 5092.1 5111.0 5122.6 5470.8 5586.2 5594.2 5680.1 5682.5 6192.1 6192.5 6196.3 6197.8 6199.7 6210.8 6281.6 6282.3 6287.2 6304.9 5639.5 5748.9 5762.5 5783.0 5853.5 6253.2 6256.3 6262.4 6279.3 6286.2 6051.4 6102.6 6114.8 6130.7 6131.7 6078.3 6111.8 6145.6 6155.7 6174.5 6112.7 6126.5 6145.7 6149.8 6151.1 6149.8 6150.7 6152.1 6154.8 6163.8 4806.5 4823.4 4856.6 4867.6 4881.8 4373.6 4456.6 4475.6 4476.1 4479.1 4840.9 5582.2 5615.0 5617.5 5647.1 6148.6 6208.6 6232.1 6240.8 6246.4 5654.9 5658.0 5669.5 5680.5 5690.4 5163.9 5232.6 5240.9 5266.6 5346.0 6232.8 6240.7 6254.2 6256.7 6280.1 6198.9 6207.8 6210.5 6211.1 6225.3 6161.3 6184.8 6260.0 6271.9 6287.4 6129.8 6150.4 6151.7 6155.8 6174.7 6222.4 6240.1 6250.9 6252.9 6261.1 5929.4 6035.0 6097.7 6103.3 6113.3 4511.7 5455.9 5564.9 6025.0 6028.5 5793.2 5860.5 5900.6 5915.5 5932.4 5945.6 6095.9 6096.4 6102.9 6120.9 4878.5 4879.5 5947.6 5963.7 5971.0 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#1] ext.html Cycles:180 Average:59406.93 Median:38542.73 stddev:120888.63 (313.6%) stddev-sans-first:121146.77 06:30:14 INFO - PROCESS | 2625 | Values: 468.5 476.7 578.9 624.8 642.9 36359.0 40086.0 40167.8 40201.2 40245.2 42938.0 43153.0 43232.1 43265.9 43323.8 9565.5 9791.7 9802.0 9802.9 9809.5 9623.8 9730.4 9777.4 9869.8 9883.8 9869.8 9938.9 9944.5 9945.9 9949.8 9837.9 9911.7 9913.9 9931.3 9940.8 9687.0 9823.1 9826.0 9830.5 9837.8 41664.8 41980.2 42026.6 42043.8 42086.8 3192.1 3211.1 3241.5 3298.6 3648.3 28830.4 28842.6 29459.0 29980.4 30192.8 2714.1 2750.8 2774.8 2791.8 2865.8 473527.0 474226.0 475112.6 475996.0 476288.0 45536.5 46224.1 46226.8 66337.0 66678.0 45407.8 45706.1 45853.5 46010.1 46170.5 15375.8 15574.2 15584.3 15595.0 15601.8 12522.6 12599.6 12600.5 12612.6 12626.2 14736.0 14911.3 14951.2 14965.6 15055.2 6080.2 6204.2 6356.0 6378.5 6380.8 937.6 958.3 991.3 999.9 1033.0 29895.6 30111.1 31407.8 31438.5 32015.9 1080.4 1080.9 1110.6 1115.4 1150.2 14706.7 14822.6 14847.9 15229.8 15264.1 410537.0 524835.0 528672.0 531718.0 533184.0 58856.4 59459.4 59483.1 59559.7 59578.4 1334.4 1364.3 1472.6 1476.9 1502.4 29004.7 29311.9 29642.7 29682.9 29864.6 48395.0 48630.8 48905.8 48966.0 49230.5 364379.0 371257.0 372385.0 372966.0 373639.0 33356.8 33507.7 33672.0 34245.7 34279.5 44849.6 45467.8 45830.5 46415.5 46603.0 31301.0 36213.9 37705.4 38364.0 38721.4 28805.7 36488.6 36844.3 37516.8 37589.9 29762.6 31516.4 37230.4 37358.1 37382.0 29337.4 30883.0 30947.8 30955.0 30959.4 22666.7 23394.0 23875.8 24241.5 24249.0 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#2] jquery.html Cycles:180 Average:32892.60 Median:1683.62 stddev:96978.31 (5760.1%) stddev-sans-first:97219.54 06:30:14 INFO - PROCESS | 2625 | Values: 328.4 360.6 362.5 363.8 375.4 18497.2 19618.6 19855.7 19885.7 19888.4 18140.5 19394.5 20057.8 20064.0 20091.0 5708.8 5875.7 5923.6 5930.9 5932.6 5667.7 5877.1 5911.2 5946.2 5949.2 5819.4 5850.1 5864.6 5873.6 5877.6 5510.5 5751.6 5836.0 5852.4 5854.4 4951.2 5009.1 5010.1 5013.6 5013.8 25204.5 25221.0 25313.5 25538.5 25547.5 2133.8 2213.5 2230.0 2425.5 3038.8 6694.1 6722.2 6764.8 7564.8 14572.3 1716.2 1727.5 1743.7 1773.3 1799.5 95092.0 95438.5 97940.5 98061.0 98709.0 10039.4 10286.8 10309.9 10428.4 10459.2 12737.8 12822.4 12856.9 12862.6 12888.2 8211.4 8360.9 8376.0 8464.4 8474.9 8568.7 8573.4 8580.4 8676.0 8799.1 5951.8 6050.0 6063.2 6065.5 6120.6 1657.8 1781.4 1803.8 1812.9 1817.8 830.4 902.7 1009.5 1052.6 1062.3 20534.8 20637.0 21502.4 21715.7 21719.2 941.0 984.0 995.6 1021.1 1031.5 10573.0 11424.4 11518.7 11541.5 11585.7 511861.0 581358.0 591999.0 617788.0 623753.0 73000.0 88970.0 94859.0 116581.0 123534.0 1037.4 1058.4 1075.3 1079.7 1080.0 17832.3 18305.4 18348.4 18474.4 18519.4 50251.5 50551.7 51113.0 51436.0 51532.0 72761.3 72933.3 73867.0 74015.0 74353.6 7542.7 7698.8 7722.3 7814.5 7990.1 10616.4 11994.5 12269.3 12362.6 12500.6 10300.7 10756.5 10916.0 10955.7 11062.8 10624.2 10632.5 10751.7 10787.3 11024.9 9292.5 10842.0 10979.9 11114.2 11172.3 7498.8 7563.6 7686.3 7732.2 7838.7 9192.5 10713.4 10726.6 10940.5 10956.4 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#3] mootools.html Cycles:180 Average:6063.65 Median:3020.32 stddev:3221.91 (106.7%) stddev-sans-first:3212.25 06:30:14 INFO - PROCESS | 2625 | Values: 1445.9 1603.9 1629.5 1913.7 2041.6 8121.3 8661.3 8852.8 8882.3 8885.7 8518.4 8770.4 8777.6 8785.0 8801.0 1941.2 2002.9 2235.2 2451.4 2482.9 2415.7 2474.4 2475.4 2481.1 2481.7 2406.2 2430.1 2479.2 2497.8 2519.4 2461.2 2485.7 2497.3 2512.6 2513.7 2465.7 2488.7 2497.2 2497.2 2517.5 8872.2 8920.0 8928.9 8937.6 8943.0 4790.5 5501.3 5609.4 5659.1 5662.9 3240.9 3608.5 3622.3 3775.7 3788.8 1051.6 1061.7 1067.5 1076.2 1077.0 12117.3 12135.8 12141.3 12143.3 12143.4 4850.0 4865.9 4919.4 4952.3 4966.8 10322.9 10332.0 10338.4 10341.4 10357.6 5590.1 5591.8 5594.2 5602.9 5607.5 4473.5 4600.7 4841.5 4909.3 5070.7 3822.9 3895.7 3909.2 3910.8 3956.7 1306.7 1312.9 1319.0 1328.5 1329.0 1233.7 1276.5 1284.2 1285.4 1299.4 8138.3 8289.1 8298.8 8303.8 8324.0 518.2 526.8 535.1 538.8 539.3 6267.7 6283.5 6308.2 6316.9 6326.8 10246.6 10721.6 10742.0 10752.5 10752.7 10439.5 10559.1 10619.2 10631.6 10638.4 8238.7 8320.8 8344.9 8380.3 8396.3 6458.5 7881.5 7890.0 7942.9 7948.2 7951.2 9404.4 9537.1 9628.9 9636.9 9330.4 9709.7 9710.1 9813.3 9935.0 6828.8 6896.7 7435.9 7495.7 7625.4 8237.5 8351.9 8362.1 8368.8 8374.2 7265.9 7325.3 7503.7 7504.1 7507.7 7248.9 7309.2 7315.7 7343.7 7433.1 7801.4 7828.3 7845.2 7846.2 7896.0 6972.7 7055.9 7104.0 7113.8 7116.7 7164.0 7246.0 7252.4 7254.6 7270.4 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#4] prototype.html Cycles:180 Average:5790.06 Median:6549.05 stddev:1859.50 (28.4%) stddev-sans-first:1818.84 06:30:14 INFO - PROCESS | 2625 | Values: 321.2 325.8 329.6 332.3 337.5 6539.3 6541.1 6555.1 6567.5 6594.9 6525.9 6531.8 6547.6 6550.5 6564.7 4599.5 4696.6 4707.2 4731.4 4826.6 4803.5 4807.2 4830.8 4834.3 4850.2 4387.1 4533.7 4748.1 4772.2 4774.0 4579.6 4652.9 4699.2 4768.4 4785.9 4054.2 4054.7 4113.1 4114.2 4122.6 5070.4 6465.0 6467.6 6476.6 6493.3 5742.5 5746.4 5746.7 5756.5 5775.9 7044.8 7060.4 7075.7 7076.6 7078.0 4547.9 4715.4 4719.4 4764.5 4774.6 6089.2 7258.9 7390.9 7422.6 7451.7 4766.4 4786.4 4786.5 4793.9 4806.6 4854.6 4857.2 4876.6 4880.6 4892.5 4859.2 5565.5 5724.5 5740.5 5744.0 6799.3 7080.1 7087.0 7137.9 7151.7 1689.7 1695.5 1710.5 1711.3 1716.5 987.2 1043.0 1095.5 1114.1 1117.8 6383.8 6537.4 6629.8 6646.5 6666.1 7219.5 7448.9 7451.5 7476.2 7479.8 6717.3 6738.8 6826.5 6844.6 6867.4 3869.7 3919.6 3925.8 3927.0 3927.3 6364.6 7402.7 7743.9 7745.0 7761.5 6395.9 7150.2 7502.3 7534.0 7557.6 7637.6 7752.2 7761.8 7762.7 7769.4 7388.3 7413.9 7423.8 7427.3 7431.6 7013.4 7278.3 7284.1 7287.0 7302.3 7706.8 7711.1 7743.0 7777.7 7779.5 3789.6 4637.4 4643.2 4645.8 4656.8 7375.1 7384.7 7396.4 7399.0 7404.8 6905.4 7169.9 7172.4 7199.1 7216.2 6579.8 7099.2 7138.2 7143.2 7169.0 6294.4 7000.0 7000.3 7021.5 7027.5 7189.7 7194.5 7196.4 7197.7 7202.5 5608.5 6683.5 6767.6 7045.6 7046.6 06:30:14 INFO - PROCESS | 2625 | 06:30:14 INFO - PROCESS | 2625 | [#5] yui.html Cycles:180 Average:18708.03 Median:31722.30 stddev:26694.01 (84.1%) stddev-sans-first:26734.57 06:30:14 INFO - PROCESS | 2625 | Values: 680.9 710.1 711.6 717.6 771.0 15005.7 15206.0 15214.2 15231.0 15252.4 13818.4 13854.3 14163.6 14328.9 14345.1 656.7 760.4 910.9 931.1 939.5 927.2 927.6 932.3 932.3 937.2 978.4 985.2 985.7 987.0 996.8 770.9 789.1 790.5 966.2 985.6 722.6 724.1 724.4 725.1 731.2 14859.1 14923.2 14954.6 14960.2 14968.8 12282.8 12336.9 12408.0 12526.1 12556.5 9831.4 10070.4 10117.2 10135.0 10434.0 3466.7 3500.2 3527.9 3546.0 3594.7 78365.6 79230.0 80799.6 81361.6 81786.6 9425.7 9492.1 9507.3 9760.9 9876.7 22269.0 22302.4 22354.4 22355.9 22362.6 7333.9 7401.7 7447.9 7524.8 7610.4 3953.2 4020.0 4021.2 4032.6 4046.1 3489.9 3545.2 3547.1 3553.2 3554.3 644.9 651.5 662.7 673.0 682.4 539.9 589.5 592.6 596.4 600.5 7851.9 7979.2 7982.7 8226.8 8331.0 529.2 569.2 576.7 603.6 620.8 3733.1 3805.1 3870.2 3878.7 3897.2 96339.0 96504.0 98623.0 98717.5 98805.0 83488.0 83571.7 84428.0 84823.6 88416.0 72387.0 73191.0 73276.0 73648.6 74177.0 7723.6 8095.6 8248.8 8298.8 8357.2 48446.5 48576.0 48797.0 49041.8 51637.0 62799.7 65439.7 66664.7 69394.0 69566.7 11084.1 11184.0 11187.3 11489.1 11529.0 11943.5 11954.2 12017.1 12110.5 12159.6 9680.6 11365.3 11366.0 11873.9 11950.6 11304.4 11322.4 11591.4 11805.0 12264.3 10180.8 11089.4 11389.0 11431.7 11655.7 9486.4 9633.7 9687.4 10062.8 10079.2 9545.2 9657.2 9699.7 9703.2 9730.2 06:30:14 INFO - PROCESS | 2625 | -------- Summary: end -------- 06:30:14 INFO - PROCESS | 2625 | 06:30:15 INFO - TEST-INFO | 2625: exit 0 06:30:15 INFO - TEST-OK | dromaeo_css | took 1113537ms 06:30:15 INFO - TEST-START | kraken 06:30:15 INFO - operating with platform_type : mac_ 06:30:15 INFO - Initialising browser for kraken test... 06:30:15 INFO - TEST-INFO | started process 2628 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpUDUriU/profile http://localhost:52434/getInfo.html) 06:30:17 INFO - PROCESS | 2628 | __metrics Screen width/height:1600/1200 06:30:17 INFO - PROCESS | 2628 | colorDepth:24 06:30:17 INFO - PROCESS | 2628 | Browser inner width/height: 1024/689 06:30:17 INFO - PROCESS | 2628 | __metrics 06:30:17 INFO - PROCESS | 2628 | 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" 06:30:17 ERROR - PROCESS | 2628 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:30:17 INFO - TEST-INFO | 2628: exit 0 06:30:17 INFO - Browser initialized. 06:30:17 INFO - Running cycle 1/1 for kraken test... 06:30:17 INFO - TEST-INFO | started process 2630 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpUDUriU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:29 INFO - PROCESS | 2630 | RSS: Main: 244547584 06:30:29 INFO - PROCESS | 2630 | 06:30:32 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52434/tests/kraken/driver.html?testName=audio-beat-detection) 06:30:33 INFO - PROCESS | 2630 | RSS: Main: 291000320 06:30:33 INFO - PROCESS | 2630 | 06:30:35 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52434/tests/kraken/driver.html?testName=audio-dft) 06:30:36 INFO - PROCESS | 2630 | RSS: Main: 301043712 06:30:36 INFO - PROCESS | 2630 | 06:30:39 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52434/tests/kraken/driver.html?testName=audio-fft) 06:30:40 INFO - PROCESS | 2630 | RSS: Main: 287244288 06:30:40 INFO - PROCESS | 2630 | 06:30:42 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52434/tests/kraken/driver.html?testName=audio-oscillator) 06:30:42 INFO - PROCESS | 2630 | RSS: Main: 289026048 06:30:42 INFO - PROCESS | 2630 | 06:30:44 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:45 INFO - PROCESS | 2630 | RSS: Main: 288935936 06:30:45 INFO - PROCESS | 2630 | 06:30:48 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52434/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:48 INFO - PROCESS | 2630 | RSS: Main: 290185216 06:30:48 INFO - PROCESS | 2630 | 06:30:51 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52434/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:52 INFO - PROCESS | 2630 | RSS: Main: 290418688 06:30:52 INFO - PROCESS | 2630 | 06:30:54 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52434/tests/kraken/driver.html?testName=json-parse-financial) 06:30:55 INFO - PROCESS | 2630 | RSS: Main: 290717696 06:30:55 INFO - PROCESS | 2630 | 06:30:57 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:57 INFO - PROCESS | 2630 | RSS: Main: 322318336 06:30:57 INFO - PROCESS | 2630 | 06:30:59 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:00 INFO - PROCESS | 2630 | RSS: Main: 322543616 06:31:00 INFO - PROCESS | 2630 | 06:31:02 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:02 INFO - PROCESS | 2630 | RSS: Main: 329535488 06:31:02 INFO - PROCESS | 2630 | 06:31:05 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:06 INFO - PROCESS | 2630 | RSS: Main: 331243520 06:31:06 INFO - PROCESS | 2630 | 06:31:08 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:09 INFO - PROCESS | 2630 | RSS: Main: 331112448 06:31:09 INFO - PROCESS | 2630 | 06:31:10 INFO - PROCESS | 2630 | Cycle 1(1): loaded http://localhost:52434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52434/tests/kraken/driver.html?testName=ai-astar) 06:31:11 INFO - PROCESS | 2630 | RSS: Main: 395055104 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | __start_tp_report 06:31:11 INFO - PROCESS | 2630 | _x_x_mozilla_page_load 06:31:11 INFO - PROCESS | 2630 | _x_x_mozilla_page_load_details 06:31:11 INFO - PROCESS | 2630 | |i|pagename|runs| 06:31:11 INFO - PROCESS | 2630 | |0;ai-astar;110;111;112;110;112;111;116;112;111;112 06:31:11 INFO - PROCESS | 2630 | |1;audio-beat-detection;157;120;143;162;103;147;161;149;197;142 06:31:11 INFO - PROCESS | 2630 | |2;audio-dft;185;183;187;181;183;184;223;264;182;181 06:31:11 INFO - PROCESS | 2630 | |3;audio-fft;81;77;83;82;56;60;57;76;77;54 06:31:11 INFO - PROCESS | 2630 | |4;audio-oscillator;95;97;135;80;77;94;114;79;80;113 06:31:11 INFO - PROCESS | 2630 | |5;imaging-gaussian-blur;87;83;87;84;127;83;87;83;86;83 06:31:11 INFO - PROCESS | 2630 | |6;imaging-darkroom;92;93;93;94;93;92;93;93;93;92 06:31:11 INFO - PROCESS | 2630 | |7;imaging-desaturate;86;88;88;85;88;87;86;88;86;84 06:31:11 INFO - PROCESS | 2630 | |8;json-parse-financial;57;55;55;53;60;54;54;62;55;53 06:31:11 INFO - PROCESS | 2630 | |9;json-stringify-tinderbox;67;70;69;81;71;68;69;68;68;68 06:31:11 INFO - PROCESS | 2630 | |10;stanford-crypto-aes;83;85;84;79;84;83;84;83;85;83 06:31:11 INFO - PROCESS | 2630 | |11;stanford-crypto-ccm;125;136;111;110;143;132;131;128;147;140 06:31:11 INFO - PROCESS | 2630 | |12;stanford-crypto-pbkdf2;140;131;139;171;146;130;142;140;141;138 06:31:11 INFO - PROCESS | 2630 | |13;stanford-crypto-sha256-iterative;72;68;69;68;69;68;67;67;67;69 06:31:11 INFO - PROCESS | 2630 | __end_tp_report 06:31:11 INFO - PROCESS | 2630 | __start_cc_report 06:31:11 INFO - PROCESS | 2630 | _x_x_mozilla_cycle_collect,1233 06:31:11 INFO - PROCESS | 2630 | __end_cc_report 06:31:11 INFO - PROCESS | 2630 | __startTimestamp1459344671174__endTimestamp 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | ------- Summary: start ------- 06:31:11 INFO - PROCESS | 2630 | Number of tests: 14 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.70 (1.5%) stddev-sans-first:1.69 06:31:11 INFO - PROCESS | 2630 | Values: 110.0 111.0 112.0 110.0 112.0 111.0 116.0 112.0 111.0 112.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.00 stddev:25.21 (16.5%) stddev-sans-first:26.53 06:31:11 INFO - PROCESS | 2630 | Values: 157.0 120.0 143.0 162.0 103.0 147.0 161.0 149.0 197.0 142.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#2] audio-dft Cycles:10 Average:195.30 Median:184.50 stddev:27.24 (14.8%) stddev-sans-first:28.64 06:31:11 INFO - PROCESS | 2630 | Values: 185.0 183.0 187.0 181.0 183.0 184.0 223.0 264.0 182.0 181.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#3] audio-fft Cycles:10 Average:70.30 Median:77.00 stddev:11.96 (15.5%) stddev-sans-first:12.05 06:31:11 INFO - PROCESS | 2630 | Values: 81.0 77.0 83.0 82.0 56.0 60.0 57.0 76.0 77.0 54.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:80.00 stddev:19.15 (23.9%) stddev-sans-first:20.30 06:31:11 INFO - PROCESS | 2630 | Values: 95.0 97.0 135.0 80.0 77.0 94.0 114.0 79.0 80.0 113.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:85.00 stddev:13.47 (15.9%) stddev-sans-first:14.27 06:31:11 INFO - PROCESS | 2630 | Values: 87.0 83.0 87.0 84.0 127.0 83.0 87.0 83.0 86.0 83.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:31:11 INFO - PROCESS | 2630 | Values: 92.0 93.0 93.0 94.0 93.0 92.0 93.0 93.0 93.0 92.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.50 stddev:1.43 (1.6%) stddev-sans-first:1.50 06:31:11 INFO - PROCESS | 2630 | Values: 86.0 88.0 88.0 85.0 88.0 87.0 86.0 88.0 86.0 84.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.01 (5.5%) stddev-sans-first:3.16 06:31:11 INFO - PROCESS | 2630 | Values: 57.0 55.0 55.0 53.0 60.0 54.0 54.0 62.0 55.0 53.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.00 stddev:4.07 (5.9%) stddev-sans-first:4.18 06:31:11 INFO - PROCESS | 2630 | Values: 67.0 70.0 69.0 81.0 71.0 68.0 69.0 68.0 68.0 68.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.70 (2.0%) stddev-sans-first:1.80 06:31:11 INFO - PROCESS | 2630 | Values: 83.0 85.0 84.0 79.0 84.0 83.0 84.0 83.0 85.0 83.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:134.00 stddev:12.42 (9.3%) stddev-sans-first:13.02 06:31:11 INFO - PROCESS | 2630 | Values: 125.0 136.0 111.0 110.0 143.0 132.0 131.0 128.0 147.0 140.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:140.50 stddev:11.33 (8.1%) stddev-sans-first:12.00 06:31:11 INFO - PROCESS | 2630 | Values: 140.0 131.0 139.0 171.0 146.0 130.0 142.0 140.0 141.0 138.0 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - PROCESS | 2630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.51 (2.2%) stddev-sans-first:0.87 06:31:11 INFO - PROCESS | 2630 | Values: 72.0 68.0 69.0 68.0 69.0 68.0 67.0 67.0 67.0 69.0 06:31:11 INFO - PROCESS | 2630 | -------- Summary: end -------- 06:31:11 INFO - PROCESS | 2630 | 06:31:11 INFO - TEST-INFO | 2630: exit 0 06:31:11 INFO - TEST-OK | kraken | took 56848ms 06:31:11 INFO - SUITE-END | took 1170s 06:31:12 INFO - Completed test suite (00:19:30) 06:31:12 INFO - javascript benchmark 06:31:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2842.7441530262277, 3324.0194142727896, 3427.108951672564, 3465.2549701814105, 3500.947485787712, 4645.3960985071935, 5521.751521181546, 5608.2428872102255, 5609.242752228448, 5656.57575681824, 5662.094064949609, 5668.348139963905, 5791.652500849952, 5799.681017544033, 5844.064949608063, 4179.787861520171, 5033.421156566987, 5048.318477005603, 5086.567641750456, 5241.344831896013, 5164.793408263665, 5171.663841850286, 5198.428172900978, 5218.373795144588, 5232.189010703347, 4769.904601907977, 5005.199168133117, 5081.74591270435, 5134.0, 5144.356955380577, 5113.693178409308, 5118.948810511922, 5121.334226550524, 5130.615203859726, 5142.742862856842, 5069.898602027975, 5089.44016158226, 5092.134337162654, 5111.028904508132, 5122.615803814729, 5470.781168753245, 5586.162075688639, 5594.160875868612, 5680.11958146488, 5682.54539636828, 6192.071189321638, 6192.473639740628, 6196.256449226076, 6197.845053873644, 6199.659018753967, 6210.7826226082325, 6281.623102613858, 6282.277538083134, 6287.182666253358, 6304.936950630481, 5639.520640745542, 5748.913766293551, 5762.481376676077, 5782.971085144632, 5853.473187413153, 6253.249610046823, 6256.343083976117, 6262.436380725665, 6279.309275979638, 6286.245650521875, 6051.394860513913, 6102.603330783485, 6114.847128821815, 6130.724117414727, 6131.724072416752, 6078.270607527125, 6111.834843226297, 6145.569810113249, 6155.692215389213, 6174.475169610633, 6112.680125321883, 6126.4694000708, 6145.661988590581, 6149.84625384369, 6151.108089327112, 6149.8155055347515, 6150.7232174552255, 6152.077188421773, 6154.78458253959, 6163.8150855474405, 4806.543378379049, 4823.397075365579, 4856.611471082305, 4867.63492738039, 4881.755912204447, 4373.584509471595, 4456.5766252205985, 4475.597196252353, 4476.1495315890525, 4479.081788233404, 4840.903181936342, 5582.162675598612, 5615.017371959891, 5617.466340697627, 5647.068233741469, 6148.569600127948, 6208.596441231305, 6232.065190221503, 6240.7503699852405, 6246.406591373812, 5654.943450565524, 5657.971710141423, 5669.461401166883, 5680.517156041783, 5690.374058853523, 5163.948360516347, 5232.633715639945, 5240.868978275574, 5266.631335806457, 5346.0, 6232.75068997235, 6240.687965601611, 6254.186955695731, 6256.749730010749, 6280.0893870389455, 6198.876022479435, 6207.782727604512, 6210.5031597473, 6211.099390588249, 6225.28409232944, 6161.291451483136, 6184.845378865384, 6260.029695397221, 6271.937280627135, 6287.434130928238, 6129.785457508966, 6150.384961503813, 6151.661658608819, 6155.84610384744, 6174.722137503733, 6222.408871157233, 6240.12638230639, 6250.874982500415, 6252.874942501216, 6261.123442718114, 5929.436703513159, 6035.0, 6097.725602347994, 6103.277060575968, 6113.29387775398, 4511.70673906195, 5455.890882182255, 5564.914841605848, 6025.0, 6028.457438830526, 5793.188953546422, 5860.472557469848, 5900.616459930091, 5915.526757859275, 5932.406759324033, 5945.554083443672, 6095.922000763747, 6096.390360963868, 6102.883130681719, 6120.938790612215, 4878.487758785276, 4879.463259041574, 5947.613405128653, 5963.70181490915, 5971.0], "unit": "score", "name": "dojo.html", "value": 5608.21719227735}, {"lowerIsBetter": false, "replicates": [468.52444768559894, 476.679597514884, 578.9289813844389, 624.8344188789971, 642.8971364581666, 36359.0, 40085.99999999996, 40167.79916100419, 40201.19597608053, 40245.19509609806, 42938.0, 43153.0, 43232.135357292835, 43265.91835204114, 43323.78338108313, 9565.521723913795, 9791.706248812512, 9801.950990245039, 9802.852957205647, 9809.50952452378, 9623.807523849518, 9730.367526110815, 9777.41335519871, 9869.802603947917, 9883.802323953516, 9869.802603947917, 9938.900610993906, 9944.453055082004, 9945.850812237823, 9949.801003979916, 9837.852432213522, 9911.653092141813, 9913.90086099137, 9931.30480866336, 9940.80118397628, 9687.0, 9823.115919567274, 9825.950870245675, 9830.508474576314, 9837.803243935154, 41664.79167604173, 41980.1603967922, 42026.579734202875, 42043.78978105121, 42086.78956605228, 3192.1062102611304, 3211.0687900508824, 3241.465158248886, 3298.5711857458377, 3648.343298206322, 28830.423391532262, 28842.567361489593, 29459.0, 29980.400391992258, 30192.84903575468, 2714.09077958884, 2750.7661848742882, 2774.819636723627, 2791.7627001704877, 2865.785066120049, 473527.0, 474226.0, 475112.62443687906, 475996.0, 476288.0, 45536.54463455323, 46224.075518489444, 46226.76886615546, 66337.0, 66678.0, 45407.772961134986, 45706.08587828225, 45853.54146458493, 46010.07979840384, 46170.459544854835, 15375.769363459556, 15574.221288935509, 15584.298706558233, 15594.986325888782, 15601.765973510406, 12522.624321270376, 12599.622011339674, 12600.495980160691, 12612.621621351374, 12626.179298345578, 14736.0, 14911.254437278092, 14951.1776852272, 14965.551033469013, 15055.247237638074, 6080.2399700037495, 6204.193454850931, 6355.966090850883, 6378.521610879203, 6380.840478988062, 937.554661535765, 958.3291695812959, 991.2961797123978, 999.9350042247231, 1032.9896701033044, 29895.551566726517, 30111.09666710002, 31407.84296078505, 31438.528422073687, 32015.87944421934, 1080.3679847289425, 1080.8540846985557, 1110.5502271580024, 1115.369816053927, 1150.1718762490993, 14706.705865882837, 14822.62943426423, 14847.851521484863, 15229.847701522844, 15264.084154950739, 410537.0, 524835.0, 528672.0, 531718.0, 533184.0, 58856.41143588595, 59459.405405945385, 59483.10775338373, 59559.702201489585, 59578.40421595815, 1334.426196735413, 1364.2973868457752, 1472.5950363649868, 1476.852314768536, 1502.3765137467828, 29004.694788734978, 29311.85344073266, 29642.703572963994, 29682.851585741933, 29864.552031719108, 48395.0, 48630.75684621554, 48905.755471222416, 48966.0, 49230.50769492259, 364379.0, 371257.0, 372385.0, 372966.0, 373639.0, 33356.833215833765, 33507.66492335046, 33672.0, 34245.657543425245, 34279.48580771241, 44849.55150448454, 45467.772661136485, 45830.54169458263, 46415.53584464112, 46603.0, 31301.0, 36213.91358259256, 37705.43441848319, 38364.04089897775, 38721.4191787129, 28805.7119428803, 36488.635113648525, 36844.26311473809, 37516.81241593884, 37589.872303830925, 29762.553561697026, 31516.369672606877, 37230.44154337633, 37358.06604834901, 37382.0, 29337.413251735274, 30883.0, 30947.845260773553, 30955.0, 30959.380812383177, 22666.660000100343, 23394.0, 23875.76124238805, 24241.51516969686, 24249.0], "unit": "score", "name": "ext.html", "value": 19081.583911811416}, {"lowerIsBetter": false, "replicates": [328.4268950681062, 360.5871277387391, 362.47260236356124, 363.81627278224494, 375.44059351566176, 18497.16762745676, 19618.56675081862, 19855.702164467508, 19885.701714474293, 19888.40334789955, 18140.546486337847, 19394.515137121543, 20057.799422005777, 20064.0, 20091.0, 5708.77164913404, 5875.735591898375, 5923.644581325134, 5930.851728706773, 5932.555058370618, 5667.716614169296, 5877.059670452729, 5911.231539899829, 5946.197263369433, 5949.1968584241, 5819.388964158766, 5850.122481627747, 5864.648121112726, 5873.559483038768, 5877.559183061266, 5510.531604813596, 5751.597388182829, 5836.0, 5852.444017818321, 5854.414558544154, 4951.232558953368, 5009.123403404426, 5010.0981823271795, 5013.573846223039, 5013.774380152865, 25204.495910081878, 25221.0, 25313.493730125294, 25538.489230215477, 25547.48905021908, 2133.839962002856, 2213.4687674957895, 2229.977700222993, 2425.454272788626, 3038.8176709397508, 6694.129763130762, 6722.159730033746, 6764.763233286861, 7564.773056808304, 14572.296917513522, 1716.159082049799, 1727.4731206981864, 1743.747156662277, 1773.2906837265198, 1799.5051360875732, 95092.0, 95438.52280738621, 97940.51029744805, 98061.0, 98709.0, 10039.4478303694, 10286.845697314397, 10309.94845025785, 10428.37429754202, 10459.163266938627, 12737.808932866015, 12822.35888205586, 12856.935715321551, 12862.614121576367, 12888.162269452456, 8211.384146189059, 8360.874586881202, 8375.95812020936, 8464.40749147566, 8474.915250847536, 8568.742937711879, 8573.399862009725, 8580.399372043898, 8676.002259740084, 8799.076097009722, 5951.791687290924, 6050.0, 6063.151158837766, 6065.451710749173, 6120.60216085953, 1657.7815305750505, 1781.385422029398, 1803.8083728270215, 1812.9002904840097, 1817.7727784026997, 830.4311546590604, 902.6660135749814, 1009.4548943570536, 1052.5737076484036, 1062.2757942225692, 20534.794652053588, 20637.0, 21502.354929352143, 21715.674264886038, 21719.239826605994, 940.9764755881158, 984.0, 995.5619527407918, 1021.0657248617432, 1031.4636389077637, 10573.0, 11424.42877856104, 11518.654440366803, 11541.538338466535, 11585.6524304271, 511861.0, 581358.0, 591999.0, 617788.0, 623753.0, 73000.0, 88970.0, 94859.0, 116581.0, 123534.0, 1037.3775734559356, 1058.439027315524, 1075.3494136047734, 1079.6707004363902, 1080.02797482265, 17832.32515122742, 18305.359312424, 18348.449546513624, 18474.353397631017, 18519.35182268614, 50251.49748502468, 50551.74724126356, 51113.0, 51436.0, 51532.0, 72761.27238727757, 72933.27066729477, 73867.0, 74015.0, 74353.6282318585, 7542.660580273791, 7698.807529811799, 7722.339696965179, 7814.492058016211, 7990.121086680577, 10616.416097114732, 11994.520219191134, 12269.325187114795, 12362.567310144103, 12500.624981250578, 10300.742481437725, 10756.462176890967, 10916.01755841978, 10955.726106847393, 11062.778744425228, 10624.246999245039, 10632.468376580986, 10751.731206719582, 10787.298825576627, 11024.889751102708, 9292.535373231176, 10842.0, 10979.890201098206, 11114.166437517057, 11172.273802202832, 7498.812529686801, 7563.621818909142, 7686.3082322591235, 7732.226777322223, 7838.686452541834, 9192.54037298119, 10713.410762408143, 10726.624568140078, 10940.452977350942, 10956.397398142859], "unit": "score", "name": "jquery.html", "value": 9273.880483907518}, {"lowerIsBetter": false, "replicates": [1445.877100446462, 1603.8957467764594, 1629.5437277562282, 1913.6651086059935, 2041.5712700332929, 8121.309688676462, 8661.307095432367, 8852.822943541125, 8882.333824963129, 8885.733427997155, 8518.446300990432, 8770.386072974894, 8777.648894044247, 8785.033646298902, 8801.0, 1941.1847024249848, 2002.9284332881912, 2235.228846048119, 2451.3503921460783, 2482.937926551833, 2415.6618073469726, 2474.393773525489, 2475.4306509502735, 2481.131603938625, 2481.727010028895, 2406.193925035115, 2430.1008626808107, 2479.231438254147, 2497.8001759859258, 2519.370157460635, 2461.2247142150345, 2485.689288838895, 2497.2882728422496, 2512.648229247907, 2513.6606558114786, 2465.7287698353166, 2488.701355837293, 2497.1509686706427, 2497.1509686706427, 2517.5216708825265, 8872.245859101984, 8920.0, 8928.910710892873, 8937.553122343857, 8942.955285223597, 4790.496997815214, 5501.312335958005, 5609.439056094398, 5659.122835960392, 5662.943370566283, 3240.8865689700747, 3608.548931383577, 3622.2936527377174, 3775.716821238418, 3788.7916164610933, 1051.6371851711147, 1061.6921092883056, 1067.4929408530963, 1076.2036093290988, 1076.962306319275, 12117.27296362221, 12135.817962730565, 12141.332226727527, 12143.271403715806, 12143.392830358534, 4849.95150048495, 4865.878353041131, 4919.385076865392, 4952.257161425815, 4966.801327946914, 10322.896771032343, 10331.966803319758, 10338.431386273827, 10341.431221282752, 10357.63748268807, 5590.105583106683, 5591.832245032656, 5594.244776955059, 5602.915956260659, 5607.467290607386, 4473.530279320689, 4600.700954437951, 4841.491643377394, 4909.2881532177635, 5070.721110338966, 3822.9235415291537, 3895.7078219133114, 3909.237698648736, 3910.787655826703, 3956.742811717229, 1306.719055403074, 1312.9080964332595, 1318.960431187066, 1328.5482935801874, 1328.9601311960657, 1233.7224124572078, 1276.5213045108085, 1284.229462322599, 1285.4279845468677, 1299.4347458855427, 8138.308243799225, 8289.129641387688, 8298.751037468886, 8303.8339233215, 8323.95838020806, 518.1805667538548, 526.8472143078465, 535.0769921884795, 538.7979507684619, 539.3231494474488, 6267.6866156692895, 6283.497320214372, 6308.179936608211, 6316.905246421307, 6326.778562750282, 10246.6413675521, 10721.571137154582, 10741.979511946352, 10752.516136773707, 10752.677419677422, 10439.478026098664, 10559.102476289449, 10619.20355973305, 10631.574737010587, 10638.361698297973, 8238.670453181925, 8320.791980200544, 8344.916550834536, 8380.329573634095, 8396.286315663116, 6458.483321334376, 7881.527108373516, 7890.0, 7942.920570794449, 7948.16544262844, 7951.244631759973, 9404.38871473352, 9537.14165725088, 9628.855567166358, 9636.903630963881, 9330.393524420891, 9709.70870873875, 9710.077542633438, 9813.264005199495, 9934.950325248328, 6828.760993365208, 6896.689648965708, 7435.925640743523, 7495.662695178621, 7625.351845093007, 8237.50574965504, 8351.916480835114, 8362.121977192308, 8368.790780230544, 8374.162583741578, 7265.891011634724, 7325.304096110861, 7503.737369192052, 7504.137024242282, 7507.66215520292, 7248.855022899407, 7309.195988441374, 7315.670794814353, 7343.669534870837, 7433.145188303198, 7801.414893882868, 7828.256315650005, 7845.215478452109, 7846.17615150401, 7896.0, 6972.742734453567, 7055.929440705528, 7104.0, 7113.786586402416, 7116.715331386687, 7164.032855564432, 7246.0, 7252.38354739853, 7254.5647261164495, 7270.418366530771], "unit": "score", "name": "mootools.html", "value": 4860.001435517209}, {"lowerIsBetter": false, "replicates": [321.163369422654, 325.762193598673, 329.586369106771, 332.3270377485593, 337.492074427986, 6539.346065393458, 6541.149650545434, 6555.099021283828, 6567.507436942236, 6594.934050659492, 6525.902111468332, 6531.836704082389, 6547.624998750256, 6550.475961923046, 6564.671766411684, 4599.517050709677, 4696.600788932928, 4707.152712511746, 4731.432228132629, 4826.638002149844, 4803.519648035203, 4807.1587472192405, 4830.758462076899, 4834.2990266411525, 4850.223964165734, 4387.1225754849, 4533.727976321431, 4748.050389922012, 4772.188727916246, 4773.952260477386, 4579.610733087691, 4652.883308006054, 4699.154152252593, 4768.403949506329, 4785.90428191436, 4054.209429161315, 4054.6958978076764, 4113.115680128787, 4114.218298523271, 4122.649574786146, 5070.3915530136255, 6465.0, 6467.644279564622, 6476.579022363531, 6493.253275873288, 5742.511886489653, 5746.396628354046, 5746.683932383718, 5756.510696590794, 5775.884482310373, 7044.753433629799, 7060.435165186773, 7075.681594328267, 7076.575405475636, 7077.964610176916, 4547.909041819178, 4715.386999690053, 4719.386479757643, 4764.475907650156, 4774.594159496447, 6089.208402907594, 7258.947452619341, 7390.926090739077, 7422.6288685565505, 7451.664675089634, 4766.4280286365165, 4786.401699787527, 4786.497417771084, 4793.880152996203, 4806.567408933143, 4854.5873600744335, 4857.198562237262, 4876.634252431082, 4880.633952453581, 4892.510748925079, 4859.222524396079, 5565.471280228372, 5724.484796368347, 5740.512056475163, 5744.0, 6799.252082270947, 7080.079589653312, 7086.964565177141, 7137.857242855218, 7151.678174482161, 1689.6789609974312, 1695.5422036050197, 1710.4868539438366, 1711.2898147268993, 1716.5279548124365, 987.151050096916, 1042.9674622124194, 1095.4741723972538, 1114.0641860836936, 1117.8379135025539, 6383.808485745435, 6537.411632953057, 6629.801105966829, 6646.534742567974, 6666.133402657721, 7219.458540609476, 7448.851022979618, 7451.515651482637, 7476.1776204617445, 7479.813004674927, 6717.2946840581035, 6738.764143255061, 6826.488013398915, 6844.555103918229, 6867.381935625817, 3869.7484663496784, 3919.5884432134217, 3925.842966281317, 3926.980365098156, 3927.3127202739406, 6364.586301890362, 7402.666879990414, 7743.92256077432, 7744.961275193588, 7761.534307941542, 6395.936040639627, 7150.177729561063, 7502.287282708134, 7533.962330188314, 7557.584332861746, 7637.579933103732, 7752.224777522316, 7761.8447631047065, 7762.650680719268, 7769.417293702995, 7388.298111679382, 7413.925860741324, 7423.8144046399275, 7427.331540161412, 7431.628418578941, 7013.438924885895, 7278.308560686726, 7284.089488813898, 7287.0, 7302.306280903305, 7706.7687969361, 7711.11322197932, 7743.0, 7777.688892444466, 7779.494332868346, 3789.6399842014966, 4637.3739545162325, 4643.187442197669, 4645.814167433265, 4656.813727451, 7375.11498620169, 7384.741534046282, 7396.4082873368925, 7398.96300518494, 7404.777856664308, 6905.447564194752, 7169.856602868018, 7172.354488096096, 7199.1001124859395, 7216.242294558996, 6579.769708060195, 7099.183593886562, 7138.214796372291, 7143.178534468395, 7168.9605007274695, 6294.43350098475, 6999.965000174967, 7000.334968178015, 7021.473389495911, 7027.543209691558, 7189.71241150369, 7194.496385252982, 7196.352328290479, 7197.740395430884, 7202.495825292389, 5608.523275521627, 6683.498737594603, 6767.593944363354, 7045.647717614202, 7046.647667616701], "unit": "score", "name": "prototype.html", "value": 5171.0768020301775}, {"lowerIsBetter": false, "replicates": [680.9455243580514, 710.126544350449, 711.5730561663006, 717.5730440387969, 770.9922900770994, 15005.699886002274, 15206.0, 15214.163221022853, 15231.0, 15252.389904403824, 13818.378172982215, 13854.307284635779, 14163.645908852284, 14328.928355358235, 14345.067570607904, 656.6651007985914, 760.39168665068, 910.9498977556249, 931.1433481197315, 939.4973689076346, 927.1655510040949, 927.5918595817852, 932.2681694869528, 932.3380399916068, 937.2221056523103, 978.3885071830106, 985.1773768902974, 985.7486340983039, 986.9981968302143, 996.7707427291728, 770.9113451953014, 789.128013545036, 790.5217343507153, 966.2077096780572, 985.5614251658016, 722.5736815278958, 724.102113379411, 724.4457989637931, 725.1370868666323, 731.228553875661, 14859.108453492825, 14923.179225142612, 14954.62613434662, 14960.177190254532, 14968.775468367983, 12282.754344913052, 12336.876631233663, 12408.007359411225, 12526.060545459128, 12556.497740090386, 9831.410115393099, 10070.395776253448, 10117.241206909437, 10135.037171468699, 10434.0, 3466.6879980801596, 3500.2474467989505, 3527.876524321662, 3546.042568506489, 3594.748367614268, 78365.60817195935, 79230.0, 80799.5960020202, 81361.59319203366, 81786.59106704428, 9425.717228483156, 9492.050794920591, 9507.33448658601, 9760.902390976, 9876.65431709901, 22269.0, 22302.442438938833, 22354.441138971655, 22355.888220558794, 22362.55274894493, 7333.853322933618, 7401.703931842773, 7447.88828167578, 7524.774256772305, 7610.391168706601, 3953.2488827122756, 4020.0150963013666, 4021.2158629067053, 4032.5564187939303, 4046.109855831712, 3489.8953031409096, 3545.2023294758988, 3547.0600290922926, 3553.200529880756, 3554.289142171576, 644.9193850768654, 651.4853265919965, 662.7017841971036, 672.9938741581269, 682.4199430484049, 539.9352077750696, 589.5254320272222, 592.6473748119948, 596.3916804859106, 600.474584738354, 7851.882221766678, 7979.241972012649, 7982.68069277234, 8226.753197404087, 8330.958345208357, 529.219401382957, 569.1548051144048, 576.700115939709, 603.5533705058225, 620.8261686727724, 3733.0667333166707, 3805.0677583991546, 3870.1679138985255, 3878.6897048236074, 3897.162110146332, 96339.0, 96504.0, 98623.0, 98717.50641246748, 98805.0, 83488.0, 83571.74642380369, 84428.0, 84823.57588212143, 88416.0, 72387.0, 73191.0, 73276.0, 73648.63175684087, 74177.0, 7723.575203363869, 8095.595220239083, 8248.83502329962, 8298.751037468886, 8357.206065423776, 48446.51553484561, 48576.0, 48797.0, 49041.754791225816, 51637.0, 62799.6860015697, 65439.67280163569, 66664.66667666825, 69394.0, 69566.65216673884, 11084.113270938144, 11184.0, 11187.32876027441, 11489.138314626269, 11529.0, 11943.522259109886, 11954.222975506564, 12017.09871759604, 12110.515579376726, 12159.635210943687, 9680.612775489184, 11365.31808091517, 11366.0, 11873.881261187278, 11950.641480755592, 11304.378259195495, 11322.37726925027, 11591.420428978687, 11805.0, 12264.32546209967, 10180.847287290844, 11089.390083545482, 11389.0, 11431.657050288504, 11655.708607284547, 9486.383385079947, 9633.710988670351, 9687.418754874448, 10062.798744025225, 10079.244056695923, 9545.236381089357, 9657.179139773198, 9699.66051188205, 9703.175230105238, 9730.172935300296], "unit": "score", "name": "yui.html", "value": 6938.743294324842}], "name": "dromaeo_css", "value": 7465.154624704269}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 112.0, 110.0, 112.0, 111.0, 116.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 143.0, 162.0, 103.0, 147.0, 161.0, 149.0, 197.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 187.0, 181.0, 183.0, 184.0, 223.0, 264.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 195.3}, {"lowerIsBetter": true, "replicates": [81.0, 77.0, 83.0, 82.0, 56.0, 60.0, 57.0, 76.0, 77.0, 54.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 135.0, 80.0, 77.0, 94.0, 114.0, 79.0, 80.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 96.4}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 87.0, 84.0, 127.0, 83.0, 87.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.8}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 88.0, 85.0, 88.0, 87.0, 86.0, 88.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 53.0, 60.0, 54.0, 54.0, 62.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 69.0, 81.0, 71.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 79.0, 84.0, 83.0, 84.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [125.0, 136.0, 111.0, 110.0, 143.0, 132.0, 131.0, 128.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [140.0, 131.0, 139.0, 171.0, 146.0, 130.0, 142.0, 140.0, 141.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 69.0, 68.0, 69.0, 68.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1439.6999999999998}]} 06:31:12 INFO - Return code: 0 06:31:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:31:12 ERROR - # TBPL SUCCESS # 06:31:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:31:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:31:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:31:12 INFO - 2016-03-30 06:31:12.496 screenresolution[2634:38738] starting screenresolution argv=screenresolution get 06:31:12 INFO - 2016-03-30 06:31:12.498 screenresolution[2634:38738] Display 0: 1600x1200x32@60 06:31:12 INFO - 2016-03-30 06:31:12.504 screenresolution[2635:38741] starting screenresolution argv=screenresolution list 06:31:12 INFO - Available Modes on Display 0 06:31:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:31:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:31:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:31:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:31:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:31:12 INFO - Intel Iris: 06:31:12 INFO - Chipset Model: Intel Iris 06:31:12 INFO - Type: GPU 06:31:12 INFO - Bus: Built-In 06:31:12 INFO - VRAM (Dynamic, Max): 1536 MB 06:31:12 INFO - Vendor: Intel (0x8086) 06:31:12 INFO - Device ID: 0x0a2e 06:31:12 INFO - Revision ID: 0x0009 06:31:12 INFO - Displays: 06:31:12 INFO - Display: 06:31:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:31:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:31:12 INFO - Display Serial Number: 1600x1200 60 06:31:12 INFO - Main Display: Yes 06:31:12 INFO - Mirror: Off 06:31:12 INFO - Online: Yes 06:31:12 INFO - Rotation: Supported 06:31:12 INFO - Return code: 0 06:31:12 INFO - Running post-action listener: _resource_record_post_action 06:31:12 INFO - Running post-run listener: _resource_record_post_run 06:31:13 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 147456; Write bytes: 703028736; Read time: 1; Write time: 2164 06:31:13 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394025472; Write bytes: 389613568; Read time: 29602; Write time: 808 06:31:13 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 147456; Write bytes: 296027648; Read time: 1; Write time: 1311 06:31:13 INFO - Running post-run listener: _upload_blobber_files 06:31:13 INFO - Blob upload gear active. 06:31:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:31:13 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 06:31:13 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'] 06:31:13 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 06:31:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:14 INFO - (blobuploader) - INFO - Done attempting. 06:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:15 INFO - (blobuploader) - INFO - Done attempting. 06:31:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:31:15 INFO - Return code: 0 06:31:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:31:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:31:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b1f0ed9069ff666bbb278c3d03a05a2940f0125bfdf18696a00029ab123058be9a07dbbbf2144491d8efb0837d8a37845d26b1affa5d7e2a8168ada21f656db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/638dccb72777c17e59768fed8d7a16dc5d732177cf79e6845a97a9c4f2ccec2d57b290494228963d5102ba0a5a46d272a5329d8facc88817bb7d85084232d9c9"} 06:31:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:31:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:31:15 INFO - Contents: 06:31:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b1f0ed9069ff666bbb278c3d03a05a2940f0125bfdf18696a00029ab123058be9a07dbbbf2144491d8efb0837d8a37845d26b1affa5d7e2a8168ada21f656db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/638dccb72777c17e59768fed8d7a16dc5d732177cf79e6845a97a9c4f2ccec2d57b290494228963d5102ba0a5a46d272a5329d8facc88817bb7d85084232d9c9"} 06:31:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:31:15 INFO - Copying logs to upload dir... 06:31:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:31:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.654593 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-30 06:31:15.897374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 06:31:15.900418) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/0b1f0ed9069ff666bbb278c3d03a05a2940f0125bfdf18696a00029ab123058be9a07dbbbf2144491d8efb0837d8a37845d26b1affa5d7e2a8168ada21f656db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/638dccb72777c17e59768fed8d7a16dc5d732177cf79e6845a97a9c4f2ccec2d57b290494228963d5102ba0a5a46d272a5329d8facc88817bb7d85084232d9c9"} build_url:https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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/0b1f0ed9069ff666bbb278c3d03a05a2940f0125bfdf18696a00029ab123058be9a07dbbbf2144491d8efb0837d8a37845d26b1affa5d7e2a8168ada21f656db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/638dccb72777c17e59768fed8d7a16dc5d732177cf79e6845a97a9c4f2ccec2d57b290494228963d5102ba0a5a46d272a5329d8facc88817bb7d85084232d9c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 06:31:15.928054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:31:15.928351) ========= 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.eijT9YzCtI/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.kzRMA9lcFP/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005499 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:31:16.032983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 06:31:16.033311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 06:31:16.092729) ========= ========= Total master_lag: 0.35 =========