builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0015 starttime: 1460610741.73 results: success (0) buildid: 20160413210420 builduid: 97a3828d77174786a51866ac0c796004 revision: 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.731190) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.731652) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.731941) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.004918 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.755217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.755502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.773206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.773531) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005759 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.821892) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.822194) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.822554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:21.822823) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-13 22:12:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 52.6M=0s 2016-04-13 22:12:22 (52.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:22.040033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:22.040360) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.026644 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:22.088826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 22:12:22.089180) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 --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 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-13 22:12:22,167 truncating revision to first 12 chars 2016-04-13 22:12:22,167 Setting DEBUG logging. 2016-04-13 22:12:22,167 attempt 1/10 2016-04-13 22:12:22,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/04f9767b4abe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 22:12:23,025 unpacking tar archive at: fx-team-04f9767b4abe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.107099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 22:12:23.212879) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:23.213289) ========= echo 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'04f9767b4abe6e33d294b89ab29ae5c1b2b67484'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 program finished with exit code 0 elapsedTime=0.005162 script_repo_revision: '04f9767b4abe6e33d294b89ab29ae5c1b2b67484' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:23.263697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:23.263998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:12:23.278267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-13 22:12:23.278779) ========= /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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:23 INFO - MultiFileLogger online at 20160413 22:12:23 in /builds/slave/test 22:12:23 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 22:12:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:23 INFO - {'append_to_log': False, 22:12:23 INFO - 'base_work_dir': '/builds/slave/test', 22:12:23 INFO - 'blob_upload_branch': 'Fx-Team', 22:12:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:23 INFO - 'branch': 'Fx-Team', 22:12:23 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:23 INFO - 'config_files': ('talos/mac_config.py',), 22:12:23 INFO - 'default_actions': ('clobber', 22:12:23 INFO - 'read-buildbot-config', 22:12:23 INFO - 'download-and-extract', 22:12:23 INFO - 'populate-webroot', 22:12:23 INFO - 'create-virtualenv', 22:12:23 INFO - 'install', 22:12:23 INFO - 'run-tests'), 22:12:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:23 INFO - 'download_minidump_stackwalk': True, 22:12:23 INFO - 'download_symbols': 'ondemand', 22:12:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:23 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:23 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:23 INFO - 'installer_path': 'installer.exe', 22:12:23 INFO - 'log_level': 'info', 22:12:23 INFO - 'log_name': 'talos', 22:12:23 INFO - 'log_to_console': True, 22:12:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:12:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:12:23 INFO - 'opt_config_files': (), 22:12:23 INFO - 'pip_index': False, 22:12:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:12:23 INFO - 'cmd': ('bash', 22:12:23 INFO - '-c', 22:12:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:12:23 INFO - 'enabled': True, 22:12:23 INFO - 'halt_on_failure': False, 22:12:23 INFO - 'name': 'check_screen_resolution'},), 22:12:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:12:23 INFO - 'cmd': ('bash', 22:12:23 INFO - '-c', 22:12:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:12:23 INFO - 'enabled': True, 22:12:23 INFO - 'halt_on_failure': False, 22:12:23 INFO - 'name': 'check_screen_resolution'},), 22:12:23 INFO - 'run_cmd_checks_enabled': True, 22:12:23 INFO - 'sps_profile': False, 22:12:23 INFO - 'sps_profile_interval': 0, 22:12:23 INFO - 'suite': 'dromaeojs', 22:12:23 INFO - 'system_bits': '32', 22:12:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:23 INFO - 'title': 't-yosemite-r7-0015', 22:12:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:23 INFO - 'use_talos_json': True, 22:12:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:23 INFO - 'work_dir': 'build'} 22:12:23 INFO - ##### 22:12:23 INFO - ##### Running clobber step. 22:12:23 INFO - ##### 22:12:23 INFO - Running pre-action listener: _resource_record_pre_action 22:12:23 INFO - Running main action method: clobber 22:12:23 INFO - rmtree: /builds/slave/test/build 22:12:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:25 INFO - Running post-action listener: _resource_record_post_action 22:12:25 INFO - ##### 22:12:25 INFO - ##### Running read-buildbot-config step. 22:12:25 INFO - ##### 22:12:25 INFO - Running pre-action listener: _resource_record_pre_action 22:12:25 INFO - Running main action method: read_buildbot_config 22:12:25 INFO - Using buildbot properties: 22:12:25 INFO - { 22:12:25 INFO - "project": "", 22:12:25 INFO - "product": "firefox", 22:12:25 INFO - "script_repo_revision": "production", 22:12:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:12:25 INFO - "repository": "", 22:12:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:12:25 INFO - "buildid": "20160413210420", 22:12:25 INFO - "pgo_build": "False", 22:12:25 INFO - "basedir": "/builds/slave/test", 22:12:25 INFO - "buildnumber": 616, 22:12:25 INFO - "slavename": "t-yosemite-r7-0015", 22:12:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:12:25 INFO - "platform": "yosemite_r7", 22:12:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:12:25 INFO - "branch": "fx-team", 22:12:25 INFO - "repo_path": "integration/fx-team", 22:12:25 INFO - "revision": "04f9767b4abe6e33d294b89ab29ae5c1b2b67484", 22:12:25 INFO - "stage_platform": "macosx64", 22:12:25 INFO - "builduid": "97a3828d77174786a51866ac0c796004", 22:12:25 INFO - "slavebuilddir": "test" 22:12:25 INFO - } 22:12:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:12:25 INFO - Running post-action listener: _resource_record_post_action 22:12:25 INFO - ##### 22:12:25 INFO - ##### Running download-and-extract step. 22:12:25 INFO - ##### 22:12:25 INFO - Running pre-action listener: _resource_record_pre_action 22:12:25 INFO - Running main action method: download_and_extract 22:12:25 INFO - mkdir: /builds/slave/test/build/tests 22:12:25 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')]} 22:12:25 INFO - https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:12:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:12:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:12:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:27 INFO - Downloaded 1199 bytes. 22:12:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:12:27 INFO - Using the following test package requirements: 22:12:27 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:12:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:12:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:12:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'jsshell-mac.zip'], 22:12:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:12:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:12:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:12:27 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:12:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:12:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:12:27 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:12:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:27 INFO - https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:28 INFO - Downloaded 18031197 bytes. 22:12:28 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'] 22:12:28 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 22:12:31 INFO - Return code: 0 22:12:31 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 22:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:31 INFO - https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:12:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:12:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:12:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:32 INFO - Downloaded 18031197 bytes. 22:12:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:12:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:12:36 INFO - Return code: 0 22:12:36 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')]} 22:12:36 INFO - https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:37 INFO - Downloaded 10841076 bytes. 22:12:37 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'] 22:12:37 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 22:12:37 INFO - Return code: 0 22:12:37 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')]} 22:12:37 INFO - https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aXf4b9pARVCjBhwO2_oCow/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 22:12:41 INFO - Downloaded 109329023 bytes. 22:12:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:12:41 INFO - mkdir: /builds/slave/test/properties 22:12:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:12:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:12:41 INFO - Contents: 22:12:41 INFO - build_url:https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:12:42 INFO - Running post-action listener: _resource_record_post_action 22:12:42 INFO - Running post-action listener: set_extra_try_arguments 22:12:42 INFO - ##### 22:12:42 INFO - ##### Running populate-webroot step. 22:12:42 INFO - ##### 22:12:42 INFO - Running pre-action listener: _resource_record_pre_action 22:12:42 INFO - Running main action method: populate_webroot 22:12:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:42 INFO - '--tppagecycles', 22:12:42 INFO - '7'], 22:12:42 INFO - 'tests': ['tsvgm']}}, 22:12:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:12:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:12:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['damp', 'tps']}, 22:12:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'tests': ['damp', 'tps']}, 22:12:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['dromaeo_dom']}, 22:12:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:12:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'other-e10s': {'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['a11yr', 22:12:42 INFO - 'ts_paint', 22:12:42 INFO - 'tpaint', 22:12:42 INFO - 'sessionrestore', 22:12:42 INFO - 'sessionrestore_no_auto_restore', 22:12:42 INFO - 'tabpaint']}, 22:12:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['tsvgx', 22:12:42 INFO - 'tsvgr_opacity', 22:12:42 INFO - 'tart', 22:12:42 INFO - 'tscrollx', 22:12:42 INFO - 'cart']}, 22:12:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:12:42 INFO - 'tsvgr_opacity', 22:12:42 INFO - 'tart', 22:12:42 INFO - 'tscrollx', 22:12:42 INFO - 'cart']}, 22:12:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'talos_options': ['--disable-e10s'], 22:12:42 INFO - 'tests': ['tp5o']}, 22:12:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'tests': ['tp5o']}, 22:12:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'talos_options': ['--disable-e10s', 22:12:42 INFO - '--xperf_path', 22:12:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:42 INFO - 'tests': ['tp5n']}, 22:12:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:42 INFO - 'talos_options': ['--xperf_path', 22:12:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:42 INFO - 'tests': ['tp5n']}}, 22:12:42 INFO - 'talos.zip': {'path': '', 22:12:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:42 INFO - Running post-action listener: _resource_record_post_action 22:12:42 INFO - ##### 22:12:42 INFO - ##### Running create-virtualenv step. 22:12:42 INFO - ##### 22:12:42 INFO - Running pre-action listener: _resource_record_pre_action 22:12:42 INFO - Running main action method: create_virtualenv 22:12:42 INFO - Creating virtualenv /builds/slave/test/build/venv 22:12:42 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 22:12:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:12:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:42 INFO - Using real prefix '/tools/python27' 22:12:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:12:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:12:46 INFO - Installing pip.................done. 22:12:46 INFO - Return code: 0 22:12:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:12:46 INFO - 'HOME': '/Users/cltbld', 22:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:12:46 INFO - 'LOGNAME': 'cltbld', 22:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:46 INFO - 'MOZ_NO_REMOTE': '1', 22:12:46 INFO - 'NO_EM_RESTART': '1', 22:12:46 INFO - 'PAGER': '/bin/cat', 22:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:46 INFO - 'PWD': '/builds/slave/test', 22:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:12:46 INFO - 'SHELL': '/bin/bash', 22:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:12:46 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:12:46 INFO - 'USER': 'cltbld', 22:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:46 INFO - 'XPC_FLAGS': '0x0', 22:12:46 INFO - 'XPC_SERVICE_NAME': '0', 22:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:46 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 22:12:46 INFO - Cleaning up... 22:12:46 INFO - Return code: 0 22:12:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:12:46 INFO - 'HOME': '/Users/cltbld', 22:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:12:46 INFO - 'LOGNAME': 'cltbld', 22:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:46 INFO - 'MOZ_NO_REMOTE': '1', 22:12:46 INFO - 'NO_EM_RESTART': '1', 22:12:46 INFO - 'PAGER': '/bin/cat', 22:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:46 INFO - 'PWD': '/builds/slave/test', 22:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:12:46 INFO - 'SHELL': '/bin/bash', 22:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:12:46 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:12:46 INFO - 'USER': 'cltbld', 22:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:46 INFO - 'XPC_FLAGS': '0x0', 22:12:46 INFO - 'XPC_SERVICE_NAME': '0', 22:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:46 INFO - Downloading/unpacking psutil>=0.7.1 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:12:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:49 INFO - Installing collected packages: psutil 22:12:49 INFO - Running setup.py install for psutil 22:12:49 INFO - building 'psutil._psutil_osx' extension 22:12:49 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 22:12:50 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 22:12:50 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 22:12:50 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 22:12:50 INFO - building 'psutil._psutil_posix' extension 22:12:50 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 22:12:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:12:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:12:50 INFO - ^ 22:12:50 INFO - 1 warning generated. 22:12:50 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 22:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:50 INFO - Successfully installed psutil 22:12:50 INFO - Cleaning up... 22:12:51 INFO - Return code: 0 22:12:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:12:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:12:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:12:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:12:51 INFO - 'HOME': '/Users/cltbld', 22:12:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:12:51 INFO - 'LOGNAME': 'cltbld', 22:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:51 INFO - 'MOZ_NO_REMOTE': '1', 22:12:51 INFO - 'NO_EM_RESTART': '1', 22:12:51 INFO - 'PAGER': '/bin/cat', 22:12:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:51 INFO - 'PWD': '/builds/slave/test', 22:12:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:12:51 INFO - 'SHELL': '/bin/bash', 22:12:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:12:51 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:12:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:12:51 INFO - 'USER': 'cltbld', 22:12:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:12:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:51 INFO - 'XPC_FLAGS': '0x0', 22:12:51 INFO - 'XPC_SERVICE_NAME': '0', 22:12:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:12:53 INFO - Installing collected packages: mozsystemmonitor 22:12:53 INFO - Running setup.py install for mozsystemmonitor 22:12:53 INFO - Successfully installed mozsystemmonitor 22:12:53 INFO - Cleaning up... 22:12:54 INFO - Return code: 0 22:12:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:12:54 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')]} 22:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:54 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')]} 22:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:54 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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:54 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 22:12:54 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 22:12:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:12:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:12:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:12:54 INFO - 'HOME': '/Users/cltbld', 22:12:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:12:54 INFO - 'LOGNAME': 'cltbld', 22:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:54 INFO - 'MOZ_NO_REMOTE': '1', 22:12:54 INFO - 'NO_EM_RESTART': '1', 22:12:54 INFO - 'PAGER': '/bin/cat', 22:12:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:54 INFO - 'PWD': '/builds/slave/test', 22:12:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:12:54 INFO - 'SHELL': '/bin/bash', 22:12:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:12:54 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:12:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:12:54 INFO - 'USER': 'cltbld', 22:12:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:12:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:54 INFO - 'XPC_FLAGS': '0x0', 22:12:54 INFO - 'XPC_SERVICE_NAME': '0', 22:12:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:12:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:57 INFO - Downloading docopt-0.6.1.tar.gz 22:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:58 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:58 INFO - Running setup.py install for blobuploader 22:12:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:12:58 INFO - Running setup.py install for requests 22:12:58 INFO - Running setup.py install for docopt 22:12:58 INFO - Successfully installed blobuploader requests docopt 22:12:58 INFO - Cleaning up... 22:12:58 INFO - Return code: 0 22:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:58 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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:12:58 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 22:12:58 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 22:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:12:58 INFO - 'HOME': '/Users/cltbld', 22:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:12:58 INFO - 'LOGNAME': 'cltbld', 22:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:58 INFO - 'MOZ_NO_REMOTE': '1', 22:12:58 INFO - 'NO_EM_RESTART': '1', 22:12:58 INFO - 'PAGER': '/bin/cat', 22:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:58 INFO - 'PWD': '/builds/slave/test', 22:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:12:58 INFO - 'SHELL': '/bin/bash', 22:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:12:58 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:12:58 INFO - 'USER': 'cltbld', 22:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:58 INFO - 'XPC_FLAGS': '0x0', 22:12:58 INFO - 'XPC_SERVICE_NAME': '0', 22:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cjqBnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-j_Cter-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JtLxyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0QfLe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-d2PWj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-HRflw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-WIGpqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-N5mFLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ee67Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-j34LHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-vBW2UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-9NT8_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-yTvJSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-BESGiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Qjpp1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6AlI9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xFlQSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:00 INFO - Running setup.py install for manifestparser 22:13:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:01 INFO - Running setup.py install for mozcrash 22:13:01 INFO - Running setup.py install for mozdebug 22:13:01 INFO - Running setup.py install for mozdevice 22:13:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:01 INFO - Running setup.py install for mozfile 22:13:01 INFO - Running setup.py install for mozhttpd 22:13:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:01 INFO - Running setup.py install for mozinfo 22:13:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Running setup.py install for mozInstall 22:13:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Running setup.py install for mozleak 22:13:02 INFO - Running setup.py install for mozlog 22:13:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Running setup.py install for moznetwork 22:13:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Running setup.py install for mozprocess 22:13:02 INFO - Running setup.py install for mozprofile 22:13:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:02 INFO - Running setup.py install for mozrunner 22:13:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:03 INFO - Running setup.py install for mozscreenshot 22:13:03 INFO - Running setup.py install for moztest 22:13:03 INFO - Running setup.py install for mozversion 22:13:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:03 INFO - Cleaning up... 22:13:03 INFO - Return code: 0 22:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:03 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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:13:03 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 22:13:03 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 22:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:03 INFO - 'HOME': '/Users/cltbld', 22:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:03 INFO - 'LOGNAME': 'cltbld', 22:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:03 INFO - 'MOZ_NO_REMOTE': '1', 22:13:03 INFO - 'NO_EM_RESTART': '1', 22:13:03 INFO - 'PAGER': '/bin/cat', 22:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:03 INFO - 'PWD': '/builds/slave/test', 22:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:03 INFO - 'SHELL': '/bin/bash', 22:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:13:03 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:03 INFO - 'USER': 'cltbld', 22:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:03 INFO - 'XPC_FLAGS': '0x0', 22:13:03 INFO - 'XPC_SERVICE_NAME': '0', 22:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-vV0qt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:03 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)) 22:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-k2ZJ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DG86xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ZWtu12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-KHMdf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kaMtPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6lcAPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-d3rcCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-SqI428-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-QUefIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-LrmiaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:04 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)) 22:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:04 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ULjoZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:05 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)) 22:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:05 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-LE0Ot1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:05 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)) 22:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:05 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-oO9geY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:05 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)) 22:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:05 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mN82zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:05 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)) 22:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:05 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-s7UZPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:05 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)) 22:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:05 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-SRwoye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:05 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)) 22:13:05 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)) 22:13:05 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)) 22:13:05 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)) 22:13:05 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)) 22:13:05 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)) 22:13:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:08 INFO - Downloading blessings-1.6.tar.gz 22:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:08 INFO - Installing collected packages: blessings 22:13:08 INFO - Running setup.py install for blessings 22:13:08 INFO - Successfully installed blessings 22:13:08 INFO - Cleaning up... 22:13:08 INFO - Return code: 0 22:13:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:08 INFO - Reading from file tmpfile_stdout 22:13:08 INFO - Current package versions: 22:13:08 INFO - blessings == 1.6 22:13:08 INFO - blobuploader == 1.2.4 22:13:08 INFO - docopt == 0.6.1 22:13:08 INFO - manifestparser == 1.1 22:13:08 INFO - mozInstall == 1.12 22:13:08 INFO - mozcrash == 0.17 22:13:08 INFO - mozdebug == 0.1 22:13:08 INFO - mozdevice == 0.48 22:13:08 INFO - mozfile == 1.2 22:13:08 INFO - mozhttpd == 0.7 22:13:08 INFO - mozinfo == 0.9 22:13:08 INFO - mozleak == 0.1 22:13:08 INFO - mozlog == 3.1 22:13:08 INFO - moznetwork == 0.27 22:13:08 INFO - mozprocess == 0.22 22:13:08 INFO - mozprofile == 0.28 22:13:08 INFO - mozrunner == 6.11 22:13:08 INFO - mozscreenshot == 0.1 22:13:08 INFO - mozsystemmonitor == 0.0 22:13:08 INFO - moztest == 0.7 22:13:08 INFO - mozversion == 1.4 22:13:08 INFO - psutil == 3.1.1 22:13:08 INFO - requests == 1.2.3 22:13:08 INFO - wsgiref == 0.1.2 22:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:08 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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:13:08 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 22:13:08 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 22:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:08 INFO - 'HOME': '/Users/cltbld', 22:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:08 INFO - 'LOGNAME': 'cltbld', 22:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:08 INFO - 'MOZ_NO_REMOTE': '1', 22:13:08 INFO - 'NO_EM_RESTART': '1', 22:13:08 INFO - 'PAGER': '/bin/cat', 22:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:08 INFO - 'PWD': '/builds/slave/test', 22:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:08 INFO - 'SHELL': '/bin/bash', 22:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:13:08 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:08 INFO - 'USER': 'cltbld', 22:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:08 INFO - 'XPC_FLAGS': '0x0', 22:13:08 INFO - 'XPC_SERVICE_NAME': '0', 22:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 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)) 22:13:08 INFO - Cleaning up... 22:13:09 INFO - Return code: 0 22:13:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:09 INFO - 'HOME': '/Users/cltbld', 22:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:09 INFO - 'LOGNAME': 'cltbld', 22:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:09 INFO - 'MOZ_NO_REMOTE': '1', 22:13:09 INFO - 'NO_EM_RESTART': '1', 22:13:09 INFO - 'PAGER': '/bin/cat', 22:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:09 INFO - 'PWD': '/builds/slave/test', 22:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:09 INFO - 'SHELL': '/bin/bash', 22:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:13:09 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:09 INFO - 'USER': 'cltbld', 22:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:09 INFO - 'XPC_FLAGS': '0x0', 22:13:09 INFO - 'XPC_SERVICE_NAME': '0', 22:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:09 INFO - Downloading/unpacking jsonschema 22:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:12 INFO - warning: no files found matching '*.txt' 22:13:12 INFO - no previously-included directories found matching 'build' 22:13:12 INFO - no previously-included directories found matching 'dist' 22:13:12 INFO - no previously-included directories found matching '.git*' 22:13:12 INFO - Installing collected packages: jsonschema, functools32 22:13:12 INFO - Running setup.py install for functools32 22:13:12 INFO - warning: no files found matching '*.txt' 22:13:12 INFO - no previously-included directories found matching 'build' 22:13:12 INFO - no previously-included directories found matching 'dist' 22:13:12 INFO - no previously-included directories found matching '.git*' 22:13:12 INFO - Successfully installed jsonschema functools32 22:13:12 INFO - Cleaning up... 22:13:12 INFO - Return code: 0 22:13:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:13:12 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')]} 22:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:12 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')]} 22:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:12 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 0x10810aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90bda6940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, '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.xhwpuZGH5m/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.B3Axebkkr5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 22:13:12 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 22:13:12 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 22:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:12 INFO - 'HOME': '/Users/cltbld', 22:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:12 INFO - 'LOGNAME': 'cltbld', 22:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:12 INFO - 'MOZ_NO_REMOTE': '1', 22:13:12 INFO - 'NO_EM_RESTART': '1', 22:13:12 INFO - 'PAGER': '/bin/cat', 22:13:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:12 INFO - 'PWD': '/builds/slave/test', 22:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:12 INFO - 'SHELL': '/bin/bash', 22:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:13:12 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:12 INFO - 'USER': 'cltbld', 22:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:12 INFO - 'XPC_FLAGS': '0x0', 22:13:12 INFO - 'XPC_SERVICE_NAME': '0', 22:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:12 INFO - Downloading/unpacking flake8 22:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:13:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:13:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 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 22:13:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:13:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:13:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:13:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:13:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:13:16 INFO - no previously-included directories found matching 'docs/_build' 22:13:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:13:16 INFO - Running setup.py install for pep8 22:13:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:13:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:13:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:13:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:13:16 INFO - no previously-included directories found matching 'docs/_build' 22:13:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:13:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:13:16 INFO - Cleaning up... 22:13:16 INFO - Return code: 0 22:13:16 INFO - Running post-action listener: _resource_record_post_action 22:13:16 INFO - Running post-action listener: _start_resource_monitoring 22:13:16 INFO - Starting resource monitoring. 22:13:16 INFO - ##### 22:13:16 INFO - ##### Running install step. 22:13:16 INFO - ##### 22:13:16 INFO - Running pre-action listener: _resource_record_pre_action 22:13:16 INFO - Running main action method: install 22:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:17 INFO - Reading from file tmpfile_stdout 22:13:17 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:17 INFO - Reading from file tmpfile_stdout 22:13:17 INFO - Output received: 22:13:17 INFO - Usage: mozinstall [options] installer 22:13:17 INFO - Options: 22:13:17 INFO - -h, --help show this help message and exit 22:13:17 INFO - -d DEST, --destination=DEST 22:13:17 INFO - Directory to install application into. [default: 22:13:17 INFO - "/builds/slave/test"] 22:13:17 INFO - --app=APP Application being installed. [default: firefox] 22:13:17 INFO - mkdir: /builds/slave/test/build/application 22:13:17 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'] 22:13:17 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 22:13:50 INFO - Reading from file tmpfile_stdout 22:13:50 INFO - Output received: 22:13:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:13:50 INFO - Running post-action listener: _resource_record_post_action 22:13:50 INFO - ##### 22:13:50 INFO - ##### Running run-tests step. 22:13:50 INFO - ##### 22:13:50 INFO - Running pre-action listener: _resource_record_pre_action 22:13:50 INFO - Running main action method: run_tests 22:13:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:13:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:13:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:13:50 INFO - 2016-04-13 22:13:50.432 screenresolution[1644:7744] starting screenresolution argv=screenresolution get 22:13:50 INFO - 2016-04-13 22:13:50.435 screenresolution[1644:7744] Display 0: 1600x1200x32@60 22:13:50 INFO - 2016-04-13 22:13:50.441 screenresolution[1645:7746] starting screenresolution argv=screenresolution list 22:13:50 INFO - Available Modes on Display 0 22:13:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:13:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:13:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:13:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:13:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:13:50 INFO - Intel Iris: 22:13:50 INFO - Chipset Model: Intel Iris 22:13:50 INFO - Type: GPU 22:13:50 INFO - Bus: Built-In 22:13:50 INFO - VRAM (Dynamic, Max): 1536 MB 22:13:50 INFO - Vendor: Intel (0x8086) 22:13:50 INFO - Device ID: 0x0a2e 22:13:50 INFO - Revision ID: 0x0009 22:13:50 INFO - Displays: 22:13:50 INFO - Display: 22:13:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:13:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:13:50 INFO - Display Serial Number: 1600x1200 60 22:13:50 INFO - Main Display: Yes 22:13:50 INFO - Mirror: Off 22:13:50 INFO - Online: Yes 22:13:50 INFO - Rotation: Supported 22:13:50 INFO - Return code: 0 22:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:50 INFO - Python 2.7.3 22:13:50 INFO - Return code: 0 22:13:50 INFO - grabbing minidump binary from tooltool 22:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:50 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 0x107fa9e00>, '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 0x107dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:50 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 22:13:50 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 22:13:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:50 INFO - Return code: 0 22:13:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:13:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:13:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:13:51 INFO - Return code: 0 22:13:51 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/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 22:13:51 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/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --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 22:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xhwpuZGH5m/Render', 22:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:51 INFO - 'HOME': '/Users/cltbld', 22:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:51 INFO - 'LOGNAME': 'cltbld', 22:13:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:51 INFO - 'MOZ_NO_REMOTE': '1', 22:13:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:51 INFO - 'NO_EM_RESTART': '1', 22:13:51 INFO - 'PAGER': '/bin/cat', 22:13:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:51 INFO - 'PWD': '/builds/slave/test', 22:13:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:51 INFO - 'SHELL': '/bin/bash', 22:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3Axebkkr5/Listeners', 22:13:51 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 22:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:51 INFO - 'USER': 'cltbld', 22:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:51 INFO - 'XPC_FLAGS': '0x0', 22:13:51 INFO - 'XPC_SERVICE_NAME': '0', 22:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:51 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/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 22:13:52 INFO - mozversion application_buildid: 20160413210420 22:13:52 INFO - mozversion application_changeset: 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 22:13:52 INFO - mozversion application_display_name: Nightly 22:13:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:52 INFO - mozversion application_name: Firefox 22:13:52 INFO - mozversion application_remotingname: firefox 22:13:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:13:52 INFO - mozversion application_vendor: Mozilla 22:13:52 INFO - mozversion application_version: 48.0a1 22:13:52 INFO - mozversion platform_buildid: 20160413210420 22:13:52 INFO - mozversion platform_changeset: 04f9767b4abe6e33d294b89ab29ae5c1b2b67484 22:13:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:13:52 INFO - mozversion platform_version: 48.0a1 22:13:52 INFO - using testdate: 1460610832 22:13:52 INFO - actual date: 1460610832 22:13:52 INFO - starting webserver on 'localhost:49276' 22:13:52 INFO - SUITE-START | Running 2 tests 22:13:52 INFO - TEST-START | dromaeo_css 22:13:52 INFO - operating with platform_type : mac_ 22:13:52 INFO - Initialising browser for dromaeo_css test... 22:13:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp641oJB/profile http://localhost:49276/getInfo.html) 22:13:54 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 22:13:54 INFO - PROCESS | 1663 | colorDepth:24 22:13:54 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 22:13:54 INFO - PROCESS | 1663 | __metrics 22:13:54 INFO - PROCESS | 1663 | 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" 22:13:54 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:13:55 INFO - TEST-INFO | 1663: exit 0 22:13:55 INFO - Browser initialized. 22:13:55 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:55 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp641oJB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:07 INFO - PROCESS | 1665 | RSS: Main: 237404160 22:14:07 INFO - PROCESS | 1665 | 22:14:58 INFO - PROCESS | 1665 | 1460610898493 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] 22:17:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 22:17:10 INFO - PROCESS | 1665 | RSS: Main: 408555520 22:17:10 INFO - PROCESS | 1665 | 22:20:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 22:20:13 INFO - PROCESS | 1665 | RSS: Main: 374501376 22:20:13 INFO - PROCESS | 1665 | 22:23:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 22:23:16 INFO - PROCESS | 1665 | RSS: Main: 376889344 22:23:16 INFO - PROCESS | 1665 | 22:26:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 22:26:19 INFO - PROCESS | 1665 | RSS: Main: 375062528 22:26:19 INFO - PROCESS | 1665 | 22:29:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 22:29:23 INFO - PROCESS | 1665 | RSS: Main: 347795456 22:29:23 INFO - PROCESS | 1665 | 22:32:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 22:32:26 INFO - PROCESS | 1665 | RSS: Main: 385114112 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | __start_tp_report 22:32:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 22:32:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 22:32:26 INFO - PROCESS | 1665 | |i|pagename|runs| 22:32:26 INFO - PROCESS | 1665 | |0;dojo.html;3419.2648580555174;3486.6513348665135;3512.4028915084427;3523.5419395478584;3524.647535246476;5761.337446193689;5793.884122317551;5798;5813.33146688131;5832.504237139838;5810.767569297223;5869.7358618862145;5930.318013428457;5972.820815375535;5985.281766188053;5147.845564633067;5188.325517682696;5220.216967454893;5232.372115346145;5331.466853314657;5294.364676238857;5294.867628309285;5337.599680023995;5353.652012619187;5383.623146379755;5162.638615296931;5164.767585458663;5181.689098654093;5249.291345668324;5282.049231138393;5230.764615592308;5231.712255825928;5232.973835130838;5243.501867322599;5244;5193.974030129825;5227.843164705065;5251.947480525184;5252.816151434719;5266.262723218752;5005.74971251436;5581.162825576155;5658.74535645897;5693.516051135658;5699.344575373843;5965.747193089456;6218.253809542884;6239.625622462621;6247.875042499125;6248.593841400295;5570.6657600543695;6038.2150320458495;6184.226971628546;6220.533459990474;6262.530310226751;5775.509081728016;5881.911771323434;5884.0585506318785;5936.139259807347;5958;6209.96895015522;6211.9689401552705;6234;6313.779017734358;6316.368363163739;5203.5576975957465;6163;6209.379062093754;6211.503079753609;6226.470749986212;6165.876682466415;6199.56603037783;6237.09562113491;6249.062640603855;6250.812475625738;5873.236479257755;6134.5092392608485;6163.952128138228;6193.566450348432;6219.626822390671;6188.288346840171;6231.688415579203;6233.781817636452;6240.375962403723;6260.217472815898;4933.383327084114;4965.90068198634;4967.4784147664695;4972;5004.574611158019;4354.7822608870065;4395.7362558246605;4507.909841803211;4508.887277818081;4542.613877820356;5724.542036637059;5763.394843541451;5765;5792.536597072224;5818.709064546841;6187.81436556904;6205.131281620576;6207.379262073847;6213.440790328892;6233.875322493524;5611.719414029282;5719.57103217252;5735.369109397963;5753.51095156908;5812.796552120655;5418.241446197536;5424.213489044067;5427.782888684408;5433.375161856358;5440.047991601454;6331.366863313632;6357.841053973688;6363.745450182034;6364.904526432108;6380;6134.877302453837;6154.599951003171;6216;6216.689165541615;6281.528885333527;6286.057091436322;6357.586756860789;6358.173437453286;6359.618422894641;6390.968045159931;6231.657258850807;6244.063390491463;6247.156633854372;6248.250209974832;6281.748730050929;6130.489860652556;6157.1072194532435;6216.875662486635;6218.751249949952;6219.813405597839;5224.869378265574;5321.680699158062;6141.293751218488;6149.72326245329;6153.6923153841235;6108.083787431743;6111.480524155497;6124.050772130327;6130.938690613037;6137.1101190328045;5891;5987.820365389045;5989.341172471112;6007.639541627516;6018.337982821974;6090.23872015998;6094.776756467113;6112.471872075215;6113.083037544226;6121.87979361315;6040.36576159497;6100.066499260575;6104.459155447048;6129.816105516842;6133.426475724836 22:32:26 INFO - PROCESS | 1665 | |1;ext.html;511.5089514066496;527.4382782336813;530.6656806212086;539.1454544546892;587.1867463562965;30386.240343991383;40003.399949000755;40970.38544421832;41079.58920410795;41183.79408102963;45550;45728.085438291215;45793.54206457934;45848;45933.54066459335;8598.828023439528;9715.854262186072;9972.10251077403;9977.201823854111;9984.75038124049;8827.470351778882;11752.882471175308;12132.211406258564;12140.514379424812;12159;11952.342621155833;12106.152569320151;12106.394680265996;12106.97090747283;12117.030637549018;8693.565321733951;11679.766404671944;11857.762844743056;11875.703107422298;11878.584249551268;11720;11830.876066773642;11841.822372664417;11850.525978960832;11852.70368240801;40659.593404066174;41576.376354354405;41582.584174158175;41639.75080747582;41641.37537936933;3217.147455924182;3264.542963985044;3332.133645252228;3538.9646103538894;3561.1453251219523;28534.429311413864;29111.272218194503;29432.117036488726;29664.555031674543;30124;2719.7639824973703;2722.4963381774237;2735.4255606322695;2778.2776478115634;2781.13603685627;481088.5945570285;481809;482201;483496;483534;66372;66591.33408665948;66657.33342666608;66745;66778.66610666916;69525.95711064339;69716;69847.61828580502;69851.65074174698;69938.3006169942;16800.495985120466;16978.745318820227;16988.235529401205;16997;17019;11613.76772464546;12044.759104817855;12484.438200281009;12827.294498802468;12848.100632955604;15218.467353642569;18441.446756597325;18461.446156615322;18500.05749396321;18534.721979170325;5685.526795843821;6632.6352050636715;6689.933100669028;6760.898586521206;6784.559003664746;978.8776402949632;986.2011770465946;1031.6079889641887;1102.7185834383836;1104.9779004419865;30013.24966875802;30175.849120754694;30794.384112317628;30850.228744281125;31335.84332078325;1050.3487837540774;1066.9466526673634;1102.4377567440663;1189.6312143235625;1209.5524655877205;14721.55835324942;14814.629659254468;15313.6171595711;15377.461788837338;15823.68352632964;621397;633438;634565;634936;635512;62298.68850655718;62942.37057629365;62962;62969;62972;1281.2952875918395;1399.3702833724865;1409.6123566019426;1440.5030264558711;1462.8025216595624;24516.14193503219;25095.49809003773;28208;29299.121026369245;30297.394052118394;50033.499665002884;51933.740331298104;52181;52185.7390713044;52204.21693674522;401377;404433;405040.9495905003;405064;405473;25619.487610248063;26935.461290774467;26960.595591066543;26965;26971.86514067417;46461.535384647075;47254.291185631555;47488.52511474841;47828.5217147838;48962;37247.81376093102;37342.253154937294;38371.424428633036;38700.8389748308;39362.409563855996;37027.88916332514;38191.427128592535;38580.614193857706;39060.96902557567;39151.60848391594;31445.742170312933;36015.459768104025;36465.45301820528;37106.6289337114;37255.882323530335;26702.7329726708;31989.36021279608;32331.030069097964;32588.83705581457;32605.34789304248;24369.26892193237;25196.65388915485;25201.87399062993;25272.747272527038;25489.61765573555 22:32:26 INFO - PROCESS | 1665 | |2;jquery.html;393.9290927633026;396.1759540156475;397.5448111911861;400.50337581399054;409.5474500676752;18622.81377186231;18756.24975001;19635.90182049088;19671.016449177554;19691.113899874523;19605;19892.61288645361;20343.49141271469;20989.055492502837;21040.368788936317;5678.290213723285;5888.88222235554;6053.515718742512;6060;6062.120992456091;5915.349311575723;5919.585629005971;5942.970285148568;5984.192134061911;6011.2786465624185;5941.019731744279;6085.726142323606;6096.298925623566;6109.908351374733;6131.264248290189;6060.395867911912;6100.908486372708;6139.539534534905;6730.495212859055;6770.221424536192;5077.847664570068;5743.741531631086;5942.762289508414;5948.167256584082;5949.524038076944;13428.53000145;13432.19406835593;13846.723065538734;13888.375023123983;13895.166290022631;2426.296374051523;2493.2644869763462;2526.9494610107695;2527.1672968850166;2789.5257806173;9765.560549775206;9843.409395436225;9874.358166719212;10289.736258023222;10290.279680422373;1727.887687300334;1755.8770886037983;1771.5216891439368;1778;1811.6557854007697;112715;115985.26022109675;116774.83225167809;117885.41057294658;118307;11430.771384572428;11646.475908584134;11651.766964660828;11655;11822.231554948901;15161.924190378977;15194.392224310905;15223.771643425358;15237.771433428508;15275.388984440498;7164.892526612105;8565.571721413904;8580.828383432296;8582.485050896967;8741.475511469333;8366.330693544502;8401.285890699359;8498.830023399498;8513.489190648581;8578.485290882441;4497.977510112429;4607.631389488833;4611.492735799059;4629.629629629621;4660.067986402665;1832.2213059449948;1885.7548518692756;1917.472695008856;1989.8209161175564;2002.0890494824819;907.5190149220923;921.3826736086838;934.3973137326386;995.348047029197;1035.2753072849036;19445.902770486056;19553.0223488825;20569.897150514153;20720.79279207219;20765.896170519052;913.2556966072763;984.4979060678962;1011.5296387179997;1022.6983040003217;1087.3041253597703;8985.191332780081;10775.515101820436;10780.622678206226;10801.24391292602;10804.567817287221;485518;616448.9177554083;623435;627044;638999;120483;135497;142298;142787.5721242795;147884;1004.8040632076821;1009.7172791618211;1051.5373235776235;1052.273930987616;1053.6048981631889;17040.91479542644;17419.82580174233;17434.825651743322;17435.77438173942;17600.38398656041;34499.13752156216;46278.76860615675;46504;47210.52789472061;47294.52705472901;67217;68721.65639171972;72068.27931720826;72485;74908.87636685563;7060;7425.183229844821;7476.327130558276;7530.962345188458;7547.358474529507;9789.853152202864;12801.61595152147;12929.094963352474;12960.805587916;13162.670933226746;8883.125142851392;10794.676159715222;11183.217174797686;11245.381504017358;11297.43512824339;11043;11055.613053543088;11095.833562496731;11353.716157095809;11399.373034483184;10868.51091700891;11162.162837787037;11184.720381990515;11437.828432573351;11554.653360399201;7644.847103058019;7898.091719452107;11737.88262117402;12024.158308918291;12430.192037517532;10178.847317290098;11434.028107610946;11626.476808543805;11715.941420292844;11985 22:32:26 INFO - PROCESS | 1665 | |3;mootools.html;1404.3048690898006;1589.133922012503;1589.5708158797124;1858.526075850658;2001.2295266322471;8016.959915200423;8815.647374105036;9052.230560402373;9059.682911098113;9063.592138353773;8645.74062778116;8876.8668469973;8882.333824963122;8883;8895.822083558325;2154.29985254792;2379.583572874749;2463.2856471623254;2475.4801491686767;2486.080150344375;2491.277529516447;2506.348349429143;2513.9245822625257;2521.1680145551923;2521.508305880354;2121.4378189779723;2435.512897420514;2480.2063339731294;2485.7389974052735;2486.925392238236;2140.069069954575;2388.677528533643;2446.0460420436043;2447.265820253917;2451.1053465485147;2389.2832150354825;2392.342105920868;2406.5066661334386;2409.4337830609793;2411.565918134735;8692.869606955901;8740.51927144007;8767.254783343424;8768.035516093225;8768.912310876873;5293.655912365684;5323.520883120499;5380.811671591476;5387.515123638852;5392.865178370572;3614.7469677122613;3648.1244501319757;3650.580183278904;3690.501782259414;3699.72252081095;1037.65238645054;1071.2768881005368;1073.951672174754;1079.3955384984433;1087.9619213327574;11795.705107372298;11795.705107372385;11823.231489953125;11830.822537661941;11831.053515718808;4755.167845627001;4816.301636262792;4863.3434486343895;4918.508149185053;4972.378452693413;9956.850647240297;9973.900260997443;9979.750506237402;9996.200303975664;10002.799944001079;5438.8912221755345;5444.50999410055;5445.482679145554;5465.754041068161;5485.533729632946;4181.560936101726;4321.481422229353;4871.585915197248;4986.526280003394;5004.84985450437;3337.549430826807;4019.8593049243136;4093.774842383638;4113.177364527107;4136.8138433770555;1374.9993759080714;1377.8966577506726;1379.2483096712115;1388.1462900316435;1389.769420080776;921.9170274675178;923.8660394242797;925.2043242811177;931.5063016601213;948.5968463403026;5844.298684157843;5848.590598658138;5898.262717160355;5957.344692083867;6081.023667308143;461.206724433973;471.92921061840315;481.81931775584155;482.1153183907499;486.2778773521318;3880.1269714314617;3915.2169566086895;3983.063979964706;4017.0760725033406;4019.577944315863;10282.177425805918;10664.360138391721;10774.084202842689;10788.730281742863;10790.136789056856;10625.681229563126;10769.569217231223;10776.838347424795;10789.29869558492;10814.945925270324;7993.080795708452;8164.673413063411;8184.181581841768;8191.344692424592;8195.877061844078;4728.479867214673;6003.369646187088;6026.216591843032;6070.9089363658695;6129.325774164749;10054.849177262493;10195.949020255148;10253.846192306972;10293.485325733833;10297.485125743533;9988.350757200758;10146;10415.375077495375;10417.895821041693;10518.789624207626;6908.171019477695;7185.928140718735;7394.4454165936695;7680.9231907680205;7771.572563509061;8337.916620833714;8360.12218717026;8448.070712221528;8453.323734101134;8454.408191426786;7276.927230727625;7375.520591161558;7459.589722565311;7619.08570971487;7633.732819351296;7309.195988441161;7332.890006650011;7356.190819009797;7429.14564825052;7438.925610743823;6945.513814032969;7007.159140903124;7013.368796808311;7034.331738484836;7038.612876291853;4787.712737235777;4851.51484851512;5025.698458092526;5054.989002199502;5103.744812759422;4963.131451995814;5022.67352622093;5043.319151914591;5122;5133.717645529532 22:32:26 INFO - PROCESS | 1665 | |4;prototype.html;284.7301037373315;321.3236137929658;323.82513442740907;330.09553822526277;339.0963083382785;5820.4179582041825;5897.970510147448;5911.46796788289;5919.85200369991;5940.287165540141;5858.472737453629;5869.882602347961;5871.919016283685;5881.206037184978;5905.608228667385;3724.9698914091887;4151.750894946298;4212.347086201644;4297.355396690506;4468.709533880304;4114.650254728352;4332.545082766312;4391.407160033386;4423;4427.070315233805;4366.694331396803;4381.496127945279;4405.559444055585;4429.379886815848;4434.334849772544;3057.373238486116;4032.8386864525382;4092.0383709828166;4095.9350568852014;4368.628666563346;3186.5060915558124;3205.871765129392;3560.483729859182;3801.4794082367;3805.714571407128;5170.138750049979;5588.469095435927;5638.2670252866865;5663.745131469093;5686.147077938301;4336.306191009423;4855.256779919334;5115.155999260118;5167.974160129175;5193.324867767204;4965.871500954376;6206.028141989131;6225.844353891143;6252.531060170505;6271.435570798604;4302.612764851178;4307.763073030982;4308.061372382409;4311.892202694927;4323.308270676676;5459.3994660587305;6071.635701857903;6120.877582448326;6252.686935743499;6572.309907459696;3626.818659067036;4269.743815371087;4303.505096913832;4330.41539392178;4336.457942757155;4381.9342709859375;4404.889877753018;4419.204543182258;4422.933655995163;4424.60178583929;4258.74447533149;4507.887302817456;4801.207800712913;5141.7686204120155;5147.382314122255;6230.688465576703;6248.375162483806;6258.593191442633;6265.4361107500545;6288.339724328971;1487.8239835255533;1511.6523199664139;1515.5832146159673;1523.5733994481564;1525.6491007068214;957.3298690916387;989.9406035637741;994.7811481474064;1024.0987930621006;1032.6488993742014;5177.171652535576;5745.798897038583;5822.243108395882;5887.9079040066745;5910.172575839386;6537.869242615121;6562.212534495891;6575;6608.702608382634;6619.536632435684;4998.725070121178;5592.888142237132;5685.80598074409;5898.8230353089475;5909.674967876808;3027.6366835979384;3387.256322378881;3395.320935812798;3420.6579342065593;3460.411730005905;6535.640539770263;6789.25318214996;6789.287124851919;6796.864062718718;6802.727890884309;6605.735770569124;6626.602403855784;6657.567258128206;6664.76787240106;6670.332966703291;6558.770443034471;6759.797206083826;6762.560433571802;6773.221079575912;6784.660766961632;6221.5333849962335;6411.6153030818305;6494.557884321317;6495.870082598416;6515.23102681368;6213.565050446426;6402.647854368054;6408.263049749338;6438.195225596801;6470.838229044311;6129.509639228761;6380.776672816615;6689.933100668931;6692.289622702813;6746.6626668665385;4172.8122234498915;4345.891352716081;4358.542353052884;4365.432493775789;4366.235908715898;5607.80372686954;6129.353034944201;6455.288778713046;6461.870762584816;6462.5153113515735;4890.608751299958;5459.399466058651;6208.2860471044605;6219.720112595034;6254.843628909313;6086.391360863879;6268.871603111484;6283.403076707706;6288.245410550763;6321.141561405742;5826.76692932278;6010.87978240424;6076.817695469143;6117.84705382369;6202.2867370253;4976.527229913152;5023.547880690755;5395;5882.5293976482635;6171.691415429121;5958.463738263577;6187.690615469299;6195.876082478235;6203.627782333075;6244.469220116341 22:32:26 INFO - PROCESS | 1665 | |5;yui.html;661.3287513174128;724.9927500724991;749.8425330680557;761.0866959648423;789.798601356654;14743.336549855256;15074.623134421645;15080.547583572483;15103.697926041486;15104.169270690121;12074.93962530186;13824.723505529882;13852;13855.445782168727;13862.168269903812;916.6379280184323;947.0576776107748;947.2516711797672;949.4161090929064;949.520492151466;941.9967734362916;944.1927152284801;944.6599224279254;944.8818897637796;945.3713280668347;977.1449981266392;995.2635050062974;996.4370130876068;997.2221667099674;999.3204620857814;764.2357642357642;987.7876256604828;987.8073775613758;988.9851652225223;995.975100622483;716.3874886971616;735.5880706804206;736.2600586410676;738.04791818554;741.2069086077898;14809.111453312837;14853.108813471119;14899.553013409615;14900.329485173193;14916.030458020194;12079.698007549881;12212.450439730233;12330.19853709506;12505.999520038375;12559.309237991907;8490.745277641681;9037.954810225972;9675.951620241924;10112.342697724698;10838.512266948006;3519.1202199450136;3533.9823300883586;3591.5690117185845;3656.561212654472;3658.244042859416;74546.99999999946;80707.7893831593;81027;82557;82676;9303.069693030642;9319.301052421095;9547.045295470398;9581.808363832684;10033.548490317953;17168.656626867643;20573.868437236095;20702.378928632166;20766;20847.37457876266;7509.09890813095;7600.961995189989;7622.085349758065;7770.45606807518;7817.5309481431295;4026.798660066985;4113.053997580513;4149.813258403379;4161.334186530201;4167.083241686824;3373.6795004474534;3679.816009199529;3694.319084816402;3700.130469339703;3701.0747313171705;654.7806484827636;668.3516988521127;670.3330186464499;672.0960308385214;690.6926417744056;485.4999350668817;563.3465180390727;575.1545228514077;588.2470437839572;619.6839611798016;6459.289478157399;7836.09884863248;7961.964944557286;8070.47541909774;8122.390820688353;569.2429069337771;591.9230500034968;597.7101105963604;621.0404924391826;621.9657918814418;3772.9245415091546;3797.9240415192094;3806.7335286530233;3819.618038196158;4024.939625905614;86287.27425451581;92825;95702;96042.55936160963;96059.51970240104;78107;78926.21073789304;79783.60108199422;81336;81728.59135704402;64202.67898660477;65453;65873.6825263492;66338.33661663321;67070;7471.9626401867645;7535.434842386733;7554.66004029809;7634.274743899321;7658.119316278477;43246.351304731084;43385;43785.56214437815;43874.78062609667;44644.33033504435;49635.503644963086;53910.46089539054;55507.16739248995;56799.43200567942;57543.136852948075;10536.367817930948;10598.25812193139;10662;10760.784784304113;11075.833862491907;9685.806283874424;11981.76036479248;12086.879131208576;12103.092268079754;12350.135490515577;11349.262297950938;11373.658790236306;11434.485448154686;11548.191626586058;11728.003119734576;11392;11496.252743571642;11564.653060408202;11652.009579185526;12139.696507587381;11047.558097676003;11474.254173478697;11742.530298788295;11814.822777658514;11818.113641476752;9304.441733496013;9375.85936210971;9389.765255868659;9630.133288003834;9864.358816676893;9580.616775329188;9664;9723.951380243054;9795.560514884617;9925.851112233468 22:32:26 INFO - PROCESS | 1665 | __end_tp_report 22:32:26 INFO - PROCESS | 1665 | __start_cc_report 22:32:26 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1583 22:32:26 INFO - PROCESS | 1665 | __end_cc_report 22:32:26 INFO - PROCESS | 1665 | __startTimestamp1460611946215__endTimestamp 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | ------- Summary: start ------- 22:32:26 INFO - PROCESS | 1665 | Number of tests: 6 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5756.22 Median:5987.82 stddev:619.93 (10.4%) stddev-sans-first:594.10 22:32:26 INFO - PROCESS | 1665 | Values: 3419.3 3486.7 3512.4 3523.5 3524.6 5761.3 5793.9 5798.0 5813.3 5832.5 5810.8 5869.7 5930.3 5972.8 5985.3 5147.8 5188.3 5220.2 5232.4 5331.5 5294.4 5294.9 5337.6 5353.7 5383.6 5162.6 5164.8 5181.7 5249.3 5282.0 5230.8 5231.7 5233.0 5243.5 5244.0 5194.0 5227.8 5251.9 5252.8 5266.3 5005.7 5581.2 5658.7 5693.5 5699.3 5965.7 6218.3 6239.6 6247.9 6248.6 5570.7 6038.2 6184.2 6220.5 6262.5 5775.5 5881.9 5884.1 5936.1 5958.0 6210.0 6212.0 6234.0 6313.8 6316.4 5203.6 6163.0 6209.4 6211.5 6226.5 6165.9 6199.6 6237.1 6249.1 6250.8 5873.2 6134.5 6164.0 6193.6 6219.6 6188.3 6231.7 6233.8 6240.4 6260.2 4933.4 4965.9 4967.5 4972.0 5004.6 4354.8 4395.7 4507.9 4508.9 4542.6 5724.5 5763.4 5765.0 5792.5 5818.7 6187.8 6205.1 6207.4 6213.4 6233.9 5611.7 5719.6 5735.4 5753.5 5812.8 5418.2 5424.2 5427.8 5433.4 5440.0 6331.4 6357.8 6363.7 6364.9 6380.0 6134.9 6154.6 6216.0 6216.7 6281.5 6286.1 6357.6 6358.2 6359.6 6391.0 6231.7 6244.1 6247.2 6248.3 6281.7 6130.5 6157.1 6216.9 6218.8 6219.8 5224.9 5321.7 6141.3 6149.7 6153.7 6108.1 6111.5 6124.1 6130.9 6137.1 5891.0 5987.8 5989.3 6007.6 6018.3 6090.2 6094.8 6112.5 6113.1 6121.9 6040.4 6100.1 6104.5 6129.8 6133.4 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:65588.21 Median:3435.55 stddev:137317.19 (3997.0%) stddev-sans-first:137615.47 22:32:26 INFO - PROCESS | 1665 | Values: 511.5 527.4 530.7 539.1 587.2 30386.2 40003.4 40970.4 41079.6 41183.8 45550.0 45728.1 45793.5 45848.0 45933.5 8598.8 9715.9 9972.1 9977.2 9984.8 8827.5 11752.9 12132.2 12140.5 12159.0 11952.3 12106.2 12106.4 12107.0 12117.0 8693.6 11679.8 11857.8 11875.7 11878.6 11720.0 11830.9 11841.8 11850.5 11852.7 40659.6 41576.4 41582.6 41639.8 41641.4 3217.1 3264.5 3332.1 3539.0 3561.1 28534.4 29111.3 29432.1 29664.6 30124.0 2719.8 2722.5 2735.4 2778.3 2781.1 481088.6 481809.0 482201.0 483496.0 483534.0 66372.0 66591.3 66657.3 66745.0 66778.7 69526.0 69716.0 69847.6 69851.7 69938.3 16800.5 16978.7 16988.2 16997.0 17019.0 11613.8 12044.8 12484.4 12827.3 12848.1 15218.5 18441.4 18461.4 18500.1 18534.7 5685.5 6632.6 6689.9 6760.9 6784.6 978.9 986.2 1031.6 1102.7 1105.0 30013.2 30175.8 30794.4 30850.2 31335.8 1050.3 1066.9 1102.4 1189.6 1209.6 14721.6 14814.6 15313.6 15377.5 15823.7 621397.0 633438.0 634565.0 634936.0 635512.0 62298.7 62942.4 62962.0 62969.0 62972.0 1281.3 1399.4 1409.6 1440.5 1462.8 24516.1 25095.5 28208.0 29299.1 30297.4 50033.5 51933.7 52181.0 52185.7 52204.2 401377.0 404433.0 405040.9 405064.0 405473.0 25619.5 26935.5 26960.6 26965.0 26971.9 46461.5 47254.3 47488.5 47828.5 48962.0 37247.8 37342.3 38371.4 38700.8 39362.4 37027.9 38191.4 38580.6 39061.0 39151.6 31445.7 36015.5 36465.5 37106.6 37255.9 26702.7 31989.4 32331.0 32588.8 32605.3 24369.3 25196.7 25201.9 25272.7 25489.6 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34494.26 Median:20456.69 stddev:100481.18 (491.2%) stddev-sans-first:100730.44 22:32:26 INFO - PROCESS | 1665 | Values: 393.9 396.2 397.5 400.5 409.5 18622.8 18756.2 19635.9 19671.0 19691.1 19605.0 19892.6 20343.5 20989.1 21040.4 5678.3 5888.9 6053.5 6060.0 6062.1 5915.3 5919.6 5943.0 5984.2 6011.3 5941.0 6085.7 6096.3 6109.9 6131.3 6060.4 6100.9 6139.5 6730.5 6770.2 5077.8 5743.7 5942.8 5948.2 5949.5 13428.5 13432.2 13846.7 13888.4 13895.2 2426.3 2493.3 2526.9 2527.2 2789.5 9765.6 9843.4 9874.4 10289.7 10290.3 1727.9 1755.9 1771.5 1778.0 1811.7 112715.0 115985.3 116774.8 117885.4 118307.0 11430.8 11646.5 11651.8 11655.0 11822.2 15161.9 15194.4 15223.8 15237.8 15275.4 7164.9 8565.6 8580.8 8582.5 8741.5 8366.3 8401.3 8498.8 8513.5 8578.5 4498.0 4607.6 4611.5 4629.6 4660.1 1832.2 1885.8 1917.5 1989.8 2002.1 907.5 921.4 934.4 995.3 1035.3 19445.9 19553.0 20569.9 20720.8 20765.9 913.3 984.5 1011.5 1022.7 1087.3 8985.2 10775.5 10780.6 10801.2 10804.6 485518.0 616448.9 623435.0 627044.0 638999.0 120483.0 135497.0 142298.0 142787.6 147884.0 1004.8 1009.7 1051.5 1052.3 1053.6 17040.9 17419.8 17434.8 17435.8 17600.4 34499.1 46278.8 46504.0 47210.5 47294.5 67217.0 68721.7 72068.3 72485.0 74908.9 7060.0 7425.2 7476.3 7531.0 7547.4 9789.9 12801.6 12929.1 12960.8 13162.7 8883.1 10794.7 11183.2 11245.4 11297.4 11043.0 11055.6 11095.8 11353.7 11399.4 10868.5 11162.2 11184.7 11437.8 11554.7 7644.8 7898.1 11737.9 12024.2 12430.2 10178.8 11434.0 11626.5 11715.9 11985.0 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5755.43 Median:2668.90 stddev:3233.45 (121.2%) stddev-sans-first:3225.98 22:32:26 INFO - PROCESS | 1665 | Values: 1404.3 1589.1 1589.6 1858.5 2001.2 8017.0 8815.6 9052.2 9059.7 9063.6 8645.7 8876.9 8882.3 8883.0 8895.8 2154.3 2379.6 2463.3 2475.5 2486.1 2491.3 2506.3 2513.9 2521.2 2521.5 2121.4 2435.5 2480.2 2485.7 2486.9 2140.1 2388.7 2446.0 2447.3 2451.1 2389.3 2392.3 2406.5 2409.4 2411.6 8692.9 8740.5 8767.3 8768.0 8768.9 5293.7 5323.5 5380.8 5387.5 5392.9 3614.7 3648.1 3650.6 3690.5 3699.7 1037.7 1071.3 1074.0 1079.4 1088.0 11795.7 11795.7 11823.2 11830.8 11831.1 4755.2 4816.3 4863.3 4918.5 4972.4 9956.9 9973.9 9979.8 9996.2 10002.8 5438.9 5444.5 5445.5 5465.8 5485.5 4181.6 4321.5 4871.6 4986.5 5004.8 3337.5 4019.9 4093.8 4113.2 4136.8 1375.0 1377.9 1379.2 1388.1 1389.8 921.9 923.9 925.2 931.5 948.6 5844.3 5848.6 5898.3 5957.3 6081.0 461.2 471.9 481.8 482.1 486.3 3880.1 3915.2 3983.1 4017.1 4019.6 10282.2 10664.4 10774.1 10788.7 10790.1 10625.7 10769.6 10776.8 10789.3 10814.9 7993.1 8164.7 8184.2 8191.3 8195.9 4728.5 6003.4 6026.2 6070.9 6129.3 10054.8 10195.9 10253.8 10293.5 10297.5 9988.4 10146.0 10415.4 10417.9 10518.8 6908.2 7185.9 7394.4 7680.9 7771.6 8337.9 8360.1 8448.1 8453.3 8454.4 7276.9 7375.5 7459.6 7619.1 7633.7 7309.2 7332.9 7356.2 7429.1 7438.9 6945.5 7007.2 7013.4 7034.3 7038.6 4787.7 4851.5 5025.7 5055.0 5103.7 4963.1 5022.7 5043.3 5122.0 5133.7 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5067.98 Median:5821.33 stddev:1603.15 (27.5%) stddev-sans-first:1566.93 22:32:26 INFO - PROCESS | 1665 | Values: 284.7 321.3 323.8 330.1 339.1 5820.4 5898.0 5911.5 5919.9 5940.3 5858.5 5869.9 5871.9 5881.2 5905.6 3725.0 4151.8 4212.3 4297.4 4468.7 4114.7 4332.5 4391.4 4423.0 4427.1 4366.7 4381.5 4405.6 4429.4 4434.3 3057.4 4032.8 4092.0 4095.9 4368.6 3186.5 3205.9 3560.5 3801.5 3805.7 5170.1 5588.5 5638.3 5663.7 5686.1 4336.3 4855.3 5115.2 5168.0 5193.3 4965.9 6206.0 6225.8 6252.5 6271.4 4302.6 4307.8 4308.1 4311.9 4323.3 5459.4 6071.6 6120.9 6252.7 6572.3 3626.8 4269.7 4303.5 4330.4 4336.5 4381.9 4404.9 4419.2 4422.9 4424.6 4258.7 4507.9 4801.2 5141.8 5147.4 6230.7 6248.4 6258.6 6265.4 6288.3 1487.8 1511.7 1515.6 1523.6 1525.6 957.3 989.9 994.8 1024.1 1032.6 5177.2 5745.8 5822.2 5887.9 5910.2 6537.9 6562.2 6575.0 6608.7 6619.5 4998.7 5592.9 5685.8 5898.8 5909.7 3027.6 3387.3 3395.3 3420.7 3460.4 6535.6 6789.3 6789.3 6796.9 6802.7 6605.7 6626.6 6657.6 6664.8 6670.3 6558.8 6759.8 6762.6 6773.2 6784.7 6221.5 6411.6 6494.6 6495.9 6515.2 6213.6 6402.6 6408.3 6438.2 6470.8 6129.5 6380.8 6689.9 6692.3 6746.7 4172.8 4345.9 4358.5 4365.4 4366.2 5607.8 6129.4 6455.3 6461.9 6462.5 4890.6 5459.4 6208.3 6219.7 6254.8 6086.4 6268.9 6283.4 6288.2 6321.1 5826.8 6010.9 6076.8 6117.8 6202.3 4976.5 5023.5 5395.0 5882.5 6171.7 5958.5 6187.7 6195.9 6203.6 6244.5 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:17622.96 Median:621.50 stddev:24846.53 (3997.8%) stddev-sans-first:24883.59 22:32:26 INFO - PROCESS | 1665 | Values: 661.3 725.0 749.8 761.1 789.8 14743.3 15074.6 15080.5 15103.7 15104.2 12074.9 13824.7 13852.0 13855.4 13862.2 916.6 947.1 947.3 949.4 949.5 942.0 944.2 944.7 944.9 945.4 977.1 995.3 996.4 997.2 999.3 764.2 987.8 987.8 989.0 996.0 716.4 735.6 736.3 738.0 741.2 14809.1 14853.1 14899.6 14900.3 14916.0 12079.7 12212.5 12330.2 12506.0 12559.3 8490.7 9038.0 9676.0 10112.3 10838.5 3519.1 3534.0 3591.6 3656.6 3658.2 74547.0 80707.8 81027.0 82557.0 82676.0 9303.1 9319.3 9547.0 9581.8 10033.5 17168.7 20573.9 20702.4 20766.0 20847.4 7509.1 7601.0 7622.1 7770.5 7817.5 4026.8 4113.1 4149.8 4161.3 4167.1 3373.7 3679.8 3694.3 3700.1 3701.1 654.8 668.4 670.3 672.1 690.7 485.5 563.3 575.2 588.2 619.7 6459.3 7836.1 7962.0 8070.5 8122.4 569.2 591.9 597.7 621.0 622.0 3772.9 3797.9 3806.7 3819.6 4024.9 86287.3 92825.0 95702.0 96042.6 96059.5 78107.0 78926.2 79783.6 81336.0 81728.6 64202.7 65453.0 65873.7 66338.3 67070.0 7472.0 7535.4 7554.7 7634.3 7658.1 43246.4 43385.0 43785.6 43874.8 44644.3 49635.5 53910.5 55507.2 56799.4 57543.1 10536.4 10598.3 10662.0 10760.8 11075.8 9685.8 11981.8 12086.9 12103.1 12350.1 11349.3 11373.7 11434.5 11548.2 11728.0 11392.0 11496.3 11564.7 11652.0 12139.7 11047.6 11474.3 11742.5 11814.8 11818.1 9304.4 9375.9 9389.8 9630.1 9864.4 9580.6 9664.0 9724.0 9795.6 9925.9 22:32:26 INFO - PROCESS | 1665 | -------- Summary: end -------- 22:32:26 INFO - PROCESS | 1665 | 22:32:26 INFO - TEST-INFO | 1665: exit 0 22:32:26 INFO - TEST-OK | dromaeo_css | took 1114725ms 22:32:26 INFO - TEST-START | kraken 22:32:26 INFO - operating with platform_type : mac_ 22:32:26 INFO - Initialising browser for kraken test... 22:32:26 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmps9wKoS/profile http://localhost:49276/getInfo.html) 22:32:29 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 22:32:29 INFO - PROCESS | 1675 | colorDepth:24 22:32:29 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 22:32:29 INFO - PROCESS | 1675 | __metrics 22:32:29 INFO - PROCESS | 1675 | 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" 22:32:29 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:32:30 INFO - TEST-INFO | 1675: exit 0 22:32:30 INFO - Browser initialized. 22:32:30 INFO - Running cycle 1/1 for kraken test... 22:32:30 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmps9wKoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:42 INFO - PROCESS | 1677 | RSS: Main: 237592576 22:32:42 INFO - PROCESS | 1677 | 22:32:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:45 INFO - PROCESS | 1677 | RSS: Main: 285712384 22:32:45 INFO - PROCESS | 1677 | 22:32:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 22:32:48 INFO - PROCESS | 1677 | RSS: Main: 299401216 22:32:48 INFO - PROCESS | 1677 | 22:32:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 22:32:52 INFO - PROCESS | 1677 | RSS: Main: 385048576 22:32:52 INFO - PROCESS | 1677 | 22:32:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 22:32:55 INFO - PROCESS | 1677 | RSS: Main: 287715328 22:32:55 INFO - PROCESS | 1677 | 22:32:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:58 INFO - PROCESS | 1677 | RSS: Main: 291831808 22:32:58 INFO - PROCESS | 1677 | 22:33:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:01 INFO - PROCESS | 1677 | RSS: Main: 331186176 22:33:01 INFO - PROCESS | 1677 | 22:33:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:05 INFO - PROCESS | 1677 | RSS: Main: 330694656 22:33:05 INFO - PROCESS | 1677 | 22:33:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 22:33:08 INFO - PROCESS | 1677 | RSS: Main: 327213056 22:33:08 INFO - PROCESS | 1677 | 22:33:10 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:10 INFO - PROCESS | 1677 | RSS: Main: 320094208 22:33:10 INFO - PROCESS | 1677 | 22:33:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:13 INFO - PROCESS | 1677 | RSS: Main: 326922240 22:33:13 INFO - PROCESS | 1677 | 22:33:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:16 INFO - PROCESS | 1677 | RSS: Main: 329822208 22:33:16 INFO - PROCESS | 1677 | 22:33:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:19 INFO - PROCESS | 1677 | RSS: Main: 334512128 22:33:19 INFO - PROCESS | 1677 | 22:33:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:22 INFO - PROCESS | 1677 | RSS: Main: 332361728 22:33:22 INFO - PROCESS | 1677 | 22:33:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 22:33:25 INFO - PROCESS | 1677 | RSS: Main: 395939840 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | __start_tp_report 22:33:25 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 22:33:25 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 22:33:25 INFO - PROCESS | 1677 | |i|pagename|runs| 22:33:25 INFO - PROCESS | 1677 | |0;ai-astar;110;110;112;113;113;113;118;112;113;111 22:33:25 INFO - PROCESS | 1677 | |1;audio-beat-detection;159;119;145;167;118;141;140;118;171;145 22:33:25 INFO - PROCESS | 1677 | |2;audio-dft;183;186;185;184;183;181;182;182;183;186 22:33:25 INFO - PROCESS | 1677 | |3;audio-fft;71;75;88;90;56;57;58;78;86;72 22:33:25 INFO - PROCESS | 1677 | |4;audio-oscillator;88;99;140;78;76;81;123;80;76;126 22:33:25 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;84;89;88;87;83;88;85;87;84 22:33:25 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;94;94;93;92;113;147;147;94;93 22:33:25 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;85;85;85;87;84;87;87;94;126 22:33:25 INFO - PROCESS | 1677 | |8;json-parse-financial;60;62;59;57;59;61;60;75;58;57 22:33:25 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;66;63;73;78;71;69;67;67;68;68 22:33:25 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;86;84;83;85;85;85;81;105;88;87 22:33:25 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;143;143;142;140;141;138;142;140;182;143 22:33:25 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;167;168;170;169;170;169;169;169;177;170 22:33:25 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;67;67;70;93;98;92;93;68;67;65 22:33:25 INFO - PROCESS | 1677 | __end_tp_report 22:33:25 INFO - PROCESS | 1677 | __start_cc_report 22:33:25 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1919 22:33:25 INFO - PROCESS | 1677 | __end_cc_report 22:33:25 INFO - PROCESS | 1677 | __startTimestamp1460612005049__endTimestamp 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | ------- Summary: start ------- 22:33:25 INFO - PROCESS | 1677 | Number of tests: 14 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.27 (2.0%) stddev-sans-first:2.22 22:33:25 INFO - PROCESS | 1677 | Values: 110.0 110.0 112.0 113.0 113.0 113.0 118.0 112.0 113.0 111.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:145.00 stddev:19.60 (13.5%) stddev-sans-first:19.84 22:33:25 INFO - PROCESS | 1677 | Values: 159.0 119.0 145.0 167.0 118.0 141.0 140.0 118.0 171.0 145.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.72 (0.9%) stddev-sans-first:1.81 22:33:25 INFO - PROCESS | 1677 | Values: 183.0 186.0 185.0 184.0 183.0 181.0 182.0 182.0 183.0 186.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:73.10 Median:76.50 stddev:12.85 (16.8%) stddev-sans-first:13.61 22:33:25 INFO - PROCESS | 1677 | Values: 71.0 75.0 88.0 90.0 56.0 57.0 58.0 78.0 86.0 72.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.00 stddev:24.12 (30.5%) stddev-sans-first:25.38 22:33:25 INFO - PROCESS | 1677 | Values: 88.0 99.0 140.0 78.0 76.0 81.0 123.0 80.0 76.0 126.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:2.04 (2.3%) stddev-sans-first:2.15 22:33:25 INFO - PROCESS | 1677 | Values: 87.0 84.0 89.0 88.0 87.0 83.0 88.0 85.0 87.0 84.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:93.00 stddev:22.47 (24.2%) stddev-sans-first:23.34 22:33:25 INFO - PROCESS | 1677 | Values: 93.0 94.0 94.0 93.0 92.0 113.0 147.0 147.0 94.0 93.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:86.00 stddev:12.79 (14.9%) stddev-sans-first:13.41 22:33:25 INFO - PROCESS | 1677 | Values: 85.0 85.0 85.0 85.0 87.0 84.0 87.0 87.0 94.0 126.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.00 stddev:5.25 (8.7%) stddev-sans-first:5.56 22:33:25 INFO - PROCESS | 1677 | Values: 60.0 62.0 59.0 57.0 59.0 61.0 60.0 75.0 58.0 57.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.50 stddev:4.16 (6.1%) stddev-sans-first:4.27 22:33:25 INFO - PROCESS | 1677 | Values: 66.0 63.0 73.0 78.0 71.0 69.0 67.0 67.0 68.0 68.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:85.00 stddev:6.66 (7.8%) stddev-sans-first:7.05 22:33:25 INFO - PROCESS | 1677 | Values: 86.0 84.0 83.0 85.0 85.0 85.0 81.0 105.0 88.0 87.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:142.50 stddev:12.96 (9.1%) stddev-sans-first:13.72 22:33:25 INFO - PROCESS | 1677 | Values: 143.0 143.0 142.0 140.0 141.0 138.0 142.0 140.0 182.0 143.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:169.50 stddev:2.70 (1.6%) stddev-sans-first:2.67 22:33:25 INFO - PROCESS | 1677 | Values: 167.0 168.0 170.0 169.0 170.0 169.0 169.0 169.0 177.0 170.0 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:81.00 stddev:13.91 (17.2%) stddev-sans-first:14.18 22:33:25 INFO - PROCESS | 1677 | Values: 67.0 67.0 70.0 93.0 98.0 92.0 93.0 68.0 67.0 65.0 22:33:25 INFO - PROCESS | 1677 | -------- Summary: end -------- 22:33:25 INFO - PROCESS | 1677 | 22:33:25 INFO - TEST-INFO | 1677: exit 0 22:33:25 INFO - TEST-OK | kraken | took 58933ms 22:33:25 INFO - SUITE-END | took 1173s 22:33:26 INFO - Completed test suite (00:19:34) 22:33:26 INFO - javascript benchmark 22:33:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.2648580555174, 3486.6513348665135, 3512.4028915084427, 3523.5419395478584, 3524.647535246476, 5761.337446193689, 5793.884122317551, 5798.0, 5813.33146688131, 5832.504237139838, 5810.767569297223, 5869.7358618862145, 5930.318013428457, 5972.820815375535, 5985.281766188053, 5147.845564633067, 5188.325517682696, 5220.216967454893, 5232.372115346145, 5331.466853314657, 5294.364676238857, 5294.867628309285, 5337.599680023995, 5353.652012619187, 5383.623146379755, 5162.638615296931, 5164.767585458663, 5181.689098654093, 5249.291345668324, 5282.049231138393, 5230.764615592308, 5231.712255825928, 5232.973835130838, 5243.501867322599, 5244.0, 5193.974030129825, 5227.843164705065, 5251.947480525184, 5252.816151434719, 5266.262723218752, 5005.74971251436, 5581.162825576155, 5658.74535645897, 5693.516051135658, 5699.344575373843, 5965.747193089456, 6218.253809542884, 6239.625622462621, 6247.875042499125, 6248.593841400295, 5570.6657600543695, 6038.2150320458495, 6184.226971628546, 6220.533459990474, 6262.530310226751, 5775.509081728016, 5881.911771323434, 5884.0585506318785, 5936.139259807347, 5958.0, 6209.96895015522, 6211.9689401552705, 6234.0, 6313.779017734358, 6316.368363163739, 5203.5576975957465, 6163.0, 6209.379062093754, 6211.503079753609, 6226.470749986212, 6165.876682466415, 6199.56603037783, 6237.09562113491, 6249.062640603855, 6250.812475625738, 5873.236479257755, 6134.5092392608485, 6163.952128138228, 6193.566450348432, 6219.626822390671, 6188.288346840171, 6231.688415579203, 6233.781817636452, 6240.375962403723, 6260.217472815898, 4933.383327084114, 4965.90068198634, 4967.4784147664695, 4972.0, 5004.574611158019, 4354.7822608870065, 4395.7362558246605, 4507.909841803211, 4508.887277818081, 4542.613877820356, 5724.542036637059, 5763.394843541451, 5765.0, 5792.536597072224, 5818.709064546841, 6187.81436556904, 6205.131281620576, 6207.379262073847, 6213.440790328892, 6233.875322493524, 5611.719414029282, 5719.57103217252, 5735.369109397963, 5753.51095156908, 5812.796552120655, 5418.241446197536, 5424.213489044067, 5427.782888684408, 5433.375161856358, 5440.047991601454, 6331.366863313632, 6357.841053973688, 6363.745450182034, 6364.904526432108, 6380.0, 6134.877302453837, 6154.599951003171, 6216.0, 6216.689165541615, 6281.528885333527, 6286.057091436322, 6357.586756860789, 6358.173437453286, 6359.618422894641, 6390.968045159931, 6231.657258850807, 6244.063390491463, 6247.156633854372, 6248.250209974832, 6281.748730050929, 6130.489860652556, 6157.1072194532435, 6216.875662486635, 6218.751249949952, 6219.813405597839, 5224.869378265574, 5321.680699158062, 6141.293751218488, 6149.72326245329, 6153.6923153841235, 6108.083787431743, 6111.480524155497, 6124.050772130327, 6130.938690613037, 6137.1101190328045, 5891.0, 5987.820365389045, 5989.341172471112, 6007.639541627516, 6018.337982821974, 6090.23872015998, 6094.776756467113, 6112.471872075215, 6113.083037544226, 6121.87979361315, 6040.36576159497, 6100.066499260575, 6104.459155447048, 6129.816105516842, 6133.426475724836], "value": 5718.775650217491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.5089514066496, 527.4382782336813, 530.6656806212086, 539.1454544546892, 587.1867463562965, 30386.240343991383, 40003.399949000755, 40970.38544421832, 41079.58920410795, 41183.79408102963, 45550.0, 45728.085438291215, 45793.54206457934, 45848.0, 45933.54066459335, 8598.828023439528, 9715.854262186072, 9972.10251077403, 9977.201823854111, 9984.75038124049, 8827.470351778882, 11752.882471175308, 12132.211406258564, 12140.514379424812, 12159.0, 11952.342621155833, 12106.152569320151, 12106.394680265996, 12106.97090747283, 12117.030637549018, 8693.565321733951, 11679.766404671944, 11857.762844743056, 11875.703107422298, 11878.584249551268, 11720.0, 11830.876066773642, 11841.822372664417, 11850.525978960832, 11852.70368240801, 40659.593404066174, 41576.376354354405, 41582.584174158175, 41639.75080747582, 41641.37537936933, 3217.147455924182, 3264.542963985044, 3332.133645252228, 3538.9646103538894, 3561.1453251219523, 28534.429311413864, 29111.272218194503, 29432.117036488726, 29664.555031674543, 30124.0, 2719.7639824973703, 2722.4963381774237, 2735.4255606322695, 2778.2776478115634, 2781.13603685627, 481088.5945570285, 481809.0, 482201.0, 483496.0, 483534.0, 66372.0, 66591.33408665948, 66657.33342666608, 66745.0, 66778.66610666916, 69525.95711064339, 69716.0, 69847.61828580502, 69851.65074174698, 69938.3006169942, 16800.495985120466, 16978.745318820227, 16988.235529401205, 16997.0, 17019.0, 11613.76772464546, 12044.759104817855, 12484.438200281009, 12827.294498802468, 12848.100632955604, 15218.467353642569, 18441.446756597325, 18461.446156615322, 18500.05749396321, 18534.721979170325, 5685.526795843821, 6632.6352050636715, 6689.933100669028, 6760.898586521206, 6784.559003664746, 978.8776402949632, 986.2011770465946, 1031.6079889641887, 1102.7185834383836, 1104.9779004419865, 30013.24966875802, 30175.849120754694, 30794.384112317628, 30850.228744281125, 31335.84332078325, 1050.3487837540774, 1066.9466526673634, 1102.4377567440663, 1189.6312143235625, 1209.5524655877205, 14721.55835324942, 14814.629659254468, 15313.6171595711, 15377.461788837338, 15823.68352632964, 621397.0, 633438.0, 634565.0, 634936.0, 635512.0, 62298.68850655718, 62942.37057629365, 62962.0, 62969.0, 62972.0, 1281.2952875918395, 1399.3702833724865, 1409.6123566019426, 1440.5030264558711, 1462.8025216595624, 24516.14193503219, 25095.49809003773, 28208.0, 29299.121026369245, 30297.394052118394, 50033.499665002884, 51933.740331298104, 52181.0, 52185.7390713044, 52204.21693674522, 401377.0, 404433.0, 405040.9495905003, 405064.0, 405473.0, 25619.487610248063, 26935.461290774467, 26960.595591066543, 26965.0, 26971.86514067417, 46461.535384647075, 47254.291185631555, 47488.52511474841, 47828.5217147838, 48962.0, 37247.81376093102, 37342.253154937294, 38371.424428633036, 38700.8389748308, 39362.409563855996, 37027.88916332514, 38191.427128592535, 38580.614193857706, 39060.96902557567, 39151.60848391594, 31445.742170312933, 36015.459768104025, 36465.45301820528, 37106.6289337114, 37255.882323530335, 26702.7329726708, 31989.36021279608, 32331.030069097964, 32588.83705581457, 32605.34789304248, 24369.26892193237, 25196.65388915485, 25201.87399062993, 25272.747272527038, 25489.61765573555], "value": 20177.726500892066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9290927633026, 396.1759540156475, 397.5448111911861, 400.50337581399054, 409.5474500676752, 18622.81377186231, 18756.24975001, 19635.90182049088, 19671.016449177554, 19691.113899874523, 19605.0, 19892.61288645361, 20343.49141271469, 20989.055492502837, 21040.368788936317, 5678.290213723285, 5888.88222235554, 6053.515718742512, 6060.0, 6062.120992456091, 5915.349311575723, 5919.585629005971, 5942.970285148568, 5984.192134061911, 6011.2786465624185, 5941.019731744279, 6085.726142323606, 6096.298925623566, 6109.908351374733, 6131.264248290189, 6060.395867911912, 6100.908486372708, 6139.539534534905, 6730.495212859055, 6770.221424536192, 5077.847664570068, 5743.741531631086, 5942.762289508414, 5948.167256584082, 5949.524038076944, 13428.53000145, 13432.19406835593, 13846.723065538734, 13888.375023123983, 13895.166290022631, 2426.296374051523, 2493.2644869763462, 2526.9494610107695, 2527.1672968850166, 2789.5257806173, 9765.560549775206, 9843.409395436225, 9874.358166719212, 10289.736258023222, 10290.279680422373, 1727.887687300334, 1755.8770886037983, 1771.5216891439368, 1778.0, 1811.6557854007697, 112715.0, 115985.26022109675, 116774.83225167809, 117885.41057294658, 118307.0, 11430.771384572428, 11646.475908584134, 11651.766964660828, 11655.0, 11822.231554948901, 15161.924190378977, 15194.392224310905, 15223.771643425358, 15237.771433428508, 15275.388984440498, 7164.892526612105, 8565.571721413904, 8580.828383432296, 8582.485050896967, 8741.475511469333, 8366.330693544502, 8401.285890699359, 8498.830023399498, 8513.489190648581, 8578.485290882441, 4497.977510112429, 4607.631389488833, 4611.492735799059, 4629.629629629621, 4660.067986402665, 1832.2213059449948, 1885.7548518692756, 1917.472695008856, 1989.8209161175564, 2002.0890494824819, 907.5190149220923, 921.3826736086838, 934.3973137326386, 995.348047029197, 1035.2753072849036, 19445.902770486056, 19553.0223488825, 20569.897150514153, 20720.79279207219, 20765.896170519052, 913.2556966072763, 984.4979060678962, 1011.5296387179997, 1022.6983040003217, 1087.3041253597703, 8985.191332780081, 10775.515101820436, 10780.622678206226, 10801.24391292602, 10804.567817287221, 485518.0, 616448.9177554083, 623435.0, 627044.0, 638999.0, 120483.0, 135497.0, 142298.0, 142787.5721242795, 147884.0, 1004.8040632076821, 1009.7172791618211, 1051.5373235776235, 1052.273930987616, 1053.6048981631889, 17040.91479542644, 17419.82580174233, 17434.825651743322, 17435.77438173942, 17600.38398656041, 34499.13752156216, 46278.76860615675, 46504.0, 47210.52789472061, 47294.52705472901, 67217.0, 68721.65639171972, 72068.27931720826, 72485.0, 74908.87636685563, 7060.0, 7425.183229844821, 7476.327130558276, 7530.962345188458, 7547.358474529507, 9789.853152202864, 12801.61595152147, 12929.094963352474, 12960.805587916, 13162.670933226746, 8883.125142851392, 10794.676159715222, 11183.217174797686, 11245.381504017358, 11297.43512824339, 11043.0, 11055.613053543088, 11095.833562496731, 11353.716157095809, 11399.373034483184, 10868.51091700891, 11162.162837787037, 11184.720381990515, 11437.828432573351, 11554.653360399201, 7644.847103058019, 7898.091719452107, 11737.88262117402, 12024.158308918291, 12430.192037517532, 10178.847317290098, 11434.028107610946, 11626.476808543805, 11715.941420292844, 11985.0], "value": 9459.735532718114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.3048690898006, 1589.133922012503, 1589.5708158797124, 1858.526075850658, 2001.2295266322471, 8016.959915200423, 8815.647374105036, 9052.230560402373, 9059.682911098113, 9063.592138353773, 8645.74062778116, 8876.8668469973, 8882.333824963122, 8883.0, 8895.822083558325, 2154.29985254792, 2379.583572874749, 2463.2856471623254, 2475.4801491686767, 2486.080150344375, 2491.277529516447, 2506.348349429143, 2513.9245822625257, 2521.1680145551923, 2521.508305880354, 2121.4378189779723, 2435.512897420514, 2480.2063339731294, 2485.7389974052735, 2486.925392238236, 2140.069069954575, 2388.677528533643, 2446.0460420436043, 2447.265820253917, 2451.1053465485147, 2389.2832150354825, 2392.342105920868, 2406.5066661334386, 2409.4337830609793, 2411.565918134735, 8692.869606955901, 8740.51927144007, 8767.254783343424, 8768.035516093225, 8768.912310876873, 5293.655912365684, 5323.520883120499, 5380.811671591476, 5387.515123638852, 5392.865178370572, 3614.7469677122613, 3648.1244501319757, 3650.580183278904, 3690.501782259414, 3699.72252081095, 1037.65238645054, 1071.2768881005368, 1073.951672174754, 1079.3955384984433, 1087.9619213327574, 11795.705107372298, 11795.705107372385, 11823.231489953125, 11830.822537661941, 11831.053515718808, 4755.167845627001, 4816.301636262792, 4863.3434486343895, 4918.508149185053, 4972.378452693413, 9956.850647240297, 9973.900260997443, 9979.750506237402, 9996.200303975664, 10002.799944001079, 5438.8912221755345, 5444.50999410055, 5445.482679145554, 5465.754041068161, 5485.533729632946, 4181.560936101726, 4321.481422229353, 4871.585915197248, 4986.526280003394, 5004.84985450437, 3337.549430826807, 4019.8593049243136, 4093.774842383638, 4113.177364527107, 4136.8138433770555, 1374.9993759080714, 1377.8966577506726, 1379.2483096712115, 1388.1462900316435, 1389.769420080776, 921.9170274675178, 923.8660394242797, 925.2043242811177, 931.5063016601213, 948.5968463403026, 5844.298684157843, 5848.590598658138, 5898.262717160355, 5957.344692083867, 6081.023667308143, 461.206724433973, 471.92921061840315, 481.81931775584155, 482.1153183907499, 486.2778773521318, 3880.1269714314617, 3915.2169566086895, 3983.063979964706, 4017.0760725033406, 4019.577944315863, 10282.177425805918, 10664.360138391721, 10774.084202842689, 10788.730281742863, 10790.136789056856, 10625.681229563126, 10769.569217231223, 10776.838347424795, 10789.29869558492, 10814.945925270324, 7993.080795708452, 8164.673413063411, 8184.181581841768, 8191.344692424592, 8195.877061844078, 4728.479867214673, 6003.369646187088, 6026.216591843032, 6070.9089363658695, 6129.325774164749, 10054.849177262493, 10195.949020255148, 10253.846192306972, 10293.485325733833, 10297.485125743533, 9988.350757200758, 10146.0, 10415.375077495375, 10417.895821041693, 10518.789624207626, 6908.171019477695, 7185.928140718735, 7394.4454165936695, 7680.9231907680205, 7771.572563509061, 8337.916620833714, 8360.12218717026, 8448.070712221528, 8453.323734101134, 8454.408191426786, 7276.927230727625, 7375.520591161558, 7459.589722565311, 7619.08570971487, 7633.732819351296, 7309.195988441161, 7332.890006650011, 7356.190819009797, 7429.14564825052, 7438.925610743823, 6945.513814032969, 7007.159140903124, 7013.368796808311, 7034.331738484836, 7038.612876291853, 4787.712737235777, 4851.51484851512, 5025.698458092526, 5054.989002199502, 5103.744812759422, 4963.131451995814, 5022.67352622093, 5043.319151914591, 5122.0, 5133.717645529532], "value": 4568.794026486451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7301037373315, 321.3236137929658, 323.82513442740907, 330.09553822526277, 339.0963083382785, 5820.4179582041825, 5897.970510147448, 5911.46796788289, 5919.85200369991, 5940.287165540141, 5858.472737453629, 5869.882602347961, 5871.919016283685, 5881.206037184978, 5905.608228667385, 3724.9698914091887, 4151.750894946298, 4212.347086201644, 4297.355396690506, 4468.709533880304, 4114.650254728352, 4332.545082766312, 4391.407160033386, 4423.0, 4427.070315233805, 4366.694331396803, 4381.496127945279, 4405.559444055585, 4429.379886815848, 4434.334849772544, 3057.373238486116, 4032.8386864525382, 4092.0383709828166, 4095.9350568852014, 4368.628666563346, 3186.5060915558124, 3205.871765129392, 3560.483729859182, 3801.4794082367, 3805.714571407128, 5170.138750049979, 5588.469095435927, 5638.2670252866865, 5663.745131469093, 5686.147077938301, 4336.306191009423, 4855.256779919334, 5115.155999260118, 5167.974160129175, 5193.324867767204, 4965.871500954376, 6206.028141989131, 6225.844353891143, 6252.531060170505, 6271.435570798604, 4302.612764851178, 4307.763073030982, 4308.061372382409, 4311.892202694927, 4323.308270676676, 5459.3994660587305, 6071.635701857903, 6120.877582448326, 6252.686935743499, 6572.309907459696, 3626.818659067036, 4269.743815371087, 4303.505096913832, 4330.41539392178, 4336.457942757155, 4381.9342709859375, 4404.889877753018, 4419.204543182258, 4422.933655995163, 4424.60178583929, 4258.74447533149, 4507.887302817456, 4801.207800712913, 5141.7686204120155, 5147.382314122255, 6230.688465576703, 6248.375162483806, 6258.593191442633, 6265.4361107500545, 6288.339724328971, 1487.8239835255533, 1511.6523199664139, 1515.5832146159673, 1523.5733994481564, 1525.6491007068214, 957.3298690916387, 989.9406035637741, 994.7811481474064, 1024.0987930621006, 1032.6488993742014, 5177.171652535576, 5745.798897038583, 5822.243108395882, 5887.9079040066745, 5910.172575839386, 6537.869242615121, 6562.212534495891, 6575.0, 6608.702608382634, 6619.536632435684, 4998.725070121178, 5592.888142237132, 5685.80598074409, 5898.8230353089475, 5909.674967876808, 3027.6366835979384, 3387.256322378881, 3395.320935812798, 3420.6579342065593, 3460.411730005905, 6535.640539770263, 6789.25318214996, 6789.287124851919, 6796.864062718718, 6802.727890884309, 6605.735770569124, 6626.602403855784, 6657.567258128206, 6664.76787240106, 6670.332966703291, 6558.770443034471, 6759.797206083826, 6762.560433571802, 6773.221079575912, 6784.660766961632, 6221.5333849962335, 6411.6153030818305, 6494.557884321317, 6495.870082598416, 6515.23102681368, 6213.565050446426, 6402.647854368054, 6408.263049749338, 6438.195225596801, 6470.838229044311, 6129.509639228761, 6380.776672816615, 6689.933100668931, 6692.289622702813, 6746.6626668665385, 4172.8122234498915, 4345.891352716081, 4358.542353052884, 4365.432493775789, 4366.235908715898, 5607.80372686954, 6129.353034944201, 6455.288778713046, 6461.870762584816, 6462.5153113515735, 4890.608751299958, 5459.399466058651, 6208.2860471044605, 6219.720112595034, 6254.843628909313, 6086.391360863879, 6268.871603111484, 6283.403076707706, 6288.245410550763, 6321.141561405742, 5826.76692932278, 6010.87978240424, 6076.817695469143, 6117.84705382369, 6202.2867370253, 4976.527229913152, 5023.547880690755, 5395.0, 5882.5293976482635, 6171.691415429121, 5958.463738263577, 6187.690615469299, 6195.876082478235, 6203.627782333075, 6244.469220116341], "value": 4552.288198426729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.3287513174128, 724.9927500724991, 749.8425330680557, 761.0866959648423, 789.798601356654, 14743.336549855256, 15074.623134421645, 15080.547583572483, 15103.697926041486, 15104.169270690121, 12074.93962530186, 13824.723505529882, 13852.0, 13855.445782168727, 13862.168269903812, 916.6379280184323, 947.0576776107748, 947.2516711797672, 949.4161090929064, 949.520492151466, 941.9967734362916, 944.1927152284801, 944.6599224279254, 944.8818897637796, 945.3713280668347, 977.1449981266392, 995.2635050062974, 996.4370130876068, 997.2221667099674, 999.3204620857814, 764.2357642357642, 987.7876256604828, 987.8073775613758, 988.9851652225223, 995.975100622483, 716.3874886971616, 735.5880706804206, 736.2600586410676, 738.04791818554, 741.2069086077898, 14809.111453312837, 14853.108813471119, 14899.553013409615, 14900.329485173193, 14916.030458020194, 12079.698007549881, 12212.450439730233, 12330.19853709506, 12505.999520038375, 12559.309237991907, 8490.745277641681, 9037.954810225972, 9675.951620241924, 10112.342697724698, 10838.512266948006, 3519.1202199450136, 3533.9823300883586, 3591.5690117185845, 3656.561212654472, 3658.244042859416, 74546.99999999946, 80707.7893831593, 81027.0, 82557.0, 82676.0, 9303.069693030642, 9319.301052421095, 9547.045295470398, 9581.808363832684, 10033.548490317953, 17168.656626867643, 20573.868437236095, 20702.378928632166, 20766.0, 20847.37457876266, 7509.09890813095, 7600.961995189989, 7622.085349758065, 7770.45606807518, 7817.5309481431295, 4026.798660066985, 4113.053997580513, 4149.813258403379, 4161.334186530201, 4167.083241686824, 3373.6795004474534, 3679.816009199529, 3694.319084816402, 3700.130469339703, 3701.0747313171705, 654.7806484827636, 668.3516988521127, 670.3330186464499, 672.0960308385214, 690.6926417744056, 485.4999350668817, 563.3465180390727, 575.1545228514077, 588.2470437839572, 619.6839611798016, 6459.289478157399, 7836.09884863248, 7961.964944557286, 8070.47541909774, 8122.390820688353, 569.2429069337771, 591.9230500034968, 597.7101105963604, 621.0404924391826, 621.9657918814418, 3772.9245415091546, 3797.9240415192094, 3806.7335286530233, 3819.618038196158, 4024.939625905614, 86287.27425451581, 92825.0, 95702.0, 96042.55936160963, 96059.51970240104, 78107.0, 78926.21073789304, 79783.60108199422, 81336.0, 81728.59135704402, 64202.67898660477, 65453.0, 65873.6825263492, 66338.33661663321, 67070.0, 7471.9626401867645, 7535.434842386733, 7554.66004029809, 7634.274743899321, 7658.119316278477, 43246.351304731084, 43385.0, 43785.56214437815, 43874.78062609667, 44644.33033504435, 49635.503644963086, 53910.46089539054, 55507.16739248995, 56799.43200567942, 57543.136852948075, 10536.367817930948, 10598.25812193139, 10662.0, 10760.784784304113, 11075.833862491907, 9685.806283874424, 11981.76036479248, 12086.879131208576, 12103.092268079754, 12350.135490515577, 11349.262297950938, 11373.658790236306, 11434.485448154686, 11548.191626586058, 11728.003119734576, 11392.0, 11496.252743571642, 11564.653060408202, 11652.009579185526, 12139.696507587381, 11047.558097676003, 11474.254173478697, 11742.530298788295, 11814.822777658514, 11818.113641476752, 9304.441733496013, 9375.85936210971, 9389.765255868659, 9630.133288003834, 9864.358816676893, 9580.616775329188, 9664.0, 9723.951380243054, 9795.560514884617, 9925.851112233468], "value": 6833.19054590838, "unit": "score"}], "name": "dromaeo_css", "value": 7330.357820691322, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 113.0, 113.0, 113.0, 118.0, 112.0, 113.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 145.0, 167.0, 118.0, 141.0, 140.0, 118.0, 171.0, 145.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 185.0, 184.0, 183.0, 181.0, 182.0, 182.0, 183.0, 186.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 88.0, 90.0, 56.0, 57.0, 58.0, 78.0, 86.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 99.0, 140.0, 78.0, 76.0, 81.0, 123.0, 80.0, 76.0, 126.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 88.0, 87.0, 83.0, 88.0, 85.0, 87.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 92.0, 113.0, 147.0, 147.0, 94.0, 93.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 87.0, 84.0, 87.0, 87.0, 94.0, 126.0], "value": 90.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 57.0, 59.0, 61.0, 60.0, 75.0, 58.0, 57.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 73.0, 78.0, 71.0, 69.0, 67.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 85.0, 85.0, 85.0, 81.0, 105.0, 88.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 142.0, 140.0, 141.0, 138.0, 142.0, 140.0, 182.0, 143.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 170.0, 169.0, 170.0, 169.0, 169.0, 169.0, 177.0, 170.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 93.0, 98.0, 92.0, 93.0, 68.0, 67.0, 65.0], "value": 78.0, "unit": "score"}], "name": "kraken", "value": 1500.7, "alertThreshold": 2.0}]} 22:33:26 INFO - Return code: 0 22:33:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:33:26 ERROR - # TBPL SUCCESS # 22:33:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:33:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:33:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:33:26 INFO - 2016-04-13 22:33:26.341 screenresolution[1681:10122] starting screenresolution argv=screenresolution get 22:33:26 INFO - 2016-04-13 22:33:26.343 screenresolution[1681:10122] Display 0: 1600x1200x32@60 22:33:26 INFO - 2016-04-13 22:33:26.349 screenresolution[1682:10125] starting screenresolution argv=screenresolution list 22:33:26 INFO - Available Modes on Display 0 22:33:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:33:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:33:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:33:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:33:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:33:26 INFO - Intel Iris: 22:33:26 INFO - Chipset Model: Intel Iris 22:33:26 INFO - Type: GPU 22:33:26 INFO - Bus: Built-In 22:33:26 INFO - VRAM (Dynamic, Max): 1536 MB 22:33:26 INFO - Vendor: Intel (0x8086) 22:33:26 INFO - Device ID: 0x0a2e 22:33:26 INFO - Revision ID: 0x0009 22:33:26 INFO - Displays: 22:33:26 INFO - Display: 22:33:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:33:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:33:26 INFO - Display Serial Number: 1600x1200 60 22:33:26 INFO - Main Display: Yes 22:33:26 INFO - Mirror: Off 22:33:26 INFO - Online: Yes 22:33:26 INFO - Rotation: Supported 22:33:26 INFO - Return code: 0 22:33:26 INFO - Running post-action listener: _resource_record_post_action 22:33:26 INFO - Running post-run listener: _resource_record_post_run 22:33:27 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37742080; Write bytes: 695328768; Read time: 398; Write time: 2766 22:33:27 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 385315328; Write bytes: 379266560; Read time: 28459; Write time: 789 22:33:27 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 35923456; Write bytes: 298555904; Read time: 377; Write time: 1938 22:33:27 INFO - Running post-run listener: _upload_blobber_files 22:33:27 INFO - Blob upload gear active. 22:33:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:33:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:33:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:29 INFO - (blobuploader) - INFO - Done attempting. 22:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:30 INFO - (blobuploader) - INFO - Done attempting. 22:33:30 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:30 INFO - Return code: 0 22:33:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09ac74f1fbfa3adb238ffc0fcb87ee6a464b56b06492fddacacf833b798795d3aee56b9801dddbcf5b0f6ae8a8fa057d878629a8f7842c56db821ebaab274b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b6aca53fdfb739e7c285150b58490d08c9c49d3056ff749f6fc12e9cb1dbbe712eb5f4ec8fb573988257c3de360c3647ce81fba735c26b3901d6bc6a9cc54c4"} 22:33:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:30 INFO - Contents: 22:33:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09ac74f1fbfa3adb238ffc0fcb87ee6a464b56b06492fddacacf833b798795d3aee56b9801dddbcf5b0f6ae8a8fa057d878629a8f7842c56db821ebaab274b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b6aca53fdfb739e7c285150b58490d08c9c49d3056ff749f6fc12e9cb1dbbe712eb5f4ec8fb573988257c3de360c3647ce81fba735c26b3901d6bc6a9cc54c4"} 22:33:30 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:30 INFO - Copying logs to upload dir... 22:33:30 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.806823 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-13 22:33:30.104108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 22:33:30.107644) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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/09ac74f1fbfa3adb238ffc0fcb87ee6a464b56b06492fddacacf833b798795d3aee56b9801dddbcf5b0f6ae8a8fa057d878629a8f7842c56db821ebaab274b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b6aca53fdfb739e7c285150b58490d08c9c49d3056ff749f6fc12e9cb1dbbe712eb5f4ec8fb573988257c3de360c3647ce81fba735c26b3901d6bc6a9cc54c4"} build_url:https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/aXf4b9pARVCjBhwO2_oCow/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/09ac74f1fbfa3adb238ffc0fcb87ee6a464b56b06492fddacacf833b798795d3aee56b9801dddbcf5b0f6ae8a8fa057d878629a8f7842c56db821ebaab274b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b6aca53fdfb739e7c285150b58490d08c9c49d3056ff749f6fc12e9cb1dbbe712eb5f4ec8fb573988257c3de360c3647ce81fba735c26b3901d6bc6a9cc54c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 22:33:30.136069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:33:30.136453) ========= 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.xhwpuZGH5m/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.B3Axebkkr5/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:33:30.185508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 22:33:30.185882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 22:33:30.186361) ========= ========= Total master_lag: 0.24 =========