builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1460179693.99 results: success (0) buildid: 20160408213953 builduid: 4c4c95a0875f4b309cfe650acfb4b3e2 revision: ca3f8c085a584d804511d9a551e95606fc8ff41d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:13.985625) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:13.986020) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:13.986310) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005576 basedir: '/builds/slave/test' ========= master_lag: 0.27 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.257051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.257408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.701731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.701988) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.004948 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.773831) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.774157) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.774627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:14.774984) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-08 22:28:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-04-08 22:28:15 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.541245 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:15.385641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:15.385939) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.025694 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:15.446644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 22:28:15.446970) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca3f8c085a584d804511d9a551e95606fc8ff41d --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 ca3f8c085a584d804511d9a551e95606fc8ff41d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-08 22:28:15,525 truncating revision to first 12 chars 2016-04-08 22:28:15,525 Setting DEBUG logging. 2016-04-08 22:28:15,525 attempt 1/10 2016-04-08 22:28:15,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca3f8c085a58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 22:28:17,804 unpacking tar archive at: fx-team-ca3f8c085a58/testing/mozharness/ program finished with exit code 0 elapsedTime=2.524708 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 22:28:18.013202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:18.016580) ========= echo ca3f8c085a584d804511d9a551e95606fc8ff41d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca3f8c085a584d804511d9a551e95606fc8ff41d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 ca3f8c085a584d804511d9a551e95606fc8ff41d program finished with exit code 0 elapsedTime=0.005690 script_repo_revision: 'ca3f8c085a584d804511d9a551e95606fc8ff41d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:18.077078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:18.077394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:28:18.128309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-08 22:28:18.128784) ========= /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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:28:18 INFO - MultiFileLogger online at 20160408 22:28:18 in /builds/slave/test 22:28:18 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:28:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:28:18 INFO - {'append_to_log': False, 22:28:18 INFO - 'base_work_dir': '/builds/slave/test', 22:28:18 INFO - 'blob_upload_branch': 'Fx-Team', 22:28:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:28:18 INFO - 'branch': 'Fx-Team', 22:28:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:28:18 INFO - 'config_files': ('talos/mac_config.py',), 22:28:18 INFO - 'default_actions': ('clobber', 22:28:18 INFO - 'read-buildbot-config', 22:28:18 INFO - 'download-and-extract', 22:28:18 INFO - 'populate-webroot', 22:28:18 INFO - 'create-virtualenv', 22:28:18 INFO - 'install', 22:28:18 INFO - 'run-tests'), 22:28:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:28:18 INFO - 'download_minidump_stackwalk': True, 22:28:18 INFO - 'download_symbols': 'ondemand', 22:28:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:28:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:28:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:28:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:28:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:28:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:28:18 INFO - 'installer_path': 'installer.exe', 22:28:18 INFO - 'log_level': 'info', 22:28:18 INFO - 'log_name': 'talos', 22:28:18 INFO - 'log_to_console': True, 22:28:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:28:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:28:18 INFO - 'opt_config_files': (), 22:28:18 INFO - 'pip_index': False, 22:28:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:28:18 INFO - 'cmd': ('bash', 22:28:18 INFO - '-c', 22:28:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:28:18 INFO - 'enabled': True, 22:28:18 INFO - 'halt_on_failure': False, 22:28:18 INFO - 'name': 'check_screen_resolution'},), 22:28:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:28:18 INFO - 'cmd': ('bash', 22:28:18 INFO - '-c', 22:28:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:28:18 INFO - 'enabled': True, 22:28:18 INFO - 'halt_on_failure': False, 22:28:18 INFO - 'name': 'check_screen_resolution'},), 22:28:18 INFO - 'run_cmd_checks_enabled': True, 22:28:18 INFO - 'sps_profile': False, 22:28:18 INFO - 'sps_profile_interval': 0, 22:28:18 INFO - 'suite': 'dromaeojs', 22:28:18 INFO - 'system_bits': '32', 22:28:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:28:18 INFO - 'title': 't-yosemite-r7-0085', 22:28:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:28:18 INFO - 'use_talos_json': True, 22:28:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:28:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:28:18 INFO - 'work_dir': 'build'} 22:28:18 INFO - ##### 22:28:18 INFO - ##### Running clobber step. 22:28:18 INFO - ##### 22:28:18 INFO - Running pre-action listener: _resource_record_pre_action 22:28:18 INFO - Running main action method: clobber 22:28:18 INFO - rmtree: /builds/slave/test/build 22:28:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:28:19 INFO - Running post-action listener: _resource_record_post_action 22:28:19 INFO - ##### 22:28:19 INFO - ##### Running read-buildbot-config step. 22:28:19 INFO - ##### 22:28:19 INFO - Running pre-action listener: _resource_record_pre_action 22:28:19 INFO - Running main action method: read_buildbot_config 22:28:19 INFO - Using buildbot properties: 22:28:19 INFO - { 22:28:19 INFO - "project": "", 22:28:19 INFO - "product": "firefox", 22:28:19 INFO - "script_repo_revision": "production", 22:28:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:28:19 INFO - "repository": "", 22:28:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:28:19 INFO - "buildid": "20160408213953", 22:28:19 INFO - "pgo_build": "False", 22:28:19 INFO - "basedir": "/builds/slave/test", 22:28:19 INFO - "buildnumber": 695, 22:28:19 INFO - "slavename": "t-yosemite-r7-0085", 22:28:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:28:19 INFO - "platform": "yosemite_r7", 22:28:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:28:19 INFO - "branch": "fx-team", 22:28:19 INFO - "repo_path": "integration/fx-team", 22:28:19 INFO - "revision": "ca3f8c085a584d804511d9a551e95606fc8ff41d", 22:28:19 INFO - "stage_platform": "macosx64", 22:28:19 INFO - "builduid": "4c4c95a0875f4b309cfe650acfb4b3e2", 22:28:19 INFO - "slavebuilddir": "test" 22:28:19 INFO - } 22:28:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:28:19 INFO - Running post-action listener: _resource_record_post_action 22:28:19 INFO - ##### 22:28:19 INFO - ##### Running download-and-extract step. 22:28:19 INFO - ##### 22:28:19 INFO - Running pre-action listener: _resource_record_pre_action 22:28:19 INFO - Running main action method: download_and_extract 22:28:19 INFO - mkdir: /builds/slave/test/build/tests 22:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:19 INFO - https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:21 INFO - Downloaded 1199 bytes. 22:28:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:28:21 INFO - Using the following test package requirements: 22:28:21 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:28:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:28:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:28:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'jsshell-mac.zip'], 22:28:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:28:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:28:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:28:21 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:28:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:28:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:28:21 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:28:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:28:21 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:28:21 INFO - https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:24 INFO - Downloaded 18014562 bytes. 22:28:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:28:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:28:27 INFO - Return code: 0 22:28:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:28: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:28:27 INFO - https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:35 INFO - Downloaded 18014562 bytes. 22:28:35 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:28:35 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:28:38 INFO - Return code: 0 22:28:38 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:28:38 INFO - https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:39 INFO - Downloaded 10847693 bytes. 22:28:39 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:28:39 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:28:40 INFO - Return code: 0 22:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:40 INFO - https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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:28:43 INFO - Downloaded 108783774 bytes. 22:28:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:28:43 INFO - mkdir: /builds/slave/test/properties 22:28:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:28:43 INFO - Writing to file /builds/slave/test/properties/build_url 22:28:43 INFO - Contents: 22:28:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:28:44 INFO - Running post-action listener: _resource_record_post_action 22:28:44 INFO - Running post-action listener: set_extra_try_arguments 22:28:44 INFO - ##### 22:28:44 INFO - ##### Running populate-webroot step. 22:28:44 INFO - ##### 22:28:44 INFO - Running pre-action listener: _resource_record_pre_action 22:28:44 INFO - Running main action method: populate_webroot 22:28:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:28:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:28:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:28:44 INFO - '--tppagecycles', 22:28:44 INFO - '7'], 22:28:44 INFO - 'tests': ['tsvgm']}}, 22:28:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:28:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:28:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:28:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:28:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['damp', 'tps']}, 22:28:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'tests': ['damp', 'tps']}, 22:28:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['dromaeo_dom']}, 22:28:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:28:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'other-e10s': {'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['a11yr', 22:28:44 INFO - 'ts_paint', 22:28:44 INFO - 'tpaint', 22:28:44 INFO - 'sessionrestore', 22:28:44 INFO - 'sessionrestore_no_auto_restore', 22:28:44 INFO - 'tabpaint']}, 22:28:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['tsvgx', 22:28:44 INFO - 'tsvgr_opacity', 22:28:44 INFO - 'tart', 22:28:44 INFO - 'tscrollx', 22:28:44 INFO - 'cart']}, 22:28:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:28:44 INFO - 'tsvgr_opacity', 22:28:44 INFO - 'tart', 22:28:44 INFO - 'tscrollx', 22:28:44 INFO - 'cart']}, 22:28:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'talos_options': ['--disable-e10s'], 22:28:44 INFO - 'tests': ['tp5o']}, 22:28:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'tests': ['tp5o']}, 22:28:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'talos_options': ['--disable-e10s', 22:28:44 INFO - '--xperf_path', 22:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:44 INFO - 'tests': ['tp5n']}, 22:28:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:44 INFO - 'talos_options': ['--xperf_path', 22:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:44 INFO - 'tests': ['tp5n']}}, 22:28:44 INFO - 'talos.zip': {'path': '', 22:28:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:28:44 INFO - Running post-action listener: _resource_record_post_action 22:28:44 INFO - ##### 22:28:44 INFO - ##### Running create-virtualenv step. 22:28:44 INFO - ##### 22:28:44 INFO - Running pre-action listener: _resource_record_pre_action 22:28:44 INFO - Running main action method: create_virtualenv 22:28:44 INFO - Creating virtualenv /builds/slave/test/build/venv 22:28:44 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:28:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:28:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:28:44 INFO - Using real prefix '/tools/python27' 22:28:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:28:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:28:47 INFO - Installing pip.................done. 22:28:47 INFO - Return code: 0 22:28:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:47 INFO - 'HOME': '/Users/cltbld', 22:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:47 INFO - 'LOGNAME': 'cltbld', 22:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:47 INFO - 'MOZ_NO_REMOTE': '1', 22:28:47 INFO - 'NO_EM_RESTART': '1', 22:28:47 INFO - 'PAGER': '/bin/cat', 22:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:47 INFO - 'PWD': '/builds/slave/test', 22:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:47 INFO - 'SHELL': '/bin/bash', 22:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:28:47 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:47 INFO - 'USER': 'cltbld', 22:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:47 INFO - 'XPC_FLAGS': '0x0', 22:28:47 INFO - 'XPC_SERVICE_NAME': '0', 22:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:48 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:28:48 INFO - Cleaning up... 22:28:48 INFO - Return code: 0 22:28:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:28:48 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:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:48 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:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:48 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:28:48 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:28:48 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:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:48 INFO - 'HOME': '/Users/cltbld', 22:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:48 INFO - 'LOGNAME': 'cltbld', 22:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:48 INFO - 'MOZ_NO_REMOTE': '1', 22:28:48 INFO - 'NO_EM_RESTART': '1', 22:28:48 INFO - 'PAGER': '/bin/cat', 22:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:48 INFO - 'PWD': '/builds/slave/test', 22:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:48 INFO - 'SHELL': '/bin/bash', 22:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:28:48 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:48 INFO - 'USER': 'cltbld', 22:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:48 INFO - 'XPC_FLAGS': '0x0', 22:28:48 INFO - 'XPC_SERVICE_NAME': '0', 22:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:48 INFO - Downloading/unpacking psutil>=0.7.1 22:28:48 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:28:48 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:28:48 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:28:48 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:28:48 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:28:48 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:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:28:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:51 INFO - Installing collected packages: psutil 22:28:51 INFO - Running setup.py install for psutil 22:28:51 INFO - building 'psutil._psutil_osx' extension 22:28:51 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:28:52 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:28:52 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:28:52 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:28:52 INFO - building 'psutil._psutil_posix' extension 22:28:52 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:28:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:28:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:28:52 INFO - ^ 22:28:52 INFO - 1 warning generated. 22:28:52 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:28:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:53 INFO - Successfully installed psutil 22:28:53 INFO - Cleaning up... 22:28:53 INFO - Return code: 0 22:28:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:28:53 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:28:53 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:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:53 INFO - 'HOME': '/Users/cltbld', 22:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:53 INFO - 'LOGNAME': 'cltbld', 22:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:53 INFO - 'MOZ_NO_REMOTE': '1', 22:28:53 INFO - 'NO_EM_RESTART': '1', 22:28:53 INFO - 'PAGER': '/bin/cat', 22:28:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:53 INFO - 'PWD': '/builds/slave/test', 22:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:53 INFO - 'SHELL': '/bin/bash', 22:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:28:53 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:53 INFO - 'USER': 'cltbld', 22:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:53 INFO - 'XPC_FLAGS': '0x0', 22:28:53 INFO - 'XPC_SERVICE_NAME': '0', 22:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:28:55 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:28:55 INFO - Installing collected packages: mozsystemmonitor 22:28:55 INFO - Running setup.py install for mozsystemmonitor 22:28:56 INFO - Successfully installed mozsystemmonitor 22:28:56 INFO - Cleaning up... 22:28:56 INFO - Return code: 0 22:28:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:28:56 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:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:56 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:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:56 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:28:56 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:28:56 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:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:56 INFO - 'HOME': '/Users/cltbld', 22:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:56 INFO - 'LOGNAME': 'cltbld', 22:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:56 INFO - 'MOZ_NO_REMOTE': '1', 22:28:56 INFO - 'NO_EM_RESTART': '1', 22:28:56 INFO - 'PAGER': '/bin/cat', 22:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:56 INFO - 'PWD': '/builds/slave/test', 22:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:56 INFO - 'SHELL': '/bin/bash', 22:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:28:56 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:56 INFO - 'USER': 'cltbld', 22:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:56 INFO - 'XPC_FLAGS': '0x0', 22:28:56 INFO - 'XPC_SERVICE_NAME': '0', 22:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:28: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:28: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:28: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:28: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:28: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:28: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:28:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:28:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:28:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:28:59 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:28:59 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:28:59 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:28:59 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:28:59 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:28:59 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:28:59 INFO - Downloading docopt-0.6.1.tar.gz 22:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:29:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:29:00 INFO - Running setup.py install for blobuploader 22:29:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:29:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:29:00 INFO - Running setup.py install for requests 22:29:00 INFO - Running setup.py install for docopt 22:29:00 INFO - Successfully installed blobuploader requests docopt 22:29:00 INFO - Cleaning up... 22:29:00 INFO - Return code: 0 22:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:00 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:29:00 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:29:00 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:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:00 INFO - 'HOME': '/Users/cltbld', 22:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:00 INFO - 'LOGNAME': 'cltbld', 22:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:00 INFO - 'MOZ_NO_REMOTE': '1', 22:29:00 INFO - 'NO_EM_RESTART': '1', 22:29:00 INFO - 'PAGER': '/bin/cat', 22:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:00 INFO - 'PWD': '/builds/slave/test', 22:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:00 INFO - 'SHELL': '/bin/bash', 22:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:00 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:00 INFO - 'USER': 'cltbld', 22:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:00 INFO - 'XPC_FLAGS': '0x0', 22:29:00 INFO - 'XPC_SERVICE_NAME': '0', 22:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-36x0BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-EqVfbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6H5ore-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-74Ho7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hUDr26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-IkOGMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-h4ioO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-B2hJjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-aLrNy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-kTDj01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-60mcQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-tPYyDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7kOFMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Xa32oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wrRQrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-W6dBhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-vABSeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:29:02 INFO - Running setup.py install for manifestparser 22:29:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:29:02 INFO - Running setup.py install for mozcrash 22:29:03 INFO - Running setup.py install for mozdebug 22:29:03 INFO - Running setup.py install for mozdevice 22:29:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Running setup.py install for mozfile 22:29:03 INFO - Running setup.py install for mozhttpd 22:29:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Running setup.py install for mozinfo 22:29:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Running setup.py install for mozInstall 22:29:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:29:03 INFO - Running setup.py install for mozleak 22:29:04 INFO - Running setup.py install for mozlog 22:29:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Running setup.py install for moznetwork 22:29:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Running setup.py install for mozprocess 22:29:04 INFO - Running setup.py install for mozprofile 22:29:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Running setup.py install for mozrunner 22:29:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:29:04 INFO - Running setup.py install for mozscreenshot 22:29:05 INFO - Running setup.py install for moztest 22:29:05 INFO - Running setup.py install for mozversion 22:29:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:29:05 INFO - Cleaning up... 22:29:05 INFO - Return code: 0 22:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:05 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:29:05 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:29:05 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:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:05 INFO - 'HOME': '/Users/cltbld', 22:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:05 INFO - 'LOGNAME': 'cltbld', 22:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:05 INFO - 'MOZ_NO_REMOTE': '1', 22:29:05 INFO - 'NO_EM_RESTART': '1', 22:29:05 INFO - 'PAGER': '/bin/cat', 22:29:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:05 INFO - 'PWD': '/builds/slave/test', 22:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:05 INFO - 'SHELL': '/bin/bash', 22:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:05 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:05 INFO - 'USER': 'cltbld', 22:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:05 INFO - 'XPC_FLAGS': '0x0', 22:29:05 INFO - 'XPC_SERVICE_NAME': '0', 22:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:05 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ceDBMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:05 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:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:05 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SL2fwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:05 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:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:05 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-s8P_si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:05 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:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:05 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-RidGdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-d3J6X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SNKXUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SjY5t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zMPMEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-LsGCtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6CKpFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-gWp2dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-U7723J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:06 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:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ZIpMQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:07 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:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0HPhH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:07 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:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-eIebn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:07 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:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zDQgyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:07 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:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hQCJFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:07 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:29:07 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:29:07 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:29:07 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:29:07 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:29:07 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:29:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:09 INFO - Downloading blessings-1.6.tar.gz 22:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:29:09 INFO - Installing collected packages: blessings 22:29:09 INFO - Running setup.py install for blessings 22:29:10 INFO - Successfully installed blessings 22:29:10 INFO - Cleaning up... 22:29:10 INFO - Return code: 0 22:29:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:10 INFO - Reading from file tmpfile_stdout 22:29:10 INFO - Current package versions: 22:29:10 INFO - blessings == 1.6 22:29:10 INFO - blobuploader == 1.2.4 22:29:10 INFO - docopt == 0.6.1 22:29:10 INFO - manifestparser == 1.1 22:29:10 INFO - mozInstall == 1.12 22:29:10 INFO - mozcrash == 0.17 22:29:10 INFO - mozdebug == 0.1 22:29:10 INFO - mozdevice == 0.48 22:29:10 INFO - mozfile == 1.2 22:29:10 INFO - mozhttpd == 0.7 22:29:10 INFO - mozinfo == 0.9 22:29:10 INFO - mozleak == 0.1 22:29:10 INFO - mozlog == 3.1 22:29:10 INFO - moznetwork == 0.27 22:29:10 INFO - mozprocess == 0.22 22:29:10 INFO - mozprofile == 0.28 22:29:10 INFO - mozrunner == 6.11 22:29:10 INFO - mozscreenshot == 0.1 22:29:10 INFO - mozsystemmonitor == 0.0 22:29:10 INFO - moztest == 0.7 22:29:10 INFO - mozversion == 1.4 22:29:10 INFO - psutil == 3.1.1 22:29:10 INFO - requests == 1.2.3 22:29:10 INFO - wsgiref == 0.1.2 22:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:10 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:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 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:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:29:10 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:29:10 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:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:10 INFO - 'HOME': '/Users/cltbld', 22:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:10 INFO - 'LOGNAME': 'cltbld', 22:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:10 INFO - 'MOZ_NO_REMOTE': '1', 22:29:10 INFO - 'NO_EM_RESTART': '1', 22:29:10 INFO - 'PAGER': '/bin/cat', 22:29:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:10 INFO - 'PWD': '/builds/slave/test', 22:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:10 INFO - 'SHELL': '/bin/bash', 22:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:10 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:10 INFO - 'USER': 'cltbld', 22:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:10 INFO - 'XPC_FLAGS': '0x0', 22:29:10 INFO - 'XPC_SERVICE_NAME': '0', 22:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 INFO - Cleaning up... 22:29:10 INFO - Return code: 0 22:29:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:29:10 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:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 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:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:29:10 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:29:10 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:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:10 INFO - 'HOME': '/Users/cltbld', 22:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:10 INFO - 'LOGNAME': 'cltbld', 22:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:10 INFO - 'MOZ_NO_REMOTE': '1', 22:29:10 INFO - 'NO_EM_RESTART': '1', 22:29:10 INFO - 'PAGER': '/bin/cat', 22:29:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:10 INFO - 'PWD': '/builds/slave/test', 22:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:10 INFO - 'SHELL': '/bin/bash', 22:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:10 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:10 INFO - 'USER': 'cltbld', 22:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:10 INFO - 'XPC_FLAGS': '0x0', 22:29:10 INFO - 'XPC_SERVICE_NAME': '0', 22:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:11 INFO - Downloading/unpacking jsonschema 22:29: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:29: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:29: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:29: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:29: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:29: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:29:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:29:13 INFO - Downloading/unpacking functools32 (from jsonschema) 22:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:13 INFO - Downloading functools32-3.2.3-2.tar.gz 22:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:29:13 INFO - warning: no files found matching '*.txt' 22:29:13 INFO - no previously-included directories found matching 'build' 22:29:13 INFO - no previously-included directories found matching 'dist' 22:29:13 INFO - no previously-included directories found matching '.git*' 22:29:13 INFO - Installing collected packages: jsonschema, functools32 22:29:13 INFO - Running setup.py install for functools32 22:29:14 INFO - warning: no files found matching '*.txt' 22:29:14 INFO - no previously-included directories found matching 'build' 22:29:14 INFO - no previously-included directories found matching 'dist' 22:29:14 INFO - no previously-included directories found matching '.git*' 22:29:14 INFO - Successfully installed jsonschema functools32 22:29:14 INFO - Cleaning up... 22:29:14 INFO - Return code: 0 22:29:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:14 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 0x10e6cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb569870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, '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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:29:14 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:29:14 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:29:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:14 INFO - 'HOME': '/Users/cltbld', 22:29:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:14 INFO - 'LOGNAME': 'cltbld', 22:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:14 INFO - 'MOZ_NO_REMOTE': '1', 22:29:14 INFO - 'NO_EM_RESTART': '1', 22:29:14 INFO - 'PAGER': '/bin/cat', 22:29:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:14 INFO - 'PWD': '/builds/slave/test', 22:29:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:14 INFO - 'SHELL': '/bin/bash', 22:29:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:14 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:14 INFO - 'USER': 'cltbld', 22:29:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:14 INFO - 'XPC_FLAGS': '0x0', 22:29:14 INFO - 'XPC_SERVICE_NAME': '0', 22:29:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:14 INFO - Downloading/unpacking flake8 22:29:14 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:29:14 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:29:14 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:29:14 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:29:14 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:29:14 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:29:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:29:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:29: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:29: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:29: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:29: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:29: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:29: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:29:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:29:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:29:18 INFO - no previously-included directories found matching 'docs/_build' 22:29:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:29:18 INFO - Running setup.py install for pep8 22:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:29:18 INFO - no previously-included directories found matching 'docs/_build' 22:29:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:29:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:29:18 INFO - Cleaning up... 22:29:18 INFO - Return code: 0 22:29:18 INFO - Running post-action listener: _resource_record_post_action 22:29:18 INFO - Running post-action listener: _start_resource_monitoring 22:29:18 INFO - Starting resource monitoring. 22:29:18 INFO - ##### 22:29:18 INFO - ##### Running install step. 22:29:18 INFO - ##### 22:29:18 INFO - Running pre-action listener: _resource_record_pre_action 22:29:18 INFO - Running main action method: install 22:29:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:18 INFO - Reading from file tmpfile_stdout 22:29:18 INFO - Detecting whether we're running mozinstall >=1.0... 22:29:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:29:18 INFO - Reading from file tmpfile_stdout 22:29:18 INFO - Output received: 22:29:18 INFO - Usage: mozinstall [options] installer 22:29:18 INFO - Options: 22:29:18 INFO - -h, --help show this help message and exit 22:29:18 INFO - -d DEST, --destination=DEST 22:29:18 INFO - Directory to install application into. [default: 22:29:18 INFO - "/builds/slave/test"] 22:29:18 INFO - --app=APP Application being installed. [default: firefox] 22:29:18 INFO - mkdir: /builds/slave/test/build/application 22:29:18 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:29:18 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:29:52 INFO - Reading from file tmpfile_stdout 22:29:52 INFO - Output received: 22:29:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:29:52 INFO - Running post-action listener: _resource_record_post_action 22:29:52 INFO - ##### 22:29:52 INFO - ##### Running run-tests step. 22:29:52 INFO - ##### 22:29:52 INFO - Running pre-action listener: _resource_record_pre_action 22:29:52 INFO - Running main action method: run_tests 22:29:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:29:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:29:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:29:52 INFO - 2016-04-08 22:29:52.806 screenresolution[1654:8374] starting screenresolution argv=screenresolution get 22:29:52 INFO - 2016-04-08 22:29:52.809 screenresolution[1654:8374] Display 0: 1600x1200x32@60 22:29:52 INFO - 2016-04-08 22:29:52.815 screenresolution[1655:8376] starting screenresolution argv=screenresolution list 22:29:52 INFO - Available Modes on Display 0 22:29:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:29:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:29:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:29:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:29:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:29:53 INFO - Intel Iris: 22:29:53 INFO - Chipset Model: Intel Iris 22:29:53 INFO - Type: GPU 22:29:53 INFO - Bus: Built-In 22:29:53 INFO - VRAM (Dynamic, Max): 1536 MB 22:29:53 INFO - Vendor: Intel (0x8086) 22:29:53 INFO - Device ID: 0x0a2e 22:29:53 INFO - Revision ID: 0x0009 22:29:53 INFO - Displays: 22:29:53 INFO - Display: 22:29:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:29:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:29:53 INFO - Display Serial Number: 1600x1200 60 22:29:53 INFO - Main Display: Yes 22:29:53 INFO - Mirror: Off 22:29:53 INFO - Online: Yes 22:29:53 INFO - Rotation: Supported 22:29:53 INFO - Return code: 0 22:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:29:53 INFO - Python 2.7.3 22:29:53 INFO - Return code: 0 22:29:53 INFO - grabbing minidump binary from tooltool 22:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:53 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 0x10e56ee00>, '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 0x10e397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e569b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:29:53 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:29:53 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:29:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:53 INFO - Return code: 0 22:29:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:29:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:29:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:29:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:29:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:29:54 INFO - Return code: 0 22:29:54 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/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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:29:54 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/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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:29:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vtl1pKF5jB/Render', 22:29:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:54 INFO - 'HOME': '/Users/cltbld', 22:29:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:54 INFO - 'LOGNAME': 'cltbld', 22:29:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:29:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:54 INFO - 'MOZ_NO_REMOTE': '1', 22:29:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:29:54 INFO - 'NO_EM_RESTART': '1', 22:29:54 INFO - 'PAGER': '/bin/cat', 22:29:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:54 INFO - 'PWD': '/builds/slave/test', 22:29:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:29:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:54 INFO - 'SHELL': '/bin/bash', 22:29:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMgqaeuwam/Listeners', 22:29:54 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 22:29:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:54 INFO - 'USER': 'cltbld', 22:29:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:54 INFO - 'XPC_FLAGS': '0x0', 22:29:54 INFO - 'XPC_SERVICE_NAME': '0', 22:29:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:29:54 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/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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:29:54 INFO - mozversion application_buildid: 20160408213953 22:29:54 INFO - mozversion application_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:29:54 INFO - mozversion application_display_name: Nightly 22:29:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:54 INFO - mozversion application_name: Firefox 22:29:54 INFO - mozversion application_remotingname: firefox 22:29:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:29:54 INFO - mozversion application_vendor: Mozilla 22:29:54 INFO - mozversion application_version: 48.0a1 22:29:54 INFO - mozversion platform_buildid: 20160408213953 22:29:54 INFO - mozversion platform_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:29:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:29:54 INFO - mozversion platform_version: 48.0a1 22:29:54 INFO - using testdate: 1460179794 22:29:54 INFO - actual date: 1460179794 22:29:54 INFO - starting webserver on 'localhost:49275' 22:29:54 INFO - SUITE-START | Running 2 tests 22:29:54 INFO - TEST-START | dromaeo_css 22:29:54 INFO - operating with platform_type : mac_ 22:29:54 INFO - Initialising browser for dromaeo_css test... 22:29:54 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpuuEpaJ/profile http://localhost:49275/getInfo.html) 22:29:56 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 22:29:56 INFO - PROCESS | 1673 | colorDepth:24 22:29:56 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 22:29:56 INFO - PROCESS | 1673 | __metrics 22:29:56 INFO - PROCESS | 1673 | 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:29:56 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:29:57 INFO - TEST-INFO | 1673: exit 0 22:29:57 INFO - Browser initialized. 22:29:57 INFO - Running cycle 1/1 for dromaeo_css test... 22:29:57 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpuuEpaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:09 INFO - PROCESS | 1676 | RSS: Main: 237441024 22:30:09 INFO - PROCESS | 1676 | 22:31:00 INFO - PROCESS | 1676 | 1460179860209 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:33:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 22:33:12 INFO - PROCESS | 1676 | RSS: Main: 400842752 22:33:12 INFO - PROCESS | 1676 | 22:36:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 22:36:15 INFO - PROCESS | 1676 | RSS: Main: 380510208 22:36:15 INFO - PROCESS | 1676 | 22:39:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 22:39:18 INFO - PROCESS | 1676 | RSS: Main: 375214080 22:39:18 INFO - PROCESS | 1676 | 22:42:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 22:42:21 INFO - PROCESS | 1676 | RSS: Main: 340111360 22:42:21 INFO - PROCESS | 1676 | 22:45:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 22:45:24 INFO - PROCESS | 1676 | RSS: Main: 341929984 22:45:24 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 22:48:27 INFO - PROCESS | 1676 | RSS: Main: 424902656 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | __start_tp_report 22:48:27 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 22:48:27 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 22:48:27 INFO - PROCESS | 1676 | |i|pagename|runs| 22:48:27 INFO - PROCESS | 1676 | |0;dojo.html;3180.204948762809;3379;3411.0790086676584;3447.2588393495394;3451.396005699002;5586.720663966806;5716.371199168088;5721.399253078429;5723.62796418233;5727.455891690288;5671.517920976722;5695.373508914016;5746.1668058131545;5816.302043754745;5823.359430462657;5160.6903585784785;5170.741462926858;5195.896082078356;5215.061288967984;5296.073187192226;5262.842114736564;5294.258803767476;5310.893782124355;5336.759845806929;5358.973205133969;5102.6173037022;5108.386993560759;5200.76596553156;5209.609279304048;5234.900670859086;5221.869453263661;5222.216667499867;5223.71269580173;5240.737963101829;5247.23915032322;5159.432462429129;5191.922121168185;5192.584593232532;5210.947890521122;5222.451642577513;5478.780848766045;5569.081101618228;5613.943860561383;5682.6306290091015;5689.857753556153;6208;6228.937710622881;6255.249370075575;6258.812235632939;6264.655443950581;6223.657698826562;6284.12022316876;6287.8742425151695;6289.276733175698;6299.5275354348605;5654.095344744821;5682.147677848356;5763.510101641407;5822.7088645567555;5834.241548598698;6258.280297765815;6278.780242691484;6285.654289014148;6288.937110628926;6289.905651415233;6072;6120.938790612036;6176.3514830943;6193.876122477615;6203.751849926042;6286.717097730613;6292;6306.085617585516;6308.369163083747;6309.936900631027;6244.344343843831;6247.687615619292;6254.093156492283;6255.530835187379;6259.311475737665;5198.92201616976;6113.141862489121;6163.38366163389;6280.371962803774;6281.59169653971;4922.015596880638;4951.876203094951;4959.677620954626;4974.801007959641;4976.42771081323;3775;4399.692021558524;4466.843660471868;4468.240399132155;4536.500984891659;5697.572682048863;5705.372409035002;5767.307923049261;5796.449337312949;5800.332961709373;6242.781502647385;6281.277653069864;6297.590656607397;6300.338464461165;6306.8423289417215;5581.10702287632;5740.454656807597;5772.509336706343;5780.739866706008;5799.623024503394;5325.866853328698;5347.625666203328;5409.2967914171695;5413.2150838128255;5439.836804895859;6219.315875253718;6257.405546473078;6258.499320054476;6258.561900667;6276.340984196685;6097.664628445478;6284.057391391328;6322.146510221061;6324.2410910691015;6329.461995730415;6187.628742275478;6214.223222097238;6241.251049874044;6244.2819075806865;6270.404311590391;6198.783042593487;6200.627962322275;6206.627602343874;6212.409821066992;6228.626282423069;5107.693538387709;5948.940510595012;6080.118382834376;6258.780942666985;6297;6028.758849645965;6071.908921366095;6137.009281402588;6145.156453064153;6154.815355539341;5029.4216165140015;6087.6897133220555;6093.625290627054;6115.727150604614;6116.731440059295;5141.897162056813;5784.421557844182;5834.416558344132;5970.104484327386;5971.223740913653;6036.728347224298;6038.69806509664;6068.089786531879;6075.939240607714;6100.206973093469;5921.970390148022;5937.139114828412;5937.821865344046;5942.078977758454;5943.940560594512 22:48:27 INFO - PROCESS | 1676 | |1;ext.html;515.9355080614923;528;539.9838004859853;557.9426985861792;569.4903061759728;27792.444151116964;29040.41919161618;36938.707145249886;37685.246295074154;37743.811280943555;41150.38274425886;41789.746307610745;41875.16249675005;41909.95225119373;41973.58026419735;9454.81090378192;9558.522073896313;9687.903120968806;9697.951510242474;9698.757531061709;9475.241980641533;9490.81018379632;9554.187894029015;9634.75913102171;9648.758781030496;9591.992840751725;9643.758906027371;9663.613455461807;9666.033396660312;9668.951655241714;9522.761930951712;9574.856377154349;9589.041095890425;9636.132748052709;9646.228301735879;9374.62501499946;9472.242220622402;9489.525523723787;9500;9510.762230944212;32214.03357899267;38595.421068683994;38848.61151388478;39118.41322380167;39430.49396849545;3381.8647254109806;3565.732570057256;3778.1688028633657;3830.655241028293;4123.134141830219;27910.441791164063;28196.718032819615;28248.870045198168;28651.283717907012;28782.856085719646;2649.7477144427276;2681.048227879094;2685.4897569461937;2781.568856827195;2810.6065150878894;430668;431671;431870.99999999686;432008;432119;34414.311713765586;57415.13877291844;57586.84826303534;57776.133357999664;57804;34043.82978085094;34234.48648270278;34322.313553729284;34325.313493729984;34333.484997725056;13113;13342.533011344556;13349.399277032557;13369.866301337057;13397.531086412124;11923.761524769456;11982.400879955967;11991.340476273888;11997.460114294703;12006.87993120075;7894.447388682852;8044;8048.356131509465;8119.9188008120345;8142.4300298978505;2863.3700585871075;3428.6571342865514;3432.262063656326;3448.4482482803132;3474.287771006988;995.0994350113015;1000.6747806962766;1010.782681723433;1038.3302769713493;1047.0838016735356;22597.887010564842;29127.980520681675;29212.260383386838;29505.852470737937;29753.10740677783;1118.972025699364;1133.637236084445;1164.772869290497;1165.8426112474876;1171.4611278811672;14244.85755142456;14831.18428486422;14865.729539501292;15283.46507872219;15286.464973725866;580544;611120;691145;692593;692798;54466.72766636221;54683.453165467836;55580;55615.16577251344;55862.162067568206;1309.5743883237794;1350.73660636175;1452.7748199029168;1468.5520916120472;1560.781490591318;24403.14588989448;29143.85428072846;29228.83084676589;29713.571607098227;29718.702812972457;51030.48969510257;51779.741101294254;52134.21798673099;52135;52180.21729673982;540053;543687.6312368889;543802;544754;545346;26129.869350653124;26330.94676213007;26409.73590264073;26790.053094160015;26806.59790103189;42274.788626056674;42654.57345426506;42673.359899602154;42996;43618.127637446436;34669.65330346664;35683.82158089193;35788.926332210074;36260.81869590635;36619.450708238866;34665.48001779925;35035.824820876755;35382.82308588544;35798.105047374025;35821.1044723884;34945.65054349424;35081.82459087688;35183.82408087943;35363;35457.468137977434;30907.84546077255;31487;31495;31628.841855790575;31812.84093579517;23523.354394945432;23651.56794425087;23658.408539785956;23838.642420364056;23869.641955370334 22:48:27 INFO - PROCESS | 1676 | |2;jquery.html;334.8760958445375;388.72400595577136;389.1613572750723;395.35557042021503;399.19163693520636;14914.962026445233;16045.438409655664;19319;21130.89434552827;21242.46893827655;11777.352245626487;12298.200616959914;20738.688919666216;21657.783422165812;21692.8915355423;5235.659682120659;5379.220013098098;5434.266374039494;5447.945520544803;5464.180372944051;3946.2304850554156;6441.227052753653;7289.744858929938;7669.118051424102;7680.500767450098;7559.28186822251;7651.579163146025;7675.692972281102;7677.155512893577;7690.384769218477;7552.509086909361;7685.269899359608;7782.260685234922;7786.221377862225;7798.727044553441;7266.091738532684;7507.099148102263;7548.282913123245;7554.546727196386;7561.735339263154;28037.719622803714;28660.426791464262;29740.70259297401;29871.70128298711;30064;2013.3758534854242;2109.968350474744;2138.786121387864;2224.3215819175143;2993.3414648777452;15344.156071416179;15613.141277229748;15884.92057539705;15894.966827156199;16392.83607163937;1866.72932424799;1870.7661542307212;1883.9717404238947;1915.9521011974673;1973.0923775063345;132381.35237295297;134471;136069.3196534011;137026;138592;20417.2853950114;20514.487137821674;20520.13530848059;20579.044990725855;20664.48338791542;35346.469802952975;35387.58449662036;35414.114647134025;35427.280135585395;35480.82259588686;10374.22193335503;10648.840267395995;10664.253502254924;10679.519421626046;10714.732131696614;7212.639368031578;8535.317174626016;8612.956935215283;8640.265577425864;8715.564221788885;9489.715308540755;9526.571304291323;9614;9660.903390966141;9678.128968392879;3663;3762.473253744478;3782.659560639556;3785.962140378561;3879.8466850897457;820.9548474833941;878.9208971192623;983.3460748602242;1002.2683441087901;1023.7031260934245;16230;20292;20396.898015510124;20706.68939965902;20757.896210519153;875.9357380782253;906.1663269791808;929.8047410043966;968.2689569375218;999.3154689038032;8031;10639.680809575726;10718.196135289885;10758.623448179433;10762.139028877671;502525;508049;509814;635982.6401735924;639387;95941.5202923981;108874.27814304706;129843;144316;144731;943.127606963556;1032.5869652139204;1053.7418332508432;1101.0035917494681;1101.542859713226;17101;17882.28470861151;18303.35938242155;18428.262869485607;18727.719084213477;46813.2978005337;47504.2874356878;48079.278810817166;48858;49001;71216;72813.63593182;76046.47907041718;77256;79291.20708793068;7749.263819937097;8104.918950810416;8198.877016844872;8287.461315014505;8409.789755256168;10327.535260913126;12344.074194435632;12569.560065398033;12594.141430156664;12634.052446066766;5609.186667933045;7238.927610724036;10685;10974.695313984153;11220.99011089006;5348.652337598043;9038.412503187272;10595.523201455799;10601.102178876787;10794.946025269823;9253.537323133682;10835.349879007284;11089.778204436028;11374.658760237206;11416.086713062768;9924.206063515046;10048.598056077675;11414.143939204427;11647.708807279885;11798.233114847508;5752.741126649227;10764.946175269386;11159.832602511131;11162.107031437303;11442.112051511407 22:48:27 INFO - PROCESS | 1676 | |3;mootools.html;1416.8512306207854;1595.792546968894;1605.5263697209323;1847.3995951315826;1960.2844961589024;7846.136924938252;8534.359923005775;8804.823903521925;8808.955955220223;8815.955920220405;8397.45416547924;8646.437981531197;8651.826963460728;8670.176333248348;8674.783130421743;2145.9785402146013;2377.286813955815;2425.248173066351;2463.3841539615096;2464.3223113643803;2469.876506174693;2501.112105202654;2502.78726308264;2503.924882253535;2509.3475696318906;2410.8553486790847;2471.122751423246;2474.6906636670415;2475.950480990379;2484.354067942339;2330.8251881108986;2347.730011048734;2375.619900815861;2380.1788383008006;2394.1261439574428;2388.176079252655;2412.0472413396787;2434.902603895842;2446.816488763332;2448.0207916833233;8598.957005214934;8610.225079742791;8681.869771953427;8691.95654021726;8700.042995270514;5095.5923526118195;5267.236250743659;5279.287296215;5279.63042587019;5290.153575427951;3388.7797293175863;3455.8963231102857;3506.2461570762407;3583.7670551414076;3593.8203089845665;1006.3710181136789;1026.4764969865348;1029.8403747419088;1037.8339465685528;1037.9221558383151;11401.543938242461;11488;11503.309801411859;11505.309681419141;11544.134189935789;4500.504944456107;4510.481294651091;4699.318598803223;4707.7175369477945;4712.081144176921;9094.590743416562;9109.134632209929;9117.08829117083;9121.680741174026;9154.359194856295;5229.816956406507;5244.160934250502;5260.894782104337;5266.605004624592;5273.31446911899;4071.75569465833;4359.433273674465;4539.0921815637;4702.811887524461;4829.541193586604;3737.2338670572467;3756.586775454698;3847;3864.8840534784003;3872.786996715208;1023.6007956896816;1079.4764539198482;1178.0516684069407;1201.1231800785476;1209.9637010889687;1308.535469908188;1322.9140105893086;1358.9116707413987;1369.732902084104;1370.5614203454998;7981.241782030698;8152.347812175011;8165.877511837327;8170.550619715973;8248.876266856001;468.33496435062295;475.15185394071415;508.3137764018619;519.4182515582496;519.5479932458785;6210.192674952317;6228.875422491525;6293.402126797947;6303.810885673345;6340.080688300263;9850.950745246371;10154.593816247416;10307.433091180057;10354.844677329846;10376.636817711495;9846.655367062118;10163.542640581192;10188.490575471196;10205.74485637865;10298.382097074049;7750.689972401041;7919.643616037292;7941.523508589503;7944.086430060502;7949.364050876032;7734.574598397142;7735.961320193588;7774.416918731231;7821.217878212134;7881.448298619271;9374.484403357881;9537.23702103844;9558.378705384128;9625.855612165684;9648;9387.061293870558;9583.08960648765;9685.273604479833;9791.167750741266;9855.162311203341;6446.645434501147;6458.612483250832;6861.073755043205;6932.44540436774;6991.720331186899;8278.627461764114;8377.832443350977;8443.577821109044;8450.366222533457;8494.957525212334;7282.563046217244;7375.188729239887;7507.66215520292;7542.396608271435;7566.470347075652;7460.328570428687;7547.7358292461695;7585.924140758521;7779.183185765413;7794.6882124714375;6480.740770369321;7668;7735.066233441639;7783.221677832172;7833.1775163607;6808.148981377328;7004.614746189009;7052;7061.470389720689;7094.64526773649;7108.893366599608;7179.820504487429;7180;7180.928190718235;7196.640167991684 22:48:27 INFO - PROCESS | 1676 | |4;prototype.html;276.8989318898602;314.82527197405443;320.9582754241948;322.25076696680196;326.882322363949;4624.907501849961;5670.773169073237;5926.199963004993;5949.816847986328;5951.375105613914;5109.3613298337705;5585.1063829787245;5864.149698293755;5882.176495290662;5901.734421951011;3069.41681080594;3659.8902032939054;4392.670549708769;4450.198964186445;4469.44131983502;4408.757518336491;4416.381706561068;4448.377227188196;4451.710638808483;4479.753613551254;4427.579379958899;4433.2241857674935;4457.821687132527;4459.241928872083;4465.196264672358;4171.791410429497;4215.894602634928;4432.290833466646;4482.417285752864;4489.25927222008;3836.4245363195464;3842.1931394407206;3843.1545060087014;3846.211526637033;3856.3444214483607;5582.381109478247;5586.525145362649;5620.960122377373;5622.887542249173;5638.577106717013;4507.887302817423;4816.301636262722;5042.445331013586;5105.668131571436;5115.411727651293;4636.258198688193;5987.43119403656;6219.937800621981;6234.719437625317;6299.779507717254;4163.208990291865;4169.145325208325;4174.935391475185;4180.435641188431;4195.349720793282;6287.591306565058;6598;6628.668566571652;6640.667966601651;6657.367550082734;3578.785272883635;4182.560831112689;4207.368894665763;4218.599233072914;4219.177260434247;4280.721753086102;4298.871033868989;4299.828006879689;4302.290122129813;4323.351497275434;4814.759262036884;5054.292399064134;5066.733316670832;5085.796568137233;5102.515261050195;5245.659032162897;5444.673319600836;6110.938890611126;6304.6847657617855;6332.176817013851;1440.63984003999;1465.1355700136971;1483.7625979843174;1487.5091219897408;1487.7173337065922;896.3501461440403;949.9715008549755;968.9612415503442;971.2375785008734;983.7393090830935;5455.672659640434;5631.465010823965;5752.395998420189;5908.113782932594;5936.940630593639;6250.749970001149;6524.249711283263;6554.049662798963;6563.081168636395;6613.503987200979;5570.610057296031;5804.82585522435;5838.649681019152;5893.705314734246;5905.43898329658;3383.086566626997;3391.2200193955528;3425.469052296898;3425.6745609167087;3428.02888339201;6461.384653836541;6731.966340168366;6760.661966901635;6776.593404395752;6788.185417749803;5891.7054147292465;5920.703964801743;6659.467242620579;6677.232118306457;6693.2223127401585;5127.9230811537855;5596.4123767003875;6107.6640784757265;6133.96933015341;6823.590584564942;5376.569874410116;6223.844403889758;6526.347365263436;6552.934470655233;6569.211694596679;5849.356570777296;5980.501406677143;5997.790077347272;6385.393387628168;6494.0258961156205;5277.788888444573;5599.720013999366;6441.871162576816;6773.966130169318;6798.320167983162;3734.533183352081;4189.3925380819;4209.305464598307;4240.936385954275;4254.212970600449;6185;6476.417122459001;6517.478601711947;6518.869622607616;6520.608763474207;5701.372848986691;6121.234845644294;6249.906251406142;6310.148130002574;6326.8734625306315;5244.606654500852;5759;5796.304443466811;6267.749290028348;6285.528585356208;5831.7375718091935;5933.525317974465;6034.456898879122;6108.358622344767;6166.260048794174;6127.662978536045;6341.714622842075;6346.3028213008365;6386.233651961795;6416.230052393743;5859.710863609999;6209.937900620936;6222.408871157233;6232.594881332699;6238.875222495615 22:48:27 INFO - PROCESS | 1676 | |5;yui.html;736.5543845973186;742.8105833012581;745.4930647159929;745.9701611935523;803.9155888631693;14570.271486425676;14651.926740366283;15015.02402343847;15024.323905424255;15626.76559851603;13430.194188348682;13512.391942362592;13587.72824543511;13592.796108058386;13596.028575856519;717.8313096422337;732.4835990626596;889.4440974391006;905.6015353244584;924.6671198368582;902.6434558349448;908.6683360573376;914;914.6981496106303;914.9771255718593;960.2366118935463;969.4522594733953;971.3006635222629;972.2416515118219;972.9951350243239;763.8663233934067;786.5595266650665;787.1144961917843;789.940754443419;959.184693010942;684.7979845945458;718.3211864787778;723.489939592586;724.8332883436839;725.1624373848214;14567.781483277759;14596.12423254608;14604.34280457382;14654.194019328932;14655.560333190022;12505;12724.363781810873;12771.680707982376;12942.352882355844;13268.137571057947;9887.159591434736;10364.79270414595;10397;10700.357978521313;10812.35125892449;3471.2363280078343;3484.494748261488;3487.0410637074756;3544.468329750532;3603.56757189139;77499;79266;79429.41141177143;79597.20402796014;84320.57839710762;9321.95339023314;9426.057394260519;9441.716748497556;9473.289503287144;9481.66814161501;21178.470538236666;21365.893170534047;21386;21394.679079813504;21430.571388572454;7608.80977975544;7652.248164383843;7658.4639075264195;7841.294283514511;7974.5215287082965;4169.791510424467;4173.373993900939;4258.254805409041;4325.740455572675;4513.1650644630845;3017.6077109976;3473.565804274466;3552.200754830194;3558.679718825318;3582.5163602913794;630.180765005491;648.4844548583887;648.8345471904729;657.8388294867788;672.4586707700348;541.2882060090968;605.5216379060581;609.871926895357;611.9877602448015;612.3845535237058;7798.8276272195235;7998.240167184108;8101;8114.63484143215;8276.589289178299;554.9889002219933;574.5346269521701;578.962367446123;583.5448350286783;607.1651479216077;3718.758280711745;3757.774533527997;3778.4899038629433;3862.942055869164;3863.7102217333813;82165;82304.17695822965;84121.57939210265;84296;84869.08874568081;70782;72288.63855680688;72312.63843680748;73188;73276;62637.373626264976;63463.04805427922;63557;63978.68010659917;64048;7377.26227377258;7525.88711169322;7593.696252149852;7603.885941710768;7648.870892850778;32083;40534.797326013184;42111.36832947447;42744.572554275306;42991;56209.71895140662;58727.70636146792;58859.11711324419;59544.10683839659;60346.09480857878;9742;9867.25995550351;9888.555015024198;9928.056834600702;9951.800963980535;10597.576096956343;10892.836607451052;10961.671149865517;11095.001449869551;11660.06719462458;9849.015098490094;10064.949675251577;10380.688579342632;10381.429021403896;10398.792024159626;10250.641227557;10369.481525923522;10395.844062339222;10604.89395106039;11165.274257173258;10125.088742013255;10157.644482443078;10167.949160254448;10185.898141018495;10210.081092701692;7719.614019299125;8590.312774978112;8679.652813887626;8684.9262137943;8890.511021893857;7648.923510765044;7951.960240198762;8282.544460054514;8460.196281353261;8676.219140277406 22:48:27 INFO - PROCESS | 1676 | __end_tp_report 22:48:27 INFO - PROCESS | 1676 | __start_cc_report 22:48:27 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1639 22:48:27 INFO - PROCESS | 1676 | __end_cc_report 22:48:27 INFO - PROCESS | 1676 | __startTimestamp1460180907939__endTimestamp 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | ------- Summary: start ------- 22:48:27 INFO - PROCESS | 1676 | Number of tests: 6 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5724.23 Median:5937.14 stddev:647.68 (10.9%) stddev-sans-first:618.16 22:48:27 INFO - PROCESS | 1676 | Values: 3180.2 3379.0 3411.1 3447.3 3451.4 5586.7 5716.4 5721.4 5723.6 5727.5 5671.5 5695.4 5746.2 5816.3 5823.4 5160.7 5170.7 5195.9 5215.1 5296.1 5262.8 5294.3 5310.9 5336.8 5359.0 5102.6 5108.4 5200.8 5209.6 5234.9 5221.9 5222.2 5223.7 5240.7 5247.2 5159.4 5191.9 5192.6 5210.9 5222.5 5478.8 5569.1 5613.9 5682.6 5689.9 6208.0 6228.9 6255.2 6258.8 6264.7 6223.7 6284.1 6287.9 6289.3 6299.5 5654.1 5682.1 5763.5 5822.7 5834.2 6258.3 6278.8 6285.7 6288.9 6289.9 6072.0 6120.9 6176.4 6193.9 6203.8 6286.7 6292.0 6306.1 6308.4 6309.9 6244.3 6247.7 6254.1 6255.5 6259.3 5198.9 6113.1 6163.4 6280.4 6281.6 4922.0 4951.9 4959.7 4974.8 4976.4 3775.0 4399.7 4466.8 4468.2 4536.5 5697.6 5705.4 5767.3 5796.4 5800.3 6242.8 6281.3 6297.6 6300.3 6306.8 5581.1 5740.5 5772.5 5780.7 5799.6 5325.9 5347.6 5409.3 5413.2 5439.8 6219.3 6257.4 6258.5 6258.6 6276.3 6097.7 6284.1 6322.1 6324.2 6329.5 6187.6 6214.2 6241.3 6244.3 6270.4 6198.8 6200.6 6206.6 6212.4 6228.6 5107.7 5948.9 6080.1 6258.8 6297.0 6028.8 6071.9 6137.0 6145.2 6154.8 5029.4 6087.7 6093.6 6115.7 6116.7 5141.9 5784.4 5834.4 5970.1 5971.2 6036.7 6038.7 6068.1 6075.9 6100.2 5922.0 5937.1 5937.8 5942.1 5943.9 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:65615.79 Median:35793.52 stddev:147781.72 (412.9%) stddev-sans-first:148115.46 22:48:27 INFO - PROCESS | 1676 | Values: 515.9 528.0 540.0 557.9 569.5 27792.4 29040.4 36938.7 37685.2 37743.8 41150.4 41789.7 41875.2 41910.0 41973.6 9454.8 9558.5 9687.9 9698.0 9698.8 9475.2 9490.8 9554.2 9634.8 9648.8 9592.0 9643.8 9663.6 9666.0 9669.0 9522.8 9574.9 9589.0 9636.1 9646.2 9374.6 9472.2 9489.5 9500.0 9510.8 32214.0 38595.4 38848.6 39118.4 39430.5 3381.9 3565.7 3778.2 3830.7 4123.1 27910.4 28196.7 28248.9 28651.3 28782.9 2649.7 2681.0 2685.5 2781.6 2810.6 430668.0 431671.0 431871.0 432008.0 432119.0 34414.3 57415.1 57586.8 57776.1 57804.0 34043.8 34234.5 34322.3 34325.3 34333.5 13113.0 13342.5 13349.4 13369.9 13397.5 11923.8 11982.4 11991.3 11997.5 12006.9 7894.4 8044.0 8048.4 8119.9 8142.4 2863.4 3428.7 3432.3 3448.4 3474.3 995.1 1000.7 1010.8 1038.3 1047.1 22597.9 29128.0 29212.3 29505.9 29753.1 1119.0 1133.6 1164.8 1165.8 1171.5 14244.9 14831.2 14865.7 15283.5 15286.5 580544.0 611120.0 691145.0 692593.0 692798.0 54466.7 54683.5 55580.0 55615.2 55862.2 1309.6 1350.7 1452.8 1468.6 1560.8 24403.1 29143.9 29228.8 29713.6 29718.7 51030.5 51779.7 52134.2 52135.0 52180.2 540053.0 543687.6 543802.0 544754.0 545346.0 26129.9 26330.9 26409.7 26790.1 26806.6 42274.8 42654.6 42673.4 42996.0 43618.1 34669.7 35683.8 35788.9 36260.8 36619.5 34665.5 35035.8 35382.8 35798.1 35821.1 34945.7 35081.8 35183.8 35363.0 35457.5 30907.8 31487.0 31495.0 31628.8 31812.8 23523.4 23651.6 23658.4 23838.6 23869.6 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:35369.71 Median:16528.67 stddev:94493.53 (571.7%) stddev-sans-first:94721.99 22:48:27 INFO - PROCESS | 1676 | Values: 334.9 388.7 389.2 395.4 399.2 14915.0 16045.4 19319.0 21130.9 21242.5 11777.4 12298.2 20738.7 21657.8 21692.9 5235.7 5379.2 5434.3 5447.9 5464.2 3946.2 6441.2 7289.7 7669.1 7680.5 7559.3 7651.6 7675.7 7677.2 7690.4 7552.5 7685.3 7782.3 7786.2 7798.7 7266.1 7507.1 7548.3 7554.5 7561.7 28037.7 28660.4 29740.7 29871.7 30064.0 2013.4 2110.0 2138.8 2224.3 2993.3 15344.2 15613.1 15884.9 15895.0 16392.8 1866.7 1870.8 1884.0 1916.0 1973.1 132381.4 134471.0 136069.3 137026.0 138592.0 20417.3 20514.5 20520.1 20579.0 20664.5 35346.5 35387.6 35414.1 35427.3 35480.8 10374.2 10648.8 10664.3 10679.5 10714.7 7212.6 8535.3 8613.0 8640.3 8715.6 9489.7 9526.6 9614.0 9660.9 9678.1 3663.0 3762.5 3782.7 3786.0 3879.8 821.0 878.9 983.3 1002.3 1023.7 16230.0 20292.0 20396.9 20706.7 20757.9 875.9 906.2 929.8 968.3 999.3 8031.0 10639.7 10718.2 10758.6 10762.1 502525.0 508049.0 509814.0 635982.6 639387.0 95941.5 108874.3 129843.0 144316.0 144731.0 943.1 1032.6 1053.7 1101.0 1101.5 17101.0 17882.3 18303.4 18428.3 18727.7 46813.3 47504.3 48079.3 48858.0 49001.0 71216.0 72813.6 76046.5 77256.0 79291.2 7749.3 8104.9 8198.9 8287.5 8409.8 10327.5 12344.1 12569.6 12594.1 12634.1 5609.2 7238.9 10685.0 10974.7 11221.0 5348.7 9038.4 10595.5 10601.1 10794.9 9253.5 10835.3 11089.8 11374.7 11416.1 9924.2 10048.6 11414.1 11647.7 11798.2 5752.7 10764.9 11159.8 11162.1 11442.1 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5910.57 Median:5279.46 stddev:3117.53 (59.1%) stddev-sans-first:3107.98 22:48:27 INFO - PROCESS | 1676 | Values: 1416.9 1595.8 1605.5 1847.4 1960.3 7846.1 8534.4 8804.8 8809.0 8816.0 8397.5 8646.4 8651.8 8670.2 8674.8 2146.0 2377.3 2425.2 2463.4 2464.3 2469.9 2501.1 2502.8 2503.9 2509.3 2410.9 2471.1 2474.7 2476.0 2484.4 2330.8 2347.7 2375.6 2380.2 2394.1 2388.2 2412.0 2434.9 2446.8 2448.0 8599.0 8610.2 8681.9 8692.0 8700.0 5095.6 5267.2 5279.3 5279.6 5290.2 3388.8 3455.9 3506.2 3583.8 3593.8 1006.4 1026.5 1029.8 1037.8 1037.9 11401.5 11488.0 11503.3 11505.3 11544.1 4500.5 4510.5 4699.3 4707.7 4712.1 9094.6 9109.1 9117.1 9121.7 9154.4 5229.8 5244.2 5260.9 5266.6 5273.3 4071.8 4359.4 4539.1 4702.8 4829.5 3737.2 3756.6 3847.0 3864.9 3872.8 1023.6 1079.5 1178.1 1201.1 1210.0 1308.5 1322.9 1358.9 1369.7 1370.6 7981.2 8152.3 8165.9 8170.6 8248.9 468.3 475.2 508.3 519.4 519.5 6210.2 6228.9 6293.4 6303.8 6340.1 9851.0 10154.6 10307.4 10354.8 10376.6 9846.7 10163.5 10188.5 10205.7 10298.4 7750.7 7919.6 7941.5 7944.1 7949.4 7734.6 7736.0 7774.4 7821.2 7881.4 9374.5 9537.2 9558.4 9625.9 9648.0 9387.1 9583.1 9685.3 9791.2 9855.2 6446.6 6458.6 6861.1 6932.4 6991.7 8278.6 8377.8 8443.6 8450.4 8495.0 7282.6 7375.2 7507.7 7542.4 7566.5 7460.3 7547.7 7585.9 7779.2 7794.7 6480.7 7668.0 7735.1 7783.2 7833.2 6808.1 7004.6 7052.0 7061.5 7094.6 7108.9 7179.8 7180.0 7180.9 7196.6 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5047.08 Median:5686.07 stddev:1578.07 (27.8%) stddev-sans-first:1541.34 22:48:27 INFO - PROCESS | 1676 | Values: 276.9 314.8 321.0 322.3 326.9 4624.9 5670.8 5926.2 5949.8 5951.4 5109.4 5585.1 5864.1 5882.2 5901.7 3069.4 3659.9 4392.7 4450.2 4469.4 4408.8 4416.4 4448.4 4451.7 4479.8 4427.6 4433.2 4457.8 4459.2 4465.2 4171.8 4215.9 4432.3 4482.4 4489.3 3836.4 3842.2 3843.2 3846.2 3856.3 5582.4 5586.5 5621.0 5622.9 5638.6 4507.9 4816.3 5042.4 5105.7 5115.4 4636.3 5987.4 6219.9 6234.7 6299.8 4163.2 4169.1 4174.9 4180.4 4195.3 6287.6 6598.0 6628.7 6640.7 6657.4 3578.8 4182.6 4207.4 4218.6 4219.2 4280.7 4298.9 4299.8 4302.3 4323.4 4814.8 5054.3 5066.7 5085.8 5102.5 5245.7 5444.7 6110.9 6304.7 6332.2 1440.6 1465.1 1483.8 1487.5 1487.7 896.4 950.0 969.0 971.2 983.7 5455.7 5631.5 5752.4 5908.1 5936.9 6250.7 6524.2 6554.0 6563.1 6613.5 5570.6 5804.8 5838.6 5893.7 5905.4 3383.1 3391.2 3425.5 3425.7 3428.0 6461.4 6732.0 6760.7 6776.6 6788.2 5891.7 5920.7 6659.5 6677.2 6693.2 5127.9 5596.4 6107.7 6134.0 6823.6 5376.6 6223.8 6526.3 6552.9 6569.2 5849.4 5980.5 5997.8 6385.4 6494.0 5277.8 5599.7 6441.9 6774.0 6798.3 3734.5 4189.4 4209.3 4240.9 4254.2 6185.0 6476.4 6517.5 6518.9 6520.6 5701.4 6121.2 6249.9 6310.1 6326.9 5244.6 5759.0 5796.3 6267.7 6285.5 5831.7 5933.5 6034.5 6108.4 6166.3 6127.7 6341.7 6346.3 6386.2 6416.2 5859.7 6209.9 6222.4 6232.6 6238.9 22:48:27 INFO - PROCESS | 1676 | 22:48:27 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:16925.03 Median:63510.02 stddev:23513.67 (37.0%) stddev-sans-first:23548.21 22:48:27 INFO - PROCESS | 1676 | Values: 736.6 742.8 745.5 746.0 803.9 14570.3 14651.9 15015.0 15024.3 15626.8 13430.2 13512.4 13587.7 13592.8 13596.0 717.8 732.5 889.4 905.6 924.7 902.6 908.7 914.0 914.7 915.0 960.2 969.5 971.3 972.2 973.0 763.9 786.6 787.1 789.9 959.2 684.8 718.3 723.5 724.8 725.2 14567.8 14596.1 14604.3 14654.2 14655.6 12505.0 12724.4 12771.7 12942.4 13268.1 9887.2 10364.8 10397.0 10700.4 10812.4 3471.2 3484.5 3487.0 3544.5 3603.6 77499.0 79266.0 79429.4 79597.2 84320.6 9322.0 9426.1 9441.7 9473.3 9481.7 21178.5 21365.9 21386.0 21394.7 21430.6 7608.8 7652.2 7658.5 7841.3 7974.5 4169.8 4173.4 4258.3 4325.7 4513.2 3017.6 3473.6 3552.2 3558.7 3582.5 630.2 648.5 648.8 657.8 672.5 541.3 605.5 609.9 612.0 612.4 7798.8 7998.2 8101.0 8114.6 8276.6 555.0 574.5 579.0 583.5 607.2 3718.8 3757.8 3778.5 3862.9 3863.7 82165.0 82304.2 84121.6 84296.0 84869.1 70782.0 72288.6 72312.6 73188.0 73276.0 62637.4 63463.0 63557.0 63978.7 64048.0 7377.3 7525.9 7593.7 7603.9 7648.9 32083.0 40534.8 42111.4 42744.6 42991.0 56209.7 58727.7 58859.1 59544.1 60346.1 9742.0 9867.3 9888.6 9928.1 9951.8 10597.6 10892.8 10961.7 11095.0 11660.1 9849.0 10064.9 10380.7 10381.4 10398.8 10250.6 10369.5 10395.8 10604.9 11165.3 10125.1 10157.6 10167.9 10185.9 10210.1 7719.6 8590.3 8679.7 8684.9 8890.5 7648.9 7952.0 8282.5 8460.2 8676.2 22:48:27 INFO - PROCESS | 1676 | -------- Summary: end -------- 22:48:27 INFO - PROCESS | 1676 | 22:48:28 INFO - TEST-INFO | 1676: exit 0 22:48:28 INFO - TEST-OK | dromaeo_css | took 1113964ms 22:48:28 INFO - TEST-START | kraken 22:48:28 INFO - operating with platform_type : mac_ 22:48:28 INFO - Initialising browser for kraken test... 22:48:28 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmp0jmGCk/profile http://localhost:49275/getInfo.html) 22:48:30 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 22:48:30 INFO - PROCESS | 1683 | colorDepth:24 22:48:30 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 22:48:30 INFO - PROCESS | 1683 | __metrics 22:48:30 INFO - PROCESS | 1683 | 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:48:30 ERROR - PROCESS | 1683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:48:31 INFO - TEST-INFO | 1683: exit 0 22:48:31 INFO - Browser initialized. 22:48:31 INFO - Running cycle 1/1 for kraken test... 22:48:31 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmp0jmGCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:43 INFO - PROCESS | 1685 | RSS: Main: 237264896 22:48:43 INFO - PROCESS | 1685 | 22:48:45 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:46 INFO - PROCESS | 1685 | RSS: Main: 283299840 22:48:46 INFO - PROCESS | 1685 | 22:48:49 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 22:48:49 INFO - PROCESS | 1685 | RSS: Main: 293830656 22:48:49 INFO - PROCESS | 1685 | 22:48:53 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 22:48:53 INFO - PROCESS | 1685 | RSS: Main: 280043520 22:48:53 INFO - PROCESS | 1685 | 22:48:55 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 22:48:56 INFO - PROCESS | 1685 | RSS: Main: 283131904 22:48:56 INFO - PROCESS | 1685 | 22:48:58 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:58 INFO - PROCESS | 1685 | RSS: Main: 284278784 22:48:58 INFO - PROCESS | 1685 | 22:49:01 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 22:49:02 INFO - PROCESS | 1685 | RSS: Main: 284307456 22:49:02 INFO - PROCESS | 1685 | 22:49:05 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 22:49:05 INFO - PROCESS | 1685 | RSS: Main: 284475392 22:49:05 INFO - PROCESS | 1685 | 22:49:08 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 22:49:08 INFO - PROCESS | 1685 | RSS: Main: 284979200 22:49:08 INFO - PROCESS | 1685 | 22:49:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:49:11 INFO - PROCESS | 1685 | RSS: Main: 318349312 22:49:11 INFO - PROCESS | 1685 | 22:49:12 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:49:13 INFO - PROCESS | 1685 | RSS: Main: 318279680 22:49:13 INFO - PROCESS | 1685 | 22:49:15 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:16 INFO - PROCESS | 1685 | RSS: Main: 323874816 22:49:16 INFO - PROCESS | 1685 | 22:49:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:49:19 INFO - PROCESS | 1685 | RSS: Main: 325398528 22:49:19 INFO - PROCESS | 1685 | 22:49:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:49:23 INFO - PROCESS | 1685 | RSS: Main: 325468160 22:49:23 INFO - PROCESS | 1685 | 22:49:24 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 22:49:25 INFO - PROCESS | 1685 | RSS: Main: 389607424 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | __start_tp_report 22:49:25 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 22:49:25 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 22:49:25 INFO - PROCESS | 1685 | |i|pagename|runs| 22:49:25 INFO - PROCESS | 1685 | |0;ai-astar;113;109;113;112;113;114;118;114;113;113 22:49:25 INFO - PROCESS | 1685 | |1;audio-beat-detection;154;123;142;159;117;141;140;120;164;121 22:49:25 INFO - PROCESS | 1685 | |2;audio-dft;183;186;187;187;183;184;185;187;182;250 22:49:25 INFO - PROCESS | 1685 | |3;audio-fft;78;76;83;79;56;57;57;77;87;81 22:49:25 INFO - PROCESS | 1685 | |4;audio-oscillator;92;96;129;78;77;77;118;81;77;121 22:49:25 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;89;84;89;85;88;84;89;86;88;84 22:49:25 INFO - PROCESS | 1685 | |6;imaging-darkroom;93;94;94;92;92;93;94;94;93;93 22:49:25 INFO - PROCESS | 1685 | |7;imaging-desaturate;87;86;84;84;87;88;87;87;84;93 22:49:25 INFO - PROCESS | 1685 | |8;json-parse-financial;52;55;54;54;55;54;55;65;56;53 22:49:25 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;65;73;75;75;71;69;69;69;67;68 22:49:25 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;86;85;87;86;84;86;84;85;85;85 22:49:25 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;160;155;146;143;142;141;140;141;145;138 22:49:25 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;171;180;169;171;171;169;171;172;169;168 22:49:25 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;67;71;69;67;67;64;67;69;68;66 22:49:25 INFO - PROCESS | 1685 | __end_tp_report 22:49:25 INFO - PROCESS | 1685 | __start_cc_report 22:49:25 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1338 22:49:25 INFO - PROCESS | 1685 | __end_cc_report 22:49:25 INFO - PROCESS | 1685 | __startTimestamp1460180965098__endTimestamp 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | ------- Summary: start ------- 22:49:25 INFO - PROCESS | 1685 | Number of tests: 14 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:2.20 (1.9%) stddev-sans-first:2.33 22:49:25 INFO - PROCESS | 1685 | Values: 113.0 109.0 113.0 112.0 113.0 114.0 118.0 114.0 113.0 113.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:141.50 stddev:17.26 (12.2%) stddev-sans-first:17.32 22:49:25 INFO - PROCESS | 1685 | Values: 154.0 123.0 142.0 159.0 117.0 141.0 140.0 120.0 164.0 121.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:191.40 Median:186.50 stddev:20.67 (11.1%) stddev-sans-first:21.70 22:49:25 INFO - PROCESS | 1685 | Values: 183.0 186.0 187.0 187.0 183.0 184.0 185.0 187.0 182.0 250.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:73.10 Median:78.50 stddev:11.77 (15.0%) stddev-sans-first:12.35 22:49:25 INFO - PROCESS | 1685 | Values: 78.0 76.0 83.0 79.0 56.0 57.0 57.0 77.0 87.0 81.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:77.50 stddev:20.62 (26.6%) stddev-sans-first:21.85 22:49:25 INFO - PROCESS | 1685 | Values: 92.0 96.0 129.0 78.0 77.0 77.0 118.0 81.0 77.0 121.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:2.22 (2.5%) stddev-sans-first:2.18 22:49:25 INFO - PROCESS | 1685 | Values: 89.0 84.0 89.0 85.0 88.0 84.0 89.0 86.0 88.0 84.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 22:49:25 INFO - PROCESS | 1685 | Values: 93.0 94.0 94.0 92.0 92.0 93.0 94.0 94.0 93.0 93.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:2.67 (3.1%) stddev-sans-first:2.83 22:49:25 INFO - PROCESS | 1685 | Values: 87.0 86.0 84.0 84.0 87.0 88.0 87.0 87.0 84.0 93.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.59 (6.5%) stddev-sans-first:3.61 22:49:25 INFO - PROCESS | 1685 | Values: 52.0 55.0 54.0 54.0 55.0 54.0 55.0 65.0 56.0 53.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.35 (4.8%) stddev-sans-first:3.00 22:49:25 INFO - PROCESS | 1685 | Values: 65.0 73.0 75.0 75.0 71.0 69.0 69.0 69.0 67.0 68.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 22:49:25 INFO - PROCESS | 1685 | Values: 86.0 85.0 87.0 86.0 84.0 86.0 84.0 85.0 85.0 85.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:144.00 stddev:7.03 (4.9%) stddev-sans-first:4.98 22:49:25 INFO - PROCESS | 1685 | Values: 160.0 155.0 146.0 143.0 142.0 141.0 140.0 141.0 145.0 138.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:3.38 (2.0%) stddev-sans-first:3.59 22:49:25 INFO - PROCESS | 1685 | Values: 171.0 180.0 169.0 171.0 171.0 169.0 171.0 172.0 169.0 168.0 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:2.01 22:49:25 INFO - PROCESS | 1685 | Values: 67.0 71.0 69.0 67.0 67.0 64.0 67.0 69.0 68.0 66.0 22:49:25 INFO - PROCESS | 1685 | -------- Summary: end -------- 22:49:25 INFO - PROCESS | 1685 | 22:49:25 INFO - TEST-INFO | 1685: exit 0 22:49:25 INFO - TEST-OK | kraken | took 57369ms 22:49:25 INFO - SUITE-END | took 1171s 22:49:26 INFO - Completed test suite (00:19:31) 22:49:26 INFO - javascript benchmark 22:49:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.204948762809, 3379.0, 3411.0790086676584, 3447.2588393495394, 3451.396005699002, 5586.720663966806, 5716.371199168088, 5721.399253078429, 5723.62796418233, 5727.455891690288, 5671.517920976722, 5695.373508914016, 5746.1668058131545, 5816.302043754745, 5823.359430462657, 5160.6903585784785, 5170.741462926858, 5195.896082078356, 5215.061288967984, 5296.073187192226, 5262.842114736564, 5294.258803767476, 5310.893782124355, 5336.759845806929, 5358.973205133969, 5102.6173037022, 5108.386993560759, 5200.76596553156, 5209.609279304048, 5234.900670859086, 5221.869453263661, 5222.216667499867, 5223.71269580173, 5240.737963101829, 5247.23915032322, 5159.432462429129, 5191.922121168185, 5192.584593232532, 5210.947890521122, 5222.451642577513, 5478.780848766045, 5569.081101618228, 5613.943860561383, 5682.6306290091015, 5689.857753556153, 6208.0, 6228.937710622881, 6255.249370075575, 6258.812235632939, 6264.655443950581, 6223.657698826562, 6284.12022316876, 6287.8742425151695, 6289.276733175698, 6299.5275354348605, 5654.095344744821, 5682.147677848356, 5763.510101641407, 5822.7088645567555, 5834.241548598698, 6258.280297765815, 6278.780242691484, 6285.654289014148, 6288.937110628926, 6289.905651415233, 6072.0, 6120.938790612036, 6176.3514830943, 6193.876122477615, 6203.751849926042, 6286.717097730613, 6292.0, 6306.085617585516, 6308.369163083747, 6309.936900631027, 6244.344343843831, 6247.687615619292, 6254.093156492283, 6255.530835187379, 6259.311475737665, 5198.92201616976, 6113.141862489121, 6163.38366163389, 6280.371962803774, 6281.59169653971, 4922.015596880638, 4951.876203094951, 4959.677620954626, 4974.801007959641, 4976.42771081323, 3775.0, 4399.692021558524, 4466.843660471868, 4468.240399132155, 4536.500984891659, 5697.572682048863, 5705.372409035002, 5767.307923049261, 5796.449337312949, 5800.332961709373, 6242.781502647385, 6281.277653069864, 6297.590656607397, 6300.338464461165, 6306.8423289417215, 5581.10702287632, 5740.454656807597, 5772.509336706343, 5780.739866706008, 5799.623024503394, 5325.866853328698, 5347.625666203328, 5409.2967914171695, 5413.2150838128255, 5439.836804895859, 6219.315875253718, 6257.405546473078, 6258.499320054476, 6258.561900667, 6276.340984196685, 6097.664628445478, 6284.057391391328, 6322.146510221061, 6324.2410910691015, 6329.461995730415, 6187.628742275478, 6214.223222097238, 6241.251049874044, 6244.2819075806865, 6270.404311590391, 6198.783042593487, 6200.627962322275, 6206.627602343874, 6212.409821066992, 6228.626282423069, 5107.693538387709, 5948.940510595012, 6080.118382834376, 6258.780942666985, 6297.0, 6028.758849645965, 6071.908921366095, 6137.009281402588, 6145.156453064153, 6154.815355539341, 5029.4216165140015, 6087.6897133220555, 6093.625290627054, 6115.727150604614, 6116.731440059295, 5141.897162056813, 5784.421557844182, 5834.416558344132, 5970.104484327386, 5971.223740913653, 6036.728347224298, 6038.69806509664, 6068.089786531879, 6075.939240607714, 6100.206973093469, 5921.970390148022, 5937.139114828412, 5937.821865344046, 5942.078977758454, 5943.940560594512], "value": 5683.269494068945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.9355080614923, 528.0, 539.9838004859853, 557.9426985861792, 569.4903061759728, 27792.444151116964, 29040.41919161618, 36938.707145249886, 37685.246295074154, 37743.811280943555, 41150.38274425886, 41789.746307610745, 41875.16249675005, 41909.95225119373, 41973.58026419735, 9454.81090378192, 9558.522073896313, 9687.903120968806, 9697.951510242474, 9698.757531061709, 9475.241980641533, 9490.81018379632, 9554.187894029015, 9634.75913102171, 9648.758781030496, 9591.992840751725, 9643.758906027371, 9663.613455461807, 9666.033396660312, 9668.951655241714, 9522.761930951712, 9574.856377154349, 9589.041095890425, 9636.132748052709, 9646.228301735879, 9374.62501499946, 9472.242220622402, 9489.525523723787, 9500.0, 9510.762230944212, 32214.03357899267, 38595.421068683994, 38848.61151388478, 39118.41322380167, 39430.49396849545, 3381.8647254109806, 3565.732570057256, 3778.1688028633657, 3830.655241028293, 4123.134141830219, 27910.441791164063, 28196.718032819615, 28248.870045198168, 28651.283717907012, 28782.856085719646, 2649.7477144427276, 2681.048227879094, 2685.4897569461937, 2781.568856827195, 2810.6065150878894, 430668.0, 431671.0, 431870.99999999686, 432008.0, 432119.0, 34414.311713765586, 57415.13877291844, 57586.84826303534, 57776.133357999664, 57804.0, 34043.82978085094, 34234.48648270278, 34322.313553729284, 34325.313493729984, 34333.484997725056, 13113.0, 13342.533011344556, 13349.399277032557, 13369.866301337057, 13397.531086412124, 11923.761524769456, 11982.400879955967, 11991.340476273888, 11997.460114294703, 12006.87993120075, 7894.447388682852, 8044.0, 8048.356131509465, 8119.9188008120345, 8142.4300298978505, 2863.3700585871075, 3428.6571342865514, 3432.262063656326, 3448.4482482803132, 3474.287771006988, 995.0994350113015, 1000.6747806962766, 1010.782681723433, 1038.3302769713493, 1047.0838016735356, 22597.887010564842, 29127.980520681675, 29212.260383386838, 29505.852470737937, 29753.10740677783, 1118.972025699364, 1133.637236084445, 1164.772869290497, 1165.8426112474876, 1171.4611278811672, 14244.85755142456, 14831.18428486422, 14865.729539501292, 15283.46507872219, 15286.464973725866, 580544.0, 611120.0, 691145.0, 692593.0, 692798.0, 54466.72766636221, 54683.453165467836, 55580.0, 55615.16577251344, 55862.162067568206, 1309.5743883237794, 1350.73660636175, 1452.7748199029168, 1468.5520916120472, 1560.781490591318, 24403.14588989448, 29143.85428072846, 29228.83084676589, 29713.571607098227, 29718.702812972457, 51030.48969510257, 51779.741101294254, 52134.21798673099, 52135.0, 52180.21729673982, 540053.0, 543687.6312368889, 543802.0, 544754.0, 545346.0, 26129.869350653124, 26330.94676213007, 26409.73590264073, 26790.053094160015, 26806.59790103189, 42274.788626056674, 42654.57345426506, 42673.359899602154, 42996.0, 43618.127637446436, 34669.65330346664, 35683.82158089193, 35788.926332210074, 36260.81869590635, 36619.450708238866, 34665.48001779925, 35035.824820876755, 35382.82308588544, 35798.105047374025, 35821.1044723884, 34945.65054349424, 35081.82459087688, 35183.82408087943, 35363.0, 35457.468137977434, 30907.84546077255, 31487.0, 31495.0, 31628.841855790575, 31812.84093579517, 23523.354394945432, 23651.56794425087, 23658.408539785956, 23838.642420364056, 23869.641955370334], "value": 18053.525332083536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.8760958445375, 388.72400595577136, 389.1613572750723, 395.35557042021503, 399.19163693520636, 14914.962026445233, 16045.438409655664, 19319.0, 21130.89434552827, 21242.46893827655, 11777.352245626487, 12298.200616959914, 20738.688919666216, 21657.783422165812, 21692.8915355423, 5235.659682120659, 5379.220013098098, 5434.266374039494, 5447.945520544803, 5464.180372944051, 3946.2304850554156, 6441.227052753653, 7289.744858929938, 7669.118051424102, 7680.500767450098, 7559.28186822251, 7651.579163146025, 7675.692972281102, 7677.155512893577, 7690.384769218477, 7552.509086909361, 7685.269899359608, 7782.260685234922, 7786.221377862225, 7798.727044553441, 7266.091738532684, 7507.099148102263, 7548.282913123245, 7554.546727196386, 7561.735339263154, 28037.719622803714, 28660.426791464262, 29740.70259297401, 29871.70128298711, 30064.0, 2013.3758534854242, 2109.968350474744, 2138.786121387864, 2224.3215819175143, 2993.3414648777452, 15344.156071416179, 15613.141277229748, 15884.92057539705, 15894.966827156199, 16392.83607163937, 1866.72932424799, 1870.7661542307212, 1883.9717404238947, 1915.9521011974673, 1973.0923775063345, 132381.35237295297, 134471.0, 136069.3196534011, 137026.0, 138592.0, 20417.2853950114, 20514.487137821674, 20520.13530848059, 20579.044990725855, 20664.48338791542, 35346.469802952975, 35387.58449662036, 35414.114647134025, 35427.280135585395, 35480.82259588686, 10374.22193335503, 10648.840267395995, 10664.253502254924, 10679.519421626046, 10714.732131696614, 7212.639368031578, 8535.317174626016, 8612.956935215283, 8640.265577425864, 8715.564221788885, 9489.715308540755, 9526.571304291323, 9614.0, 9660.903390966141, 9678.128968392879, 3663.0, 3762.473253744478, 3782.659560639556, 3785.962140378561, 3879.8466850897457, 820.9548474833941, 878.9208971192623, 983.3460748602242, 1002.2683441087901, 1023.7031260934245, 16230.0, 20292.0, 20396.898015510124, 20706.68939965902, 20757.896210519153, 875.9357380782253, 906.1663269791808, 929.8047410043966, 968.2689569375218, 999.3154689038032, 8031.0, 10639.680809575726, 10718.196135289885, 10758.623448179433, 10762.139028877671, 502525.0, 508049.0, 509814.0, 635982.6401735924, 639387.0, 95941.5202923981, 108874.27814304706, 129843.0, 144316.0, 144731.0, 943.127606963556, 1032.5869652139204, 1053.7418332508432, 1101.0035917494681, 1101.542859713226, 17101.0, 17882.28470861151, 18303.35938242155, 18428.262869485607, 18727.719084213477, 46813.2978005337, 47504.2874356878, 48079.278810817166, 48858.0, 49001.0, 71216.0, 72813.63593182, 76046.47907041718, 77256.0, 79291.20708793068, 7749.263819937097, 8104.918950810416, 8198.877016844872, 8287.461315014505, 8409.789755256168, 10327.535260913126, 12344.074194435632, 12569.560065398033, 12594.141430156664, 12634.052446066766, 5609.186667933045, 7238.927610724036, 10685.0, 10974.695313984153, 11220.99011089006, 5348.652337598043, 9038.412503187272, 10595.523201455799, 10601.102178876787, 10794.946025269823, 9253.537323133682, 10835.349879007284, 11089.778204436028, 11374.658760237206, 11416.086713062768, 9924.206063515046, 10048.598056077675, 11414.143939204427, 11647.708807279885, 11798.233114847508, 5752.741126649227, 10764.946175269386, 11159.832602511131, 11162.107031437303, 11442.112051511407], "value": 10678.54842732781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8512306207854, 1595.792546968894, 1605.5263697209323, 1847.3995951315826, 1960.2844961589024, 7846.136924938252, 8534.359923005775, 8804.823903521925, 8808.955955220223, 8815.955920220405, 8397.45416547924, 8646.437981531197, 8651.826963460728, 8670.176333248348, 8674.783130421743, 2145.9785402146013, 2377.286813955815, 2425.248173066351, 2463.3841539615096, 2464.3223113643803, 2469.876506174693, 2501.112105202654, 2502.78726308264, 2503.924882253535, 2509.3475696318906, 2410.8553486790847, 2471.122751423246, 2474.6906636670415, 2475.950480990379, 2484.354067942339, 2330.8251881108986, 2347.730011048734, 2375.619900815861, 2380.1788383008006, 2394.1261439574428, 2388.176079252655, 2412.0472413396787, 2434.902603895842, 2446.816488763332, 2448.0207916833233, 8598.957005214934, 8610.225079742791, 8681.869771953427, 8691.95654021726, 8700.042995270514, 5095.5923526118195, 5267.236250743659, 5279.287296215, 5279.63042587019, 5290.153575427951, 3388.7797293175863, 3455.8963231102857, 3506.2461570762407, 3583.7670551414076, 3593.8203089845665, 1006.3710181136789, 1026.4764969865348, 1029.8403747419088, 1037.8339465685528, 1037.9221558383151, 11401.543938242461, 11488.0, 11503.309801411859, 11505.309681419141, 11544.134189935789, 4500.504944456107, 4510.481294651091, 4699.318598803223, 4707.7175369477945, 4712.081144176921, 9094.590743416562, 9109.134632209929, 9117.08829117083, 9121.680741174026, 9154.359194856295, 5229.816956406507, 5244.160934250502, 5260.894782104337, 5266.605004624592, 5273.31446911899, 4071.75569465833, 4359.433273674465, 4539.0921815637, 4702.811887524461, 4829.541193586604, 3737.2338670572467, 3756.586775454698, 3847.0, 3864.8840534784003, 3872.786996715208, 1023.6007956896816, 1079.4764539198482, 1178.0516684069407, 1201.1231800785476, 1209.9637010889687, 1308.535469908188, 1322.9140105893086, 1358.9116707413987, 1369.732902084104, 1370.5614203454998, 7981.241782030698, 8152.347812175011, 8165.877511837327, 8170.550619715973, 8248.876266856001, 468.33496435062295, 475.15185394071415, 508.3137764018619, 519.4182515582496, 519.5479932458785, 6210.192674952317, 6228.875422491525, 6293.402126797947, 6303.810885673345, 6340.080688300263, 9850.950745246371, 10154.593816247416, 10307.433091180057, 10354.844677329846, 10376.636817711495, 9846.655367062118, 10163.542640581192, 10188.490575471196, 10205.74485637865, 10298.382097074049, 7750.689972401041, 7919.643616037292, 7941.523508589503, 7944.086430060502, 7949.364050876032, 7734.574598397142, 7735.961320193588, 7774.416918731231, 7821.217878212134, 7881.448298619271, 9374.484403357881, 9537.23702103844, 9558.378705384128, 9625.855612165684, 9648.0, 9387.061293870558, 9583.08960648765, 9685.273604479833, 9791.167750741266, 9855.162311203341, 6446.645434501147, 6458.612483250832, 6861.073755043205, 6932.44540436774, 6991.720331186899, 8278.627461764114, 8377.832443350977, 8443.577821109044, 8450.366222533457, 8494.957525212334, 7282.563046217244, 7375.188729239887, 7507.66215520292, 7542.396608271435, 7566.470347075652, 7460.328570428687, 7547.7358292461695, 7585.924140758521, 7779.183185765413, 7794.6882124714375, 6480.740770369321, 7668.0, 7735.066233441639, 7783.221677832172, 7833.1775163607, 6808.148981377328, 7004.614746189009, 7052.0, 7061.470389720689, 7094.64526773649, 7108.893366599608, 7179.820504487429, 7180.0, 7180.928190718235, 7196.640167991684], "value": 4737.057635995714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.8989318898602, 314.82527197405443, 320.9582754241948, 322.25076696680196, 326.882322363949, 4624.907501849961, 5670.773169073237, 5926.199963004993, 5949.816847986328, 5951.375105613914, 5109.3613298337705, 5585.1063829787245, 5864.149698293755, 5882.176495290662, 5901.734421951011, 3069.41681080594, 3659.8902032939054, 4392.670549708769, 4450.198964186445, 4469.44131983502, 4408.757518336491, 4416.381706561068, 4448.377227188196, 4451.710638808483, 4479.753613551254, 4427.579379958899, 4433.2241857674935, 4457.821687132527, 4459.241928872083, 4465.196264672358, 4171.791410429497, 4215.894602634928, 4432.290833466646, 4482.417285752864, 4489.25927222008, 3836.4245363195464, 3842.1931394407206, 3843.1545060087014, 3846.211526637033, 3856.3444214483607, 5582.381109478247, 5586.525145362649, 5620.960122377373, 5622.887542249173, 5638.577106717013, 4507.887302817423, 4816.301636262722, 5042.445331013586, 5105.668131571436, 5115.411727651293, 4636.258198688193, 5987.43119403656, 6219.937800621981, 6234.719437625317, 6299.779507717254, 4163.208990291865, 4169.145325208325, 4174.935391475185, 4180.435641188431, 4195.349720793282, 6287.591306565058, 6598.0, 6628.668566571652, 6640.667966601651, 6657.367550082734, 3578.785272883635, 4182.560831112689, 4207.368894665763, 4218.599233072914, 4219.177260434247, 4280.721753086102, 4298.871033868989, 4299.828006879689, 4302.290122129813, 4323.351497275434, 4814.759262036884, 5054.292399064134, 5066.733316670832, 5085.796568137233, 5102.515261050195, 5245.659032162897, 5444.673319600836, 6110.938890611126, 6304.6847657617855, 6332.176817013851, 1440.63984003999, 1465.1355700136971, 1483.7625979843174, 1487.5091219897408, 1487.7173337065922, 896.3501461440403, 949.9715008549755, 968.9612415503442, 971.2375785008734, 983.7393090830935, 5455.672659640434, 5631.465010823965, 5752.395998420189, 5908.113782932594, 5936.940630593639, 6250.749970001149, 6524.249711283263, 6554.049662798963, 6563.081168636395, 6613.503987200979, 5570.610057296031, 5804.82585522435, 5838.649681019152, 5893.705314734246, 5905.43898329658, 3383.086566626997, 3391.2200193955528, 3425.469052296898, 3425.6745609167087, 3428.02888339201, 6461.384653836541, 6731.966340168366, 6760.661966901635, 6776.593404395752, 6788.185417749803, 5891.7054147292465, 5920.703964801743, 6659.467242620579, 6677.232118306457, 6693.2223127401585, 5127.9230811537855, 5596.4123767003875, 6107.6640784757265, 6133.96933015341, 6823.590584564942, 5376.569874410116, 6223.844403889758, 6526.347365263436, 6552.934470655233, 6569.211694596679, 5849.356570777296, 5980.501406677143, 5997.790077347272, 6385.393387628168, 6494.0258961156205, 5277.788888444573, 5599.720013999366, 6441.871162576816, 6773.966130169318, 6798.320167983162, 3734.533183352081, 4189.3925380819, 4209.305464598307, 4240.936385954275, 4254.212970600449, 6185.0, 6476.417122459001, 6517.478601711947, 6518.869622607616, 6520.608763474207, 5701.372848986691, 6121.234845644294, 6249.906251406142, 6310.148130002574, 6326.8734625306315, 5244.606654500852, 5759.0, 5796.304443466811, 6267.749290028348, 6285.528585356208, 5831.7375718091935, 5933.525317974465, 6034.456898879122, 6108.358622344767, 6166.260048794174, 6127.662978536045, 6341.714622842075, 6346.3028213008365, 6386.233651961795, 6416.230052393743, 5859.710863609999, 6209.937900620936, 6222.408871157233, 6232.594881332699, 6238.875222495615], "value": 4533.8590585134325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.5543845973186, 742.8105833012581, 745.4930647159929, 745.9701611935523, 803.9155888631693, 14570.271486425676, 14651.926740366283, 15015.02402343847, 15024.323905424255, 15626.76559851603, 13430.194188348682, 13512.391942362592, 13587.72824543511, 13592.796108058386, 13596.028575856519, 717.8313096422337, 732.4835990626596, 889.4440974391006, 905.6015353244584, 924.6671198368582, 902.6434558349448, 908.6683360573376, 914.0, 914.6981496106303, 914.9771255718593, 960.2366118935463, 969.4522594733953, 971.3006635222629, 972.2416515118219, 972.9951350243239, 763.8663233934067, 786.5595266650665, 787.1144961917843, 789.940754443419, 959.184693010942, 684.7979845945458, 718.3211864787778, 723.489939592586, 724.8332883436839, 725.1624373848214, 14567.781483277759, 14596.12423254608, 14604.34280457382, 14654.194019328932, 14655.560333190022, 12505.0, 12724.363781810873, 12771.680707982376, 12942.352882355844, 13268.137571057947, 9887.159591434736, 10364.79270414595, 10397.0, 10700.357978521313, 10812.35125892449, 3471.2363280078343, 3484.494748261488, 3487.0410637074756, 3544.468329750532, 3603.56757189139, 77499.0, 79266.0, 79429.41141177143, 79597.20402796014, 84320.57839710762, 9321.95339023314, 9426.057394260519, 9441.716748497556, 9473.289503287144, 9481.66814161501, 21178.470538236666, 21365.893170534047, 21386.0, 21394.679079813504, 21430.571388572454, 7608.80977975544, 7652.248164383843, 7658.4639075264195, 7841.294283514511, 7974.5215287082965, 4169.791510424467, 4173.373993900939, 4258.254805409041, 4325.740455572675, 4513.1650644630845, 3017.6077109976, 3473.565804274466, 3552.200754830194, 3558.679718825318, 3582.5163602913794, 630.180765005491, 648.4844548583887, 648.8345471904729, 657.8388294867788, 672.4586707700348, 541.2882060090968, 605.5216379060581, 609.871926895357, 611.9877602448015, 612.3845535237058, 7798.8276272195235, 7998.240167184108, 8101.0, 8114.63484143215, 8276.589289178299, 554.9889002219933, 574.5346269521701, 578.962367446123, 583.5448350286783, 607.1651479216077, 3718.758280711745, 3757.774533527997, 3778.4899038629433, 3862.942055869164, 3863.7102217333813, 82165.0, 82304.17695822965, 84121.57939210265, 84296.0, 84869.08874568081, 70782.0, 72288.63855680688, 72312.63843680748, 73188.0, 73276.0, 62637.373626264976, 63463.04805427922, 63557.0, 63978.68010659917, 64048.0, 7377.26227377258, 7525.88711169322, 7593.696252149852, 7603.885941710768, 7648.870892850778, 32083.0, 40534.797326013184, 42111.36832947447, 42744.572554275306, 42991.0, 56209.71895140662, 58727.70636146792, 58859.11711324419, 59544.10683839659, 60346.09480857878, 9742.0, 9867.25995550351, 9888.555015024198, 9928.056834600702, 9951.800963980535, 10597.576096956343, 10892.836607451052, 10961.671149865517, 11095.001449869551, 11660.06719462458, 9849.015098490094, 10064.949675251577, 10380.688579342632, 10381.429021403896, 10398.792024159626, 10250.641227557, 10369.481525923522, 10395.844062339222, 10604.89395106039, 11165.274257173258, 10125.088742013255, 10157.644482443078, 10167.949160254448, 10185.898141018495, 10210.081092701692, 7719.614019299125, 8590.312774978112, 8679.652813887626, 8684.9262137943, 8890.511021893857, 7648.923510765044, 7951.960240198762, 8282.544460054514, 8460.196281353261, 8676.219140277406], "value": 6607.176421696545, "unit": "score"}], "name": "dromaeo_css", "value": 7333.039270764434, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 112.0, 113.0, 114.0, 118.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 142.0, 159.0, 117.0, 141.0, 140.0, 120.0, 164.0, 121.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 187.0, 187.0, 183.0, 184.0, 185.0, 187.0, 182.0, 250.0], "value": 191.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 83.0, 79.0, 56.0, 57.0, 57.0, 77.0, 87.0, 81.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 129.0, 78.0, 77.0, 77.0, 118.0, 81.0, 77.0, 121.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 89.0, 85.0, 88.0, 84.0, 89.0, 86.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 92.0, 92.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 84.0, 87.0, 88.0, 87.0, 87.0, 84.0, 93.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 65.0, 56.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 75.0, 75.0, 71.0, 69.0, 69.0, 69.0, 67.0, 68.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 86.0, 84.0, 86.0, 84.0, 85.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 146.0, 143.0, 142.0, 141.0, 140.0, 141.0, 145.0, 138.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 180.0, 169.0, 171.0, 171.0, 169.0, 171.0, 172.0, 169.0, 168.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 69.0, 67.0, 67.0, 64.0, 67.0, 69.0, 68.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1471.3, "alertThreshold": 2.0}]} 22:49:26 INFO - Return code: 0 22:49:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:49:26 ERROR - # TBPL SUCCESS # 22:49:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:49:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:49:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:49:26 INFO - 2016-04-08 22:49:26.409 screenresolution[1689:10542] starting screenresolution argv=screenresolution get 22:49:26 INFO - 2016-04-08 22:49:26.412 screenresolution[1689:10542] Display 0: 1600x1200x32@60 22:49:26 INFO - 2016-04-08 22:49:26.418 screenresolution[1690:10545] starting screenresolution argv=screenresolution list 22:49:26 INFO - Available Modes on Display 0 22:49:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:49:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:49:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:49:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:49:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:49:26 INFO - Intel Iris: 22:49:26 INFO - Chipset Model: Intel Iris 22:49:26 INFO - Type: GPU 22:49:26 INFO - Bus: Built-In 22:49:26 INFO - VRAM (Dynamic, Max): 1536 MB 22:49:26 INFO - Vendor: Intel (0x8086) 22:49:26 INFO - Device ID: 0x0a2e 22:49:26 INFO - Revision ID: 0x0009 22:49:26 INFO - Displays: 22:49:26 INFO - Display: 22:49:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:49:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:49:26 INFO - Display Serial Number: 1600x1200 60 22:49:26 INFO - Main Display: Yes 22:49:26 INFO - Mirror: Off 22:49:26 INFO - Online: Yes 22:49:26 INFO - Rotation: Supported 22:49:26 INFO - Return code: 0 22:49:26 INFO - Running post-action listener: _resource_record_post_action 22:49:26 INFO - Running post-run listener: _resource_record_post_run 22:49:27 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 32345600; Write bytes: 694526976; Read time: 325; Write time: 1919 22:49:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 387676672; Write bytes: 382416896; Read time: 29746; Write time: 702 22:49:27 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30543360; Write bytes: 298826752; Read time: 305; Write time: 1184 22:49:27 INFO - Running post-run listener: _upload_blobber_files 22:49:27 INFO - Blob upload gear active. 22:49:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:49: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:49: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:49: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:49:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:49:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:49:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:49:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:29 INFO - (blobuploader) - INFO - Done attempting. 22:49:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:49:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:49:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:30 INFO - (blobuploader) - INFO - Done attempting. 22:49:30 INFO - (blobuploader) - INFO - Iteration through files over. 22:49:30 INFO - Return code: 0 22:49:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:49:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:49:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e51549da6f79f551de0414c1eb2e4c1401573e19f775b8ae0566e8dcceab705b63a36f228c64fdf2d4343a044ab1b2b419892013919508784553111ccdb55754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcb740b87a7d4f1b4e50ae45644c764492b64dad8fc1a8423fc8be602318c624ae201f79c751601bff6f1a1736af2319212cca18438010caeb6c5b43e85d3d0b"} 22:49:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:49:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:49:30 INFO - Contents: 22:49:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e51549da6f79f551de0414c1eb2e4c1401573e19f775b8ae0566e8dcceab705b63a36f228c64fdf2d4343a044ab1b2b419892013919508784553111ccdb55754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcb740b87a7d4f1b4e50ae45644c764492b64dad8fc1a8423fc8be602318c624ae201f79c751601bff6f1a1736af2319212cca18438010caeb6c5b43e85d3d0b"} 22:49:30 INFO - Running post-run listener: copy_logs_to_upload_dir 22:49:30 INFO - Copying logs to upload dir... 22:49:30 INFO - mkdir: /builds/slave/test/build/upload/logs 22:49:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.046457 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-08 22:49:30.226427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:49:30.230956) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/e51549da6f79f551de0414c1eb2e4c1401573e19f775b8ae0566e8dcceab705b63a36f228c64fdf2d4343a044ab1b2b419892013919508784553111ccdb55754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcb740b87a7d4f1b4e50ae45644c764492b64dad8fc1a8423fc8be602318c624ae201f79c751601bff6f1a1736af2319212cca18438010caeb6c5b43e85d3d0b"} build_url:https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010813 build_url: 'https://queue.taskcluster.net/v1/task/RvBNpAYERcywmJ9t2eLcvQ/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/e51549da6f79f551de0414c1eb2e4c1401573e19f775b8ae0566e8dcceab705b63a36f228c64fdf2d4343a044ab1b2b419892013919508784553111ccdb55754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcb740b87a7d4f1b4e50ae45644c764492b64dad8fc1a8423fc8be602318c624ae201f79c751601bff6f1a1736af2319212cca18438010caeb6c5b43e85d3d0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:49:30.257108) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:49:30.257401) ========= 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.Vtl1pKF5jB/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.fMgqaeuwam/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005137 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:49:30.309547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:49:30.309858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:49:30.310266) ========= ========= Total master_lag: 0.65 =========