builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1460480224.59 results: success (0) buildid: 20160412084656 builduid: 3e55a195d436449598ab5ae182f667e9 revision: 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:04.589004) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:04.594713) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:04.595011) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005548 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:04.649854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-04-12 09:57:04.650200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-04-12 09:57:16.746489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:16.750844) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005430 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:16.858492) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:16.861875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:16.862302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 09:57:16.862612) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-12 09:57:17-- 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% 159M=0s 2016-04-12 09:57:17 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.546207 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 09:57:17.903664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 09:57:17.903954) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.026693 ========= master_lag: 2.95 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 09:57:20.880585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 09:57:20.880891) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 --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 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-12 09:57:20,956 truncating revision to first 12 chars 2016-04-12 09:57:20,956 Setting DEBUG logging. 2016-04-12 09:57:20,956 attempt 1/10 2016-04-12 09:57:20,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/870749af34d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 09:57:21,935 unpacking tar archive at: fx-team-870749af34d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224050 ========= master_lag: 1.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 09:57:23.121316) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:23.121648) ========= echo 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'870749af34d8e7a0c41bd4dc8a67e5f244ac1b83'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 program finished with exit code 0 elapsedTime=0.005815 script_repo_revision: '870749af34d8e7a0c41bd4dc8a67e5f244ac1b83' ========= master_lag: 0.93 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:24.060296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:24.060619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 09:57:24.285066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-12 09:57:24.285350) ========= /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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:24 INFO - MultiFileLogger online at 20160412 09:57:24 in /builds/slave/test 09:57:24 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 09:57:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:24 INFO - {'append_to_log': False, 09:57:24 INFO - 'base_work_dir': '/builds/slave/test', 09:57:24 INFO - 'blob_upload_branch': 'Fx-Team', 09:57:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:24 INFO - 'branch': 'Fx-Team', 09:57:24 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:24 INFO - 'config_files': ('talos/mac_config.py',), 09:57:24 INFO - 'default_actions': ('clobber', 09:57:24 INFO - 'read-buildbot-config', 09:57:24 INFO - 'download-and-extract', 09:57:24 INFO - 'populate-webroot', 09:57:24 INFO - 'create-virtualenv', 09:57:24 INFO - 'install', 09:57:24 INFO - 'run-tests'), 09:57:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:24 INFO - 'download_minidump_stackwalk': True, 09:57:24 INFO - 'download_symbols': 'ondemand', 09:57:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:24 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:24 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:24 INFO - 'installer_path': 'installer.exe', 09:57:24 INFO - 'log_level': 'info', 09:57:24 INFO - 'log_name': 'talos', 09:57:24 INFO - 'log_to_console': True, 09:57:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:57:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:57:24 INFO - 'opt_config_files': (), 09:57:24 INFO - 'pip_index': False, 09:57:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:24 INFO - 'cmd': ('bash', 09:57:24 INFO - '-c', 09:57:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:24 INFO - 'enabled': True, 09:57:24 INFO - 'halt_on_failure': False, 09:57:24 INFO - 'name': 'check_screen_resolution'},), 09:57:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:24 INFO - 'cmd': ('bash', 09:57:24 INFO - '-c', 09:57:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:24 INFO - 'enabled': True, 09:57:24 INFO - 'halt_on_failure': False, 09:57:24 INFO - 'name': 'check_screen_resolution'},), 09:57:24 INFO - 'run_cmd_checks_enabled': True, 09:57:24 INFO - 'sps_profile': False, 09:57:24 INFO - 'sps_profile_interval': 0, 09:57:24 INFO - 'suite': 'dromaeojs', 09:57:24 INFO - 'system_bits': '32', 09:57:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:24 INFO - 'title': 't-yosemite-r7-0050', 09:57:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:24 INFO - 'use_talos_json': True, 09:57:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:24 INFO - 'work_dir': 'build'} 09:57:24 INFO - ##### 09:57:24 INFO - ##### Running clobber step. 09:57:24 INFO - ##### 09:57:24 INFO - Running pre-action listener: _resource_record_pre_action 09:57:24 INFO - Running main action method: clobber 09:57:24 INFO - rmtree: /builds/slave/test/build 09:57:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:25 INFO - Running post-action listener: _resource_record_post_action 09:57:25 INFO - ##### 09:57:25 INFO - ##### Running read-buildbot-config step. 09:57:25 INFO - ##### 09:57:25 INFO - Running pre-action listener: _resource_record_pre_action 09:57:25 INFO - Running main action method: read_buildbot_config 09:57:25 INFO - Using buildbot properties: 09:57:25 INFO - { 09:57:25 INFO - "project": "", 09:57:25 INFO - "product": "firefox", 09:57:25 INFO - "script_repo_revision": "production", 09:57:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:57:25 INFO - "repository": "", 09:57:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:57:25 INFO - "buildid": "20160412084656", 09:57:25 INFO - "pgo_build": "False", 09:57:25 INFO - "basedir": "/builds/slave/test", 09:57:25 INFO - "buildnumber": 705, 09:57:25 INFO - "slavename": "t-yosemite-r7-0050", 09:57:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:57:25 INFO - "platform": "yosemite_r7", 09:57:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:57:25 INFO - "branch": "fx-team", 09:57:25 INFO - "repo_path": "integration/fx-team", 09:57:25 INFO - "revision": "870749af34d8e7a0c41bd4dc8a67e5f244ac1b83", 09:57:25 INFO - "stage_platform": "macosx64", 09:57:25 INFO - "builduid": "3e55a195d436449598ab5ae182f667e9", 09:57:25 INFO - "slavebuilddir": "test" 09:57:25 INFO - } 09:57:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:57:25 INFO - Running post-action listener: _resource_record_post_action 09:57:25 INFO - ##### 09:57:25 INFO - ##### Running download-and-extract step. 09:57:25 INFO - ##### 09:57:25 INFO - Running pre-action listener: _resource_record_pre_action 09:57:25 INFO - Running main action method: download_and_extract 09:57:25 INFO - mkdir: /builds/slave/test/build/tests 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:25 INFO - https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:26 INFO - Downloaded 1199 bytes. 09:57:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:57:26 INFO - Using the following test package requirements: 09:57:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:57:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:57:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:57:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'jsshell-mac.zip'], 09:57:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:57:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:57:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:57:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:57:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:57:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:57:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:57:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:26 INFO - https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:28 INFO - Downloaded 18021277 bytes. 09:57:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:57:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:57:31 INFO - Return code: 0 09:57:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:31 INFO - https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:33 INFO - Downloaded 18021277 bytes. 09:57:33 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'] 09:57:33 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 09:57:36 INFO - Return code: 0 09:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:36 INFO - https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:37 INFO - Downloaded 10841076 bytes. 09:57:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:57:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:57:38 INFO - Return code: 0 09:57: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')]} 09:57:38 INFO - https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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 09:57:41 INFO - Downloaded 108929766 bytes. 09:57:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:41 INFO - mkdir: /builds/slave/test/properties 09:57:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:41 INFO - Contents: 09:57:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - Running post-action listener: set_extra_try_arguments 09:57:42 INFO - ##### 09:57:42 INFO - ##### Running populate-webroot step. 09:57:42 INFO - ##### 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: populate_webroot 09:57:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:42 INFO - '--tppagecycles', 09:57:42 INFO - '7'], 09:57:42 INFO - 'tests': ['tsvgm']}}, 09:57:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['damp', 'tps']}, 09:57:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['damp', 'tps']}, 09:57:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['dromaeo_dom']}, 09:57:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tsvgx', 09:57:42 INFO - 'tsvgr_opacity', 09:57:42 INFO - 'tart', 09:57:42 INFO - 'tscrollx', 09:57:42 INFO - 'cart']}, 09:57:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:42 INFO - 'tsvgr_opacity', 09:57:42 INFO - 'tart', 09:57:42 INFO - 'tscrollx', 09:57:42 INFO - 'cart']}, 09:57:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tp5o']}, 09:57:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['tp5o']}, 09:57:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s', 09:57:42 INFO - '--xperf_path', 09:57:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:42 INFO - 'tests': ['tp5n']}, 09:57:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--xperf_path', 09:57:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:42 INFO - 'tests': ['tp5n']}}, 09:57:42 INFO - 'talos.zip': {'path': '', 09:57:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - ##### 09:57:42 INFO - ##### Running create-virtualenv step. 09:57:42 INFO - ##### 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: create_virtualenv 09:57:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:42 INFO - Using real prefix '/tools/python27' 09:57:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:46 INFO - Installing pip.................done. 09:57:46 INFO - Return code: 0 09:57:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:46 INFO - 'HOME': '/Users/cltbld', 09:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:46 INFO - 'LOGNAME': 'cltbld', 09:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:46 INFO - 'MOZ_NO_REMOTE': '1', 09:57:46 INFO - 'NO_EM_RESTART': '1', 09:57:46 INFO - 'PAGER': '/bin/cat', 09:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:46 INFO - 'PWD': '/builds/slave/test', 09:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:46 INFO - 'SHELL': '/bin/bash', 09:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:57:46 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:46 INFO - 'USER': 'cltbld', 09:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:46 INFO - 'XPC_FLAGS': '0x0', 09:57:46 INFO - 'XPC_SERVICE_NAME': '0', 09:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:46 INFO - Cleaning up... 09:57:46 INFO - Return code: 0 09:57:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:46 INFO - 'HOME': '/Users/cltbld', 09:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:46 INFO - 'LOGNAME': 'cltbld', 09:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:46 INFO - 'MOZ_NO_REMOTE': '1', 09:57:46 INFO - 'NO_EM_RESTART': '1', 09:57:46 INFO - 'PAGER': '/bin/cat', 09:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:46 INFO - 'PWD': '/builds/slave/test', 09:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:46 INFO - 'SHELL': '/bin/bash', 09:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:57:46 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:46 INFO - 'USER': 'cltbld', 09:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:46 INFO - 'XPC_FLAGS': '0x0', 09:57:46 INFO - 'XPC_SERVICE_NAME': '0', 09:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:46 INFO - Downloading/unpacking psutil>=0.7.1 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:50 INFO - Installing collected packages: psutil 09:57:50 INFO - Running setup.py install for psutil 09:57:50 INFO - building 'psutil._psutil_osx' extension 09:57:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:57:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:57: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:57:51 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 09:57:51 INFO - building 'psutil._psutil_posix' extension 09:57:51 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 09:57:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:51 INFO - ^ 09:57:51 INFO - 1 warning generated. 09:57:51 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 09:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:51 INFO - Successfully installed psutil 09:57:51 INFO - Cleaning up... 09:57:51 INFO - Return code: 0 09:57:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:57:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:57:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:51 INFO - 'HOME': '/Users/cltbld', 09:57:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:51 INFO - 'LOGNAME': 'cltbld', 09:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:51 INFO - 'MOZ_NO_REMOTE': '1', 09:57:51 INFO - 'NO_EM_RESTART': '1', 09:57:51 INFO - 'PAGER': '/bin/cat', 09:57:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:51 INFO - 'PWD': '/builds/slave/test', 09:57:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:51 INFO - 'SHELL': '/bin/bash', 09:57:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:57:51 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:57:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:51 INFO - 'USER': 'cltbld', 09:57:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:51 INFO - 'XPC_FLAGS': '0x0', 09:57:51 INFO - 'XPC_SERVICE_NAME': '0', 09:57:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:54 INFO - Installing collected packages: mozsystemmonitor 09:57:54 INFO - Running setup.py install for mozsystemmonitor 09:57:54 INFO - Successfully installed mozsystemmonitor 09:57:54 INFO - Cleaning up... 09:57:54 INFO - Return code: 0 09:57:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:54 INFO - 'HOME': '/Users/cltbld', 09:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:54 INFO - 'LOGNAME': 'cltbld', 09:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:54 INFO - 'MOZ_NO_REMOTE': '1', 09:57:54 INFO - 'NO_EM_RESTART': '1', 09:57:54 INFO - 'PAGER': '/bin/cat', 09:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:54 INFO - 'PWD': '/builds/slave/test', 09:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:54 INFO - 'SHELL': '/bin/bash', 09:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:57:54 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:54 INFO - 'USER': 'cltbld', 09:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:54 INFO - 'XPC_FLAGS': '0x0', 09:57:54 INFO - 'XPC_SERVICE_NAME': '0', 09:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:58 INFO - Downloading docopt-0.6.1.tar.gz 09:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:58 INFO - Running setup.py install for blobuploader 09:57:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:58 INFO - Running setup.py install for requests 09:57:58 INFO - Running setup.py install for docopt 09:57:59 INFO - Successfully installed blobuploader requests docopt 09:57:59 INFO - Cleaning up... 09:57:59 INFO - Return code: 0 09:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:59 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')]} 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 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')]} 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 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 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:57:59 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 09:57:59 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 09:57:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:57:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:59 INFO - 'HOME': '/Users/cltbld', 09:57:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:59 INFO - 'LOGNAME': 'cltbld', 09:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:59 INFO - 'MOZ_NO_REMOTE': '1', 09:57:59 INFO - 'NO_EM_RESTART': '1', 09:57:59 INFO - 'PAGER': '/bin/cat', 09:57:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:59 INFO - 'PWD': '/builds/slave/test', 09:57:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:59 INFO - 'SHELL': '/bin/bash', 09:57:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:57:59 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:57:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:59 INFO - 'USER': 'cltbld', 09:57:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:59 INFO - 'XPC_FLAGS': '0x0', 09:57:59 INFO - 'XPC_SERVICE_NAME': '0', 09:57:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-t1cHhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-cGaEXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jsEfD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-oMoa92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-eNMfK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:59 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-6seA80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-5Zirfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jYXehx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-w5kldG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Ud8Cpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-FAMsQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-sCXhac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-OpRZ0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-u4PL3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-OIn3GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-wJWTvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-7Ru5EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:01 INFO - Running setup.py install for manifestparser 09:58:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:01 INFO - Running setup.py install for mozcrash 09:58:01 INFO - Running setup.py install for mozdebug 09:58:01 INFO - Running setup.py install for mozdevice 09:58:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:01 INFO - Running setup.py install for mozfile 09:58:02 INFO - Running setup.py install for mozhttpd 09:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozinfo 09:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozInstall 09:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozleak 09:58:02 INFO - Running setup.py install for mozlog 09:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for moznetwork 09:58:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozprocess 09:58:03 INFO - Running setup.py install for mozprofile 09:58:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for mozrunner 09:58:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for mozscreenshot 09:58:03 INFO - Running setup.py install for moztest 09:58:03 INFO - Running setup.py install for mozversion 09:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:03 INFO - Cleaning up... 09:58:03 INFO - Return code: 0 09:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:03 INFO - 'HOME': '/Users/cltbld', 09:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:03 INFO - 'LOGNAME': 'cltbld', 09:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:03 INFO - 'MOZ_NO_REMOTE': '1', 09:58:03 INFO - 'NO_EM_RESTART': '1', 09:58:03 INFO - 'PAGER': '/bin/cat', 09:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:03 INFO - 'PWD': '/builds/slave/test', 09:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:03 INFO - 'SHELL': '/bin/bash', 09:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:58:03 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:03 INFO - 'USER': 'cltbld', 09:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:03 INFO - 'XPC_FLAGS': '0x0', 09:58:03 INFO - 'XPC_SERVICE_NAME': '0', 09:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8l_oy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:04 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)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-hHiuMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-4QULu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Xw7xM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MmlhVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Z6VpC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-kGfnXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-H_lFBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-K4A70J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-kVAkUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Fz8oF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-YKeRQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-qupHQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-_R0TIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bDMRST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-_iNM35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-88rZCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:08 INFO - Downloading blessings-1.6.tar.gz 09:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:08 INFO - Installing collected packages: blessings 09:58:08 INFO - Running setup.py install for blessings 09:58:08 INFO - Successfully installed blessings 09:58:08 INFO - Cleaning up... 09:58:08 INFO - Return code: 0 09:58:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:08 INFO - Reading from file tmpfile_stdout 09:58:08 INFO - Current package versions: 09:58:08 INFO - blessings == 1.6 09:58:08 INFO - blobuploader == 1.2.4 09:58:08 INFO - docopt == 0.6.1 09:58:08 INFO - manifestparser == 1.1 09:58:08 INFO - mozInstall == 1.12 09:58:08 INFO - mozcrash == 0.17 09:58:08 INFO - mozdebug == 0.1 09:58:08 INFO - mozdevice == 0.48 09:58:08 INFO - mozfile == 1.2 09:58:08 INFO - mozhttpd == 0.7 09:58:08 INFO - mozinfo == 0.9 09:58:08 INFO - mozleak == 0.1 09:58:08 INFO - mozlog == 3.1 09:58:08 INFO - moznetwork == 0.27 09:58:08 INFO - mozprocess == 0.22 09:58:08 INFO - mozprofile == 0.28 09:58:08 INFO - mozrunner == 6.11 09:58:08 INFO - mozscreenshot == 0.1 09:58:08 INFO - mozsystemmonitor == 0.0 09:58:08 INFO - moztest == 0.7 09:58:08 INFO - mozversion == 1.4 09:58:08 INFO - psutil == 3.1.1 09:58:08 INFO - requests == 1.2.3 09:58:08 INFO - wsgiref == 0.1.2 09:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:08 INFO - 'HOME': '/Users/cltbld', 09:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:08 INFO - 'LOGNAME': 'cltbld', 09:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:08 INFO - 'MOZ_NO_REMOTE': '1', 09:58:08 INFO - 'NO_EM_RESTART': '1', 09:58:08 INFO - 'PAGER': '/bin/cat', 09:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:08 INFO - 'PWD': '/builds/slave/test', 09:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:08 INFO - 'SHELL': '/bin/bash', 09:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:58:08 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:08 INFO - 'USER': 'cltbld', 09:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:08 INFO - 'XPC_FLAGS': '0x0', 09:58:08 INFO - 'XPC_SERVICE_NAME': '0', 09:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 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)) 09:58:09 INFO - Cleaning up... 09:58:09 INFO - Return code: 0 09:58:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:09 INFO - 'HOME': '/Users/cltbld', 09:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:09 INFO - 'LOGNAME': 'cltbld', 09:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:09 INFO - 'MOZ_NO_REMOTE': '1', 09:58:09 INFO - 'NO_EM_RESTART': '1', 09:58:09 INFO - 'PAGER': '/bin/cat', 09:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:09 INFO - 'PWD': '/builds/slave/test', 09:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:09 INFO - 'SHELL': '/bin/bash', 09:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:58:09 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:09 INFO - 'USER': 'cltbld', 09:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:09 INFO - 'XPC_FLAGS': '0x0', 09:58:09 INFO - 'XPC_SERVICE_NAME': '0', 09:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:09 INFO - Downloading/unpacking jsonschema 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:12 INFO - warning: no files found matching '*.txt' 09:58:12 INFO - no previously-included directories found matching 'build' 09:58:12 INFO - no previously-included directories found matching 'dist' 09:58:12 INFO - no previously-included directories found matching '.git*' 09:58:12 INFO - Installing collected packages: jsonschema, functools32 09:58:12 INFO - Running setup.py install for functools32 09:58:12 INFO - warning: no files found matching '*.txt' 09:58:12 INFO - no previously-included directories found matching 'build' 09:58:12 INFO - no previously-included directories found matching 'dist' 09:58:12 INFO - no previously-included directories found matching '.git*' 09:58:12 INFO - Successfully installed jsonschema functools32 09:58:12 INFO - Cleaning up... 09:58:12 INFO - Return code: 0 09:58:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f2f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd785a40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, '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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 09:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:12 INFO - 'HOME': '/Users/cltbld', 09:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:12 INFO - 'LOGNAME': 'cltbld', 09:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:12 INFO - 'MOZ_NO_REMOTE': '1', 09:58:12 INFO - 'NO_EM_RESTART': '1', 09:58:12 INFO - 'PAGER': '/bin/cat', 09:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:12 INFO - 'PWD': '/builds/slave/test', 09:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:12 INFO - 'SHELL': '/bin/bash', 09:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:58:12 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:12 INFO - 'USER': 'cltbld', 09:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:12 INFO - 'XPC_FLAGS': '0x0', 09:58:12 INFO - 'XPC_SERVICE_NAME': '0', 09:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:12 INFO - Downloading/unpacking flake8 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:16 INFO - no previously-included directories found matching 'docs/_build' 09:58:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:16 INFO - Running setup.py install for pep8 09:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:16 INFO - no previously-included directories found matching 'docs/_build' 09:58:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:16 INFO - Cleaning up... 09:58:16 INFO - Return code: 0 09:58:16 INFO - Running post-action listener: _resource_record_post_action 09:58:16 INFO - Running post-action listener: _start_resource_monitoring 09:58:16 INFO - Starting resource monitoring. 09:58:16 INFO - ##### 09:58:16 INFO - ##### Running install step. 09:58:16 INFO - ##### 09:58:16 INFO - Running pre-action listener: _resource_record_pre_action 09:58:16 INFO - Running main action method: install 09:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:17 INFO - Reading from file tmpfile_stdout 09:58:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:17 INFO - Reading from file tmpfile_stdout 09:58:17 INFO - Output received: 09:58:17 INFO - Usage: mozinstall [options] installer 09:58:17 INFO - Options: 09:58:17 INFO - -h, --help show this help message and exit 09:58:17 INFO - -d DEST, --destination=DEST 09:58:17 INFO - Directory to install application into. [default: 09:58:17 INFO - "/builds/slave/test"] 09:58:17 INFO - --app=APP Application being installed. [default: firefox] 09:58:17 INFO - mkdir: /builds/slave/test/build/application 09:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:58:50 INFO - Reading from file tmpfile_stdout 09:58:50 INFO - Output received: 09:58:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:58:50 INFO - Running post-action listener: _resource_record_post_action 09:58:50 INFO - ##### 09:58:50 INFO - ##### Running run-tests step. 09:58:50 INFO - ##### 09:58:50 INFO - Running pre-action listener: _resource_record_pre_action 09:58:50 INFO - Running main action method: run_tests 09:58:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:50 INFO - 2016-04-12 09:58:50.359 screenresolution[1647:7541] starting screenresolution argv=screenresolution get 09:58:50 INFO - 2016-04-12 09:58:50.362 screenresolution[1647:7541] Display 0: 1600x1200x32@60 09:58:50 INFO - 2016-04-12 09:58:50.367 screenresolution[1648:7543] starting screenresolution argv=screenresolution list 09:58:50 INFO - Available Modes on Display 0 09:58:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:50 INFO - Intel Iris: 09:58:50 INFO - Chipset Model: Intel Iris 09:58:50 INFO - Type: GPU 09:58:50 INFO - Bus: Built-In 09:58:50 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:50 INFO - Vendor: Intel (0x8086) 09:58:50 INFO - Device ID: 0x0a2e 09:58:50 INFO - Revision ID: 0x0009 09:58:50 INFO - Displays: 09:58:50 INFO - Display: 09:58:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:50 INFO - Display Serial Number: 1600x1200 60 09:58:50 INFO - Main Display: Yes 09:58:50 INFO - Mirror: Off 09:58:50 INFO - Online: Yes 09:58:50 INFO - Rotation: Supported 09:58:50 INFO - Return code: 0 09:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:50 INFO - Python 2.7.3 09:58:50 INFO - Return code: 0 09:58:50 INFO - grabbing minidump binary from tooltool 09:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dbee00>, '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 0x107be7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107db9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:58:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:58:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:50 INFO - Return code: 0 09:58:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:51 INFO - Return code: 0 09:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 09:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lXv2i1pCYD/Render', 09:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:51 INFO - 'HOME': '/Users/cltbld', 09:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PAGER': '/bin/cat', 09:58:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5rV2Aa8HCE/Listeners', 09:58:51 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 09:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - 'XPC_FLAGS': '0x0', 09:58:51 INFO - 'XPC_SERVICE_NAME': '0', 09:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 09:58:52 INFO - mozversion application_buildid: 20160412084656 09:58:52 INFO - mozversion application_changeset: 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 09:58:52 INFO - mozversion application_display_name: Nightly 09:58:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:52 INFO - mozversion application_name: Firefox 09:58:52 INFO - mozversion application_remotingname: firefox 09:58:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:58:52 INFO - mozversion application_vendor: Mozilla 09:58:52 INFO - mozversion application_version: 48.0a1 09:58:52 INFO - mozversion platform_buildid: 20160412084656 09:58:52 INFO - mozversion platform_changeset: 870749af34d8e7a0c41bd4dc8a67e5f244ac1b83 09:58:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:58:52 INFO - mozversion platform_version: 48.0a1 09:58:52 INFO - using testdate: 1460480332 09:58:52 INFO - actual date: 1460480332 09:58:52 INFO - starting webserver on 'localhost:49270' 09:58:52 INFO - SUITE-START | Running 2 tests 09:58:52 INFO - TEST-START | dromaeo_css 09:58:52 INFO - operating with platform_type : mac_ 09:58:52 INFO - Initialising browser for dromaeo_css test... 09:58:52 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpwGdFy8/profile http://localhost:49270/getInfo.html) 09:58:54 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:58:54 INFO - PROCESS | 1666 | colorDepth:24 09:58:54 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:58:54 INFO - PROCESS | 1666 | __metrics 09:58:54 INFO - PROCESS | 1666 | 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" 09:58:54 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:58:55 INFO - TEST-INFO | 1666: exit 0 09:58:55 INFO - Browser initialized. 09:58:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:55 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpwGdFy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:07 INFO - PROCESS | 1668 | RSS: Main: 237531136 09:59:07 INFO - PROCESS | 1668 | 09:59:58 INFO - PROCESS | 1668 | 1460480398580 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] 10:02:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 10:02:10 INFO - PROCESS | 1668 | RSS: Main: 372633600 10:02:10 INFO - PROCESS | 1668 | 10:05:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:05:14 INFO - PROCESS | 1668 | RSS: Main: 371720192 10:05:14 INFO - PROCESS | 1668 | 10:08:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:08:16 INFO - PROCESS | 1668 | RSS: Main: 376676352 10:08:16 INFO - PROCESS | 1668 | 10:11:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:11:19 INFO - PROCESS | 1668 | RSS: Main: 336990208 10:11:19 INFO - PROCESS | 1668 | 10:14:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 10:14:23 INFO - PROCESS | 1668 | RSS: Main: 339468288 10:14:23 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:17:26 INFO - PROCESS | 1668 | RSS: Main: 384696320 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | __start_tp_report 10:17:26 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 10:17:26 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 10:17:26 INFO - PROCESS | 1668 | |i|pagename|runs| 10:17:26 INFO - PROCESS | 1668 | |0;dojo.html;3393.2534842334685;3430.365382404254;3473.1664400543877;3474.6004209515904;3509.0876372143234;5494.945050549493;5601.3558440779325;5661.348944871341;5662.971685141579;5688.00459919514;5583.4974852263285;5677.630953987988;5716.7141642917795;5718.7426565804535;5751.741171647275;5086.160783470723;5116.565091967187;5170.25031370453;5184.611154163434;5278.181881808326;5260.263563101169;5262.473752624745;5309.0709125903;5335.733213339317;5367.731613419313;5075.593952483811;5126.92309615356;5167.457416971201;5242.947570524284;5256.684598924038;4260.744355338689;5175.560077393426;5192.039472697563;5198.40218374888;5201.193814958688;5111.284420181178;5169.508896654849;5201.505856943584;5203.60972927032;5223.869403264911;5448.782048718046;5550.4449555044175;5577.274954255961;5589.944100559023;5608.10270356741;6159.969200154015;6203.379662033761;6212.471939885115;6226.128342032119;6236.781712640081;6190.473809726179;6199.256089269316;6222.066689996536;6239.750409983595;6242.438180563726;5485.6982865942355;5592.189132575753;5731.799387021434;5793.826185214451;5796.652200867919;6191.473724733358;6205.782797602063;6215;6219.689015549205;6222.968885155546;6050.909236361458;6081.604695694854;6110.938890611126;6121.877562448726;6130.386961303834;6026.728797204137;6126.700892189639;6126.884121540821;6225.782097626561;6232.844178895473;6131.152125279649;6144.941444616104;6150.231221097363;6152.292486364126;6157.630542167484;6152.969235153795;6180.536459765535;6183.072539119078;6199.3490683478485;6211.068339749074;4778.1399348117675;4858.708477491291;4863.392075990501;4894.779734911866;4969.577585905238;4343.891402714958;4432.977835110803;4440.4671439427475;4446.066326071496;4455.487618923865;5591.245181900392;5603.467670571289;5604.915926261027;5612.663240205601;5612.747426365823;6129.542179248731;6132.63204207749;6144.617461071312;6148.339948214047;6224.62652240867;5655.688937108416;5660.688662123541;5661.320641523043;5679.829605111853;5686.630369026;5315.574754019669;5351.384590772033;5364.839054828361;5388.38033626138;5437.32033495813;6129.603311142676;6172.567920245539;6192.535559832941;6234.314225435108;6234.812955611339;6182.196314479089;6198.845028874314;6202.472789812917;6204.5036397089025;6206.813795586139;6231.283402408781;6242.469390101892;6252.562320637512;6259.374062593704;6260.060990851409;5921.437463440966;6103.03463616155;6128.540359473147;6145.709401025656;6186.81439556814;5166.793328266827;6018.789342372996;6161.815145545641;6168;6201.534884883742;5053;5812.128180772918;6107.267127944675;6109.266887973472;6118.051701986199;4706.764661766966;6033.577649564664;6081.331053584191;6108.08378743192;6122.38776122402;5865.266841644794;5911.113333000085;5912.586118971631;5915.58590898633;5919.4968427684125;5861.062230043343;5930.021546444961;6067.362926892789;6078.118672792332;6080.300765411857;5933.643981361132;5951.672658003678;5988.101784732325;6011.489023433057;6042.516598672008 10:17:26 INFO - PROCESS | 1668 | |1;ext.html;506.21789335476683;515.4819406496471;533.5624787674107;544.8855740294539;583.7536858806452;25816.483670326583;29385.559216611768;29391.85304073482;29443.852780736066;29542.81828726851;29547.704522954766;38704.419433708514;39967.20065598686;40091;40157.19685606286;9377.812443751138;9603.903960960406;9610.135087842093;9611.807763844754;9614;8451.154884511561;9428.151466368026;9608.951955240214;9629.711108666716;9636.951815240915;8585.871211931826;11399.145064120183;11753.764924701502;11767.470463829106;11770.823437648442;11379.317240965527;11481.540738370455;11495.827562586568;11499.77000459986;11500.309981401142;8439.156084391512;11240.718982025515;11289.98390144891;11452.656420307405;11610.767784644344;37048.629513704785;37569.43645845314;37595.62404375976;37674.623253767386;37724.43413348802;3080.2299425143715;3264.5103234514777;3314.983425082859;3409.641987591292;3658.762180458262;26882;27466;28037.859810700815;28335;28359.85820070907;2235.0724449353497;2655.6016597510334;2711.3763834318215;2764.7235276472193;2826.0815235048485;464000;464163;465575.9999999966;466015;467356;57913.71043144757;58429;58501;58509.70745146332;58551;60684;60997.69501152466;61078.38921610727;61123.970743364196;61131;15900;16325;16375.017498950101;16376.918115409586;16395.262213200436;10672.30630009047;12776.169548979287;12818.230906145474;12908;12922.741545169043;13593.52422665202;13990.86009139916;15027.09837409759;15141.394344226328;15523.689526209413;6772.187337519529;6910.997905303703;6997.230304666585;7022.508424410242;7046.718131274692;906.5014242166782;953.7234202081319;956.067833861979;1013.4729940430934;1051.7370657335666;23587.29238122859;28518.714812851606;29224.26939326534;29285.7071429283;29445.411091778475;1013.1995723378449;1111.3998440841856;1134.5461815273957;1173.5540494611994;1218.2933898338943;13639.181649100887;13642.863571364358;13909.234992075331;13967.511137110152;14158.50445234412;594173;598065;600060;602317;604381;52326;54063;54259.6435089118;54361;54365.72817135889;1304.562971404571;1347.1378317876568;1348.2315080404076;1448.1311213271952;1468.9118652880861;23562.764372356058;26986.0080665233;27949;28619.713802862538;29661.85169074141;46807.553282438115;47202;47707.76146119247;47771;47877;355307.22346389137;357798;359101;359706;360108;22255.77744222537;23902.282931512083;24324;24534.754652453248;25236.74763252344;38387;38735;38919.6108038916;39010.41484377794;39373.409398859614;32168.67831321657;33158.5026224602;33215.681771662355;33998.150046249044;34079.659203407646;28699.867520752967;32396.514052289705;32643.836780816895;33025.66974330226;33142.17144571405;33535.83232083824;33963.97428299743;34727.65272347345;34817.69231922963;34878;27914.02300919458;30019.249518762204;30115;30255.546166807955;30676.079717608507;17646.382376616755;20574.382768516967;20887.8955605221;21321.36035918925;21361.89319053395 10:17:26 INFO - PROCESS | 1668 | |2;jquery.html;392.45644781976955;395.7486995757695;396.3183324681548;398.5357059026235;410.7371282379278;18760.249590016418;19327.806721932775;19620.117094730736;20336.38990830274;20384.796152038474;19248.615027699438;19483.123259453325;19753.604927901433;20476.8976155119;20515.07682154303;5672.546196304285;5756.8272951811405;5992.940070599304;5997.580169388145;6001.519878409738;5913;5928.6739229342365;5944.256967879015;5966.999999999978;5983.461488466037;6582.703778329987;6605.801825945229;6609.074729537869;6610.8677826443445;6615.867682646368;6087.299960504554;6115.602485838406;6288.842778930518;6589.472842172615;6618.569792963442;5645.8023969161295;5820.272465941757;5845.473907348317;5846.9707651461895;5852.6488410695065;13692.589222323346;16053.759193612104;20343.5931281375;24553.281270311087;25089.749102508922;2055.1162999910034;2055.126571207246;2127.5000374911883;2164.286284209688;2213.380253529014;8988.101189881025;9698.806023879482;9787.706368808947;9817.067378599022;10331.380117192992;1706.1810331041045;1707.9573010674708;1710.7604935309066;1781.980541249269;1804.124999375302;83273;102058;119980;123241;126107;8780.165884240987;9504.667336643184;11506.654800356002;11598.478068486938;11686.941565292289;15028;15070.397184112731;15121.470748523969;15136.848631513763;15142.848571514363;8409.95795021021;8634.618461046202;8668.056034504412;8751.081136480705;8758.912410875937;8538.701145460003;8565.52889591066;8578.699745509002;8678.349123815738;8684.175003374668;4535.29702896045;4634.25851863707;4638.721676699409;4662.860114196579;4707.270373092176;1893.4887580353502;1945.114972687424;1950.1224448998007;1950.658634738915;1953.5897461532952;857.7126662567985;899.5187574647532;933.2440723014245;984.9704508864745;1000.309786247487;17504.5623859402;19421.902890485457;20217.89891050535;20450.23921770542;20487.18051277962;809.9757007289791;927.3971918253189;939.8496240601471;943.4150826487621;968.5544649461327;10492.527836247387;10776.568937242422;10777.976092271221;10778.407187604756;10808.189385796097;633942;639570;641718;653024.7348763226;658990;86349;102074;111275;117367;122992;1011.2668315471371;1031.515187861704;1052.889446608095;1064.8189807732704;1067.9145668346514;13555.39000744949;16540.917295413445;18018.90990545039;18124.365647202285;18422.907885461023;33706.66293337035;46764.53235467602;48609.756951216434;49359.51921442363;50676;71372.28627713864;73274.63362683152;73420;73747.63126184334;75242;5968.552358573038;6963.79108626742;7473.551586904803;7979.92020079815;8413.621387037476;9853.458059806493;11539.480723367637;12733.981281497643;12785.872141278469;13183.802242966554;10604.575816967543;10994.780104398027;11010.779784404427;11167.609133680282;11263.549458021587;9004.279657627243;10326.070653641209;10642.988916052962;10756;10905.073068789241;10249.846252306072;10410.791784164123;11056.170787190831;11435.085193184692;11604.013658838756;6961.79114626562;6998.475114366544;7138.607376594337;7182.640867956686;7254.528455650366;8864.73405797827;9993.60025598997;10029.04724051214;10172.949135254275;10215.59137634516 10:17:26 INFO - PROCESS | 1668 | |3;mootools.html;1327.9269640169787;1574.2364952997793;1586.373382513907;1811.175914958693;1941.8446524278058;7946.6026698665055;8587.828243435135;8860.556972151382;8894.82210355794;8902.065283145266;8489.023762267341;8699.260562852149;8706.477611343324;8708.172723591264;8720.040795512488;2138.1447421031557;2402.8798560072014;2456.5455390752722;2489.4772097859473;2500.099964012954;2492.8504289742673;2514.245726282117;2519.722830488645;2523.3943853475125;2528.2415275417393;2391.1272385579314;2478.30607429919;2480.937976550583;2481.5161043596504;2482.7641374069435;2122.9787702123012;2371.703537057868;2444.9511009779794;2456.3736247257016;2471.122751423237;2448.069733501276;2448.3879030242438;2472.629105634151;2474.9752502474926;2499.662545556363;8580.141985801432;8726.86909696355;8739.21347078766;8742.08208138149;8757.124287571256;5300;5471.5896307776675;5475.972620136874;5492.505674489275;5512.062949298629;3582.301451217014;3598.226381328027;3653.8538458461894;3659.8536058557625;3670.6696397324367;1046.7016900183487;1053.4311471805215;1058.9523471443804;1070.892910708923;1072.394097335011;11759.294442333401;11765.941170294094;11775.999040081604;11784.528618855236;11786.646400607995;4720.8743812184075;4724.622030237572;4787.952120478821;4906.9263961040615;4953.455119936804;9858.570507276405;9901.554430050664;9904.15814655748;9908.950455247821;9923.057309555581;5433.0763770159165;5433.565314774809;5439.782408703608;5448.101063324586;5450.345958485007;4416.734995900256;4595.6783025187915;4826.61387089032;4948.480409556944;4960.280759289955;3781.9243615128094;3965.3457179565626;3971.781552014667;4095.6928230382246;4124.463819703419;1343.147101590497;1348.6089034179977;1348.9123206991515;1361.3125371687236;1366.3782978744648;1312.783390740536;1339.604816579092;1380.5375199308344;1381.6891199480237;1383.197745307719;8094.190580941977;8109.675612975415;8118.02583689961;8121;8445.366597505212;1171.496256609666;1175.9647210583696;1177.7408970026581;1192.266755945105;1203.8976686981705;5370;6143.723532441051;6325.620462772248;6345.555811093272;6350.396712312323;9823.557939892722;10593.311434756715;10628.681139565826;10751.301165424222;10780.94609526963;10265.538050787733;10805.189610779224;10828.24202305831;10912.454377281105;10982.670519884416;8001.4398992071165;8155.959220203979;8187.1812818718845;8255;8265.46274492156;8025.518468891885;8149.79625509367;8236.258736713724;8264.876026859481;8267.503949763033;9630.085141911508;9776.608935642495;9801.558929848317;9830.75423114428;9903.603855845686;9892.208623310262;9917.355371900803;10196.847047294148;10258.384496930208;10296.536655850356;6837.521373503807;7085.716571337089;7418.703251869865;7531.8117047074265;7635.274648908345;8250.339972802281;8310.87533686983;8342.624581893708;8344.207300306462;8353.331733461187;7213.531120477152;7291.708331666886;7350.77947661571;7538.698452061856;7542.434317426325;7199.640017998974;7232.0959880015;7239.348458638748;7258.963705181441;7394.815129621587;7621.237876212334;7703.768886933401;7734.7679569613;7742.38060955111;7788.260115289038;6849.760258390932;6953.756618518328;6991.545549539263;6998.125234345707;7039.296070393125;7032.191298000591;7230.74692385764;7234.095738032746;7243.7464688735645;7248.818779530343 10:17:26 INFO - PROCESS | 1668 | |4;prototype.html;282.7695428225996;322.30382374071996;325.5279844225872;331.1159204922854;331.8281845322365;4709;5303.151495760679;5568;5741.913871291928;5791.478766910977;4858.538438848313;5782.190493330926;5826.941730582693;5845.970770146154;5849.619774714641;4088.632023117919;4202.415514458601;4312.116016216683;4452.220861349267;4470.776461176944;3849.7305188636806;4430.623397011242;4453.170273564731;4465.151621191963;4501.932471012938;3598.892033239007;4431.711938723973;4443.955560444403;4444.400005999181;4455.598996090352;4179.665626749853;4210.642095421893;4346.826126954918;4446.622037126848;4460.397846290758;3337.499375093731;3839.462475253467;3848.826802793881;3849.672777813861;3851.9984803951174;5596.832095037155;5603.467670571289;5628.32460104786;5658.519025882805;5662.263905692274;4038.6365227129404;4233.788310584489;4982.60139188864;5120.769565369567;5125.282460455539;5657.632253903483;5699.953033346329;6116.938830611726;6174.382561743834;6217.378262173792;3808.5810560838286;4146.357314616239;4156.833726650931;4175.457190565237;4178.26880295947;6335.588186767845;6495.870082598369;6537.5750576212395;6572.441342485942;6634.369734875179;4078.3882417636996;4090.1615168890307;4095.32427149517;4098.180363927227;4110.958890411118;4153.466385504839;4156.334986402161;4170.207660544487;4180.163967206571;4182.707210495236;4715.646326525524;4917.262410638361;4920.114379411741;5040.2691609716385;5062.240663900445;4994.725290109006;5911.615744976649;6313.210848643919;6316.62100273985;6368;1455.0978393396163;1473.8599833015846;1480.3190532355238;1482.1181397068726;1485.717713634406;922.6632279218171;967.5984466446487;979.941663003954;981.2052237687496;984.1929617713549;5749.85625359361;5773.826785196451;5795.94204057954;5798.5071268941765;5964.463198312173;5282.603804714662;5689.687067211343;6080.9391906081255;6418.422341989243;6502.902456463157;4843.564079232886;5766.826995190151;5899.439553242435;5902.2327097477055;5907.734151963086;3099.7365223956217;3430.7598468107494;3437.553118094682;3444.569428821397;3464.359093567698;6444.2589102252905;6735.360140786617;6761.797146085625;6786;6810;5187.273781670569;6152.16945712332;6571.474282057424;6678.362046991411;6728;5246.091661711973;6459.612423254526;6700.798976030727;6701.932980670131;6713.328667133248;6123.663198524124;6451.3226111257645;6459.838504037437;6465.903011454738;6480.481561474976;5231.55531779803;5705.743241554057;6241.658043520665;6362.586431881913;6366.490680745436;5904.114382842608;6657.535342224703;6692.83267918306;6720.361565651256;6728.3271672832325;3961.8613348532663;4119.949412899691;4187.7696726679105;4212.304969679968;4234.153169366077;6379.457746091634;6415.454686351713;6426.4216220540375;6436.195475565554;6461.967690161519;5916;6043.909341359795;6096.481799047131;6231.345708700521;6242.53181011435;5446.50981411659;5826.329972053268;5921.851953701192;6165.599236049642;6227.283862355887;5016.648834581544;6013.067974463965;6059.363766804422;6094.202210347869;6095.573309868444;4720.834770783006;5735.59133040634;6180.536459765445;6197.597156185014;6201.627902325875;5579.721013949367;6054.091886217103;6102.491067636039;6105.511559075175;6127.387261273837 10:17:26 INFO - PROCESS | 1668 | |5;yui.html;658.4995403493346;725.6263024542359;739.8594267089253;749.0337464670575;764.0602059466859;14699.706005879889;15155.772663410044;17146.142692865353;17928.462146135636;17940.730889036677;16280.26738796754;16316.75524867125;16382.590435239124;16399.4260200893;16418.26117824698;728.3735987051132;912.3522299167582;933.6872147830485;936.4896131608256;937.0535758883509;739.9408047356226;898.0794685447436;919.9494027828467;920.6685593186447;922.0963455813308;963.9421634701905;973.8295798235281;974.6491263145263;975.3660120921387;982.3123813330661;754.9886751698729;943.9244860411219;970.3110791338123;971.2958105373583;981.1022914033687;704.6828926982878;707.1231672725835;707.7558242406361;710.9466789990771;716.0333549707905;15611;15696.686066278724;15723.685526289524;15734.68530629381;15736.977096488692;11886.227395219283;12362.567310144103;12449.75100497985;12667.873321266761;12762.80855787164;9891.109800117953;10282.61184740058;10371.792564148675;10734.248602597821;10901;3432.7768695034742;3482.547268855058;3528.1003344147334;3532.5584301962253;3595.2989167112423;88274.5586272071;89404;89792.65311020405;89819.55090224507;90894;9566.760830979281;9581.185599224144;9818.214542836557;9866.963968783319;10019.649312274181;21163.470913226985;21374.679379809317;21378.679319810217;21383.25158619441;21384.358469245948;7475.7009719610605;7576.469647124759;7653.464257501922;7666.271704188093;7681.3854891608535;3974.4833171687496;4129.772862492532;4194.748315101104;4217.135487225111;4237.470316210473;3420.7776494528275;3542.91142721434;3551.236484155919;3552.4493703476;3553.6979356754964;540.7053156029973;634.3497914637534;649.1139594453537;650.0444346810182;652.7389044382285;540.5054375246606;560.6243816642859;583.2563481561043;608.9117078023751;627.6704730016686;5938.673372964442;7837.843243135106;7953.721619743281;7973.035450627139;8398.832023359499;500.51950127876916;531.4366771222517;536.9758360873692;604.5163868904858;610.8350745298744;3750.2124553843996;3792.488014118059;3814.8092595370676;3868.2456920900154;3875.4380614811257;69558.95661565081;72174.63912680403;72288.63855680688;72466;80589.79115313276;64605;66167.66916165389;71149;71185.64407177932;72148;46684;47148.5285147151;62866.68566657137;63632.681836591444;63943.680281598296;7910.5649189295145;7949;7978.680852765824;8148.307393871587;8280.296174825207;41758.37362439505;42474.575254248295;42493;42601.786991064844;43691.56308436875;58921.410785893306;60980.390196099244;61106.77786444335;61353;61426.38573614207;10784.406857622906;10860.131189504662;10914.836277456003;11227.943860280646;11682.532698691957;11910.821337680116;11951.163418560618;11953.402329883646;12198.451069702061;12239.571614993432;9637.74709287788;10002.949985250027;11569.595064172714;11629.99350639697;11689.824652630388;11257.887421126012;11387.259828111146;11498.310101393943;11727.179097463437;11778.587749428729;11406.429678516208;11543.36511491876;11612.419379030845;11664.76670466569;11706.824397633873;9490.810183796148;9608.087231712976;9641.566129524328;10003.899961000589;10057.396556206359;9197.89625244975;9448.48033358172;9574.90425095768;9745.220382369534;9807.264455166034 10:17:26 INFO - PROCESS | 1668 | __end_tp_report 10:17:26 INFO - PROCESS | 1668 | __start_cc_report 10:17:26 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1286 10:17:26 INFO - PROCESS | 1668 | __end_cc_report 10:17:26 INFO - PROCESS | 1668 | __startTimestamp1460481446816__endTimestamp 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | ------- Summary: start ------- 10:17:26 INFO - PROCESS | 1668 | Number of tests: 6 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5678.14 Median:5912.59 stddev:625.60 (10.6%) stddev-sans-first:601.29 10:17:26 INFO - PROCESS | 1668 | Values: 3393.3 3430.4 3473.2 3474.6 3509.1 5494.9 5601.4 5661.3 5663.0 5688.0 5583.5 5677.6 5716.7 5718.7 5751.7 5086.2 5116.6 5170.3 5184.6 5278.2 5260.3 5262.5 5309.1 5335.7 5367.7 5075.6 5126.9 5167.5 5242.9 5256.7 4260.7 5175.6 5192.0 5198.4 5201.2 5111.3 5169.5 5201.5 5203.6 5223.9 5448.8 5550.4 5577.3 5589.9 5608.1 6160.0 6203.4 6212.5 6226.1 6236.8 6190.5 6199.3 6222.1 6239.8 6242.4 5485.7 5592.2 5731.8 5793.8 5796.7 6191.5 6205.8 6215.0 6219.7 6223.0 6050.9 6081.6 6110.9 6121.9 6130.4 6026.7 6126.7 6126.9 6225.8 6232.8 6131.2 6144.9 6150.2 6152.3 6157.6 6153.0 6180.5 6183.1 6199.3 6211.1 4778.1 4858.7 4863.4 4894.8 4969.6 4343.9 4433.0 4440.5 4446.1 4455.5 5591.2 5603.5 5604.9 5612.7 5612.7 6129.5 6132.6 6144.6 6148.3 6224.6 5655.7 5660.7 5661.3 5679.8 5686.6 5315.6 5351.4 5364.8 5388.4 5437.3 6129.6 6172.6 6192.5 6234.3 6234.8 6182.2 6198.8 6202.5 6204.5 6206.8 6231.3 6242.5 6252.6 6259.4 6260.1 5921.4 6103.0 6128.5 6145.7 6186.8 5166.8 6018.8 6161.8 6168.0 6201.5 5053.0 5812.1 6107.3 6109.3 6118.1 4706.8 6033.6 6081.3 6108.1 6122.4 5865.3 5911.1 5912.6 5915.6 5919.5 5861.1 5930.0 6067.4 6078.1 6080.3 5933.6 5951.7 5988.1 6011.5 6042.5 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:60296.55 Median:17954.17 stddev:129503.29 (721.3%) stddev-sans-first:129788.78 10:17:26 INFO - PROCESS | 1668 | Values: 506.2 515.5 533.6 544.9 583.8 25816.5 29385.6 29391.9 29443.9 29542.8 29547.7 38704.4 39967.2 40091.0 40157.2 9377.8 9603.9 9610.1 9611.8 9614.0 8451.2 9428.2 9609.0 9629.7 9637.0 8585.9 11399.1 11753.8 11767.5 11770.8 11379.3 11481.5 11495.8 11499.8 11500.3 8439.2 11240.7 11290.0 11452.7 11610.8 37048.6 37569.4 37595.6 37674.6 37724.4 3080.2 3264.5 3315.0 3409.6 3658.8 26882.0 27466.0 28037.9 28335.0 28359.9 2235.1 2655.6 2711.4 2764.7 2826.1 464000.0 464163.0 465576.0 466015.0 467356.0 57913.7 58429.0 58501.0 58509.7 58551.0 60684.0 60997.7 61078.4 61124.0 61131.0 15900.0 16325.0 16375.0 16376.9 16395.3 10672.3 12776.2 12818.2 12908.0 12922.7 13593.5 13990.9 15027.1 15141.4 15523.7 6772.2 6911.0 6997.2 7022.5 7046.7 906.5 953.7 956.1 1013.5 1051.7 23587.3 28518.7 29224.3 29285.7 29445.4 1013.2 1111.4 1134.5 1173.6 1218.3 13639.2 13642.9 13909.2 13967.5 14158.5 594173.0 598065.0 600060.0 602317.0 604381.0 52326.0 54063.0 54259.6 54361.0 54365.7 1304.6 1347.1 1348.2 1448.1 1468.9 23562.8 26986.0 27949.0 28619.7 29661.9 46807.6 47202.0 47707.8 47771.0 47877.0 355307.2 357798.0 359101.0 359706.0 360108.0 22255.8 23902.3 24324.0 24534.8 25236.7 38387.0 38735.0 38919.6 39010.4 39373.4 32168.7 33158.5 33215.7 33998.2 34079.7 28699.9 32396.5 32643.8 33025.7 33142.2 33535.8 33964.0 34727.7 34817.7 34878.0 27914.0 30019.2 30115.0 30255.5 30676.1 17646.4 20574.4 20887.9 21321.4 21361.9 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34890.76 Median:394.10 stddev:106793.21 (27097.8%) stddev-sans-first:107061.37 10:17:26 INFO - PROCESS | 1668 | Values: 392.5 395.7 396.3 398.5 410.7 18760.2 19327.8 19620.1 20336.4 20384.8 19248.6 19483.1 19753.6 20476.9 20515.1 5672.5 5756.8 5992.9 5997.6 6001.5 5913.0 5928.7 5944.3 5967.0 5983.5 6582.7 6605.8 6609.1 6610.9 6615.9 6087.3 6115.6 6288.8 6589.5 6618.6 5645.8 5820.3 5845.5 5847.0 5852.6 13692.6 16053.8 20343.6 24553.3 25089.7 2055.1 2055.1 2127.5 2164.3 2213.4 8988.1 9698.8 9787.7 9817.1 10331.4 1706.2 1708.0 1710.8 1782.0 1804.1 83273.0 102058.0 119980.0 123241.0 126107.0 8780.2 9504.7 11506.7 11598.5 11686.9 15028.0 15070.4 15121.5 15136.8 15142.8 8410.0 8634.6 8668.1 8751.1 8758.9 8538.7 8565.5 8578.7 8678.3 8684.2 4535.3 4634.3 4638.7 4662.9 4707.3 1893.5 1945.1 1950.1 1950.7 1953.6 857.7 899.5 933.2 985.0 1000.3 17504.6 19421.9 20217.9 20450.2 20487.2 810.0 927.4 939.8 943.4 968.6 10492.5 10776.6 10778.0 10778.4 10808.2 633942.0 639570.0 641718.0 653024.7 658990.0 86349.0 102074.0 111275.0 117367.0 122992.0 1011.3 1031.5 1052.9 1064.8 1067.9 13555.4 16540.9 18018.9 18124.4 18422.9 33706.7 46764.5 48609.8 49359.5 50676.0 71372.3 73274.6 73420.0 73747.6 75242.0 5968.6 6963.8 7473.6 7979.9 8413.6 9853.5 11539.5 12734.0 12785.9 13183.8 10604.6 10994.8 11010.8 11167.6 11263.5 9004.3 10326.1 10643.0 10756.0 10905.1 10249.8 10410.8 11056.2 11435.1 11604.0 6961.8 6998.5 7138.6 7182.6 7254.5 8864.7 9993.6 10029.0 10172.9 10215.6 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6071.38 Median:5436.67 stddev:3176.46 (58.4%) stddev-sans-first:3165.35 10:17:26 INFO - PROCESS | 1668 | Values: 1327.9 1574.2 1586.4 1811.2 1941.8 7946.6 8587.8 8860.6 8894.8 8902.1 8489.0 8699.3 8706.5 8708.2 8720.0 2138.1 2402.9 2456.5 2489.5 2500.1 2492.9 2514.2 2519.7 2523.4 2528.2 2391.1 2478.3 2480.9 2481.5 2482.8 2123.0 2371.7 2445.0 2456.4 2471.1 2448.1 2448.4 2472.6 2475.0 2499.7 8580.1 8726.9 8739.2 8742.1 8757.1 5300.0 5471.6 5476.0 5492.5 5512.1 3582.3 3598.2 3653.9 3659.9 3670.7 1046.7 1053.4 1059.0 1070.9 1072.4 11759.3 11765.9 11776.0 11784.5 11786.6 4720.9 4724.6 4788.0 4906.9 4953.5 9858.6 9901.6 9904.2 9909.0 9923.1 5433.1 5433.6 5439.8 5448.1 5450.3 4416.7 4595.7 4826.6 4948.5 4960.3 3781.9 3965.3 3971.8 4095.7 4124.5 1343.1 1348.6 1348.9 1361.3 1366.4 1312.8 1339.6 1380.5 1381.7 1383.2 8094.2 8109.7 8118.0 8121.0 8445.4 1171.5 1176.0 1177.7 1192.3 1203.9 5370.0 6143.7 6325.6 6345.6 6350.4 9823.6 10593.3 10628.7 10751.3 10780.9 10265.5 10805.2 10828.2 10912.5 10982.7 8001.4 8156.0 8187.2 8255.0 8265.5 8025.5 8149.8 8236.3 8264.9 8267.5 9630.1 9776.6 9801.6 9830.8 9903.6 9892.2 9917.4 10196.8 10258.4 10296.5 6837.5 7085.7 7418.7 7531.8 7635.3 8250.3 8310.9 8342.6 8344.2 8353.3 7213.5 7291.7 7350.8 7538.7 7542.4 7199.6 7232.1 7239.3 7259.0 7394.8 7621.2 7703.8 7734.8 7742.4 7788.3 6849.8 6953.8 6991.5 6998.1 7039.3 7032.2 7230.7 7234.1 7243.7 7248.8 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5006.95 Median:5694.82 stddev:1572.02 (27.6%) stddev-sans-first:1535.92 10:17:26 INFO - PROCESS | 1668 | Values: 282.8 322.3 325.5 331.1 331.8 4709.0 5303.2 5568.0 5741.9 5791.5 4858.5 5782.2 5826.9 5846.0 5849.6 4088.6 4202.4 4312.1 4452.2 4470.8 3849.7 4430.6 4453.2 4465.2 4501.9 3598.9 4431.7 4444.0 4444.4 4455.6 4179.7 4210.6 4346.8 4446.6 4460.4 3337.5 3839.5 3848.8 3849.7 3852.0 5596.8 5603.5 5628.3 5658.5 5662.3 4038.6 4233.8 4982.6 5120.8 5125.3 5657.6 5700.0 6116.9 6174.4 6217.4 3808.6 4146.4 4156.8 4175.5 4178.3 6335.6 6495.9 6537.6 6572.4 6634.4 4078.4 4090.2 4095.3 4098.2 4111.0 4153.5 4156.3 4170.2 4180.2 4182.7 4715.6 4917.3 4920.1 5040.3 5062.2 4994.7 5911.6 6313.2 6316.6 6368.0 1455.1 1473.9 1480.3 1482.1 1485.7 922.7 967.6 979.9 981.2 984.2 5749.9 5773.8 5795.9 5798.5 5964.5 5282.6 5689.7 6080.9 6418.4 6502.9 4843.6 5766.8 5899.4 5902.2 5907.7 3099.7 3430.8 3437.6 3444.6 3464.4 6444.3 6735.4 6761.8 6786.0 6810.0 5187.3 6152.2 6571.5 6678.4 6728.0 5246.1 6459.6 6700.8 6701.9 6713.3 6123.7 6451.3 6459.8 6465.9 6480.5 5231.6 5705.7 6241.7 6362.6 6366.5 5904.1 6657.5 6692.8 6720.4 6728.3 3961.9 4119.9 4187.8 4212.3 4234.2 6379.5 6415.5 6426.4 6436.2 6462.0 5916.0 6043.9 6096.5 6231.3 6242.5 5446.5 5826.3 5921.9 6165.6 6227.3 5016.6 6013.1 6059.4 6094.2 6095.6 4720.8 5735.6 6180.5 6197.6 6201.6 5579.7 6054.1 6102.5 6105.5 6127.4 10:17:26 INFO - PROCESS | 1668 | 10:17:26 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17126.98 Median:32430.04 stddev:23130.59 (71.3%) stddev-sans-first:23162.43 10:17:26 INFO - PROCESS | 1668 | Values: 658.5 725.6 739.9 749.0 764.1 14699.7 15155.8 17146.1 17928.5 17940.7 16280.3 16316.8 16382.6 16399.4 16418.3 728.4 912.4 933.7 936.5 937.1 739.9 898.1 919.9 920.7 922.1 963.9 973.8 974.6 975.4 982.3 755.0 943.9 970.3 971.3 981.1 704.7 707.1 707.8 710.9 716.0 15611.0 15696.7 15723.7 15734.7 15737.0 11886.2 12362.6 12449.8 12667.9 12762.8 9891.1 10282.6 10371.8 10734.2 10901.0 3432.8 3482.5 3528.1 3532.6 3595.3 88274.6 89404.0 89792.7 89819.6 90894.0 9566.8 9581.2 9818.2 9867.0 10019.6 21163.5 21374.7 21378.7 21383.3 21384.4 7475.7 7576.5 7653.5 7666.3 7681.4 3974.5 4129.8 4194.7 4217.1 4237.5 3420.8 3542.9 3551.2 3552.4 3553.7 540.7 634.3 649.1 650.0 652.7 540.5 560.6 583.3 608.9 627.7 5938.7 7837.8 7953.7 7973.0 8398.8 500.5 531.4 537.0 604.5 610.8 3750.2 3792.5 3814.8 3868.2 3875.4 69559.0 72174.6 72288.6 72466.0 80589.8 64605.0 66167.7 71149.0 71185.6 72148.0 46684.0 47148.5 62866.7 63632.7 63943.7 7910.6 7949.0 7978.7 8148.3 8280.3 41758.4 42474.6 42493.0 42601.8 43691.6 58921.4 60980.4 61106.8 61353.0 61426.4 10784.4 10860.1 10914.8 11227.9 11682.5 11910.8 11951.2 11953.4 12198.5 12239.6 9637.7 10002.9 11569.6 11630.0 11689.8 11257.9 11387.3 11498.3 11727.2 11778.6 11406.4 11543.4 11612.4 11664.8 11706.8 9490.8 9608.1 9641.6 10003.9 10057.4 9197.9 9448.5 9574.9 9745.2 9807.3 10:17:26 INFO - PROCESS | 1668 | -------- Summary: end -------- 10:17:26 INFO - PROCESS | 1668 | 10:17:27 INFO - TEST-INFO | 1668: exit 0 10:17:27 INFO - TEST-OK | dromaeo_css | took 1115264ms 10:17:27 INFO - TEST-START | kraken 10:17:27 INFO - operating with platform_type : mac_ 10:17:27 INFO - Initialising browser for kraken test... 10:17:27 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp9t1KBN/profile http://localhost:49270/getInfo.html) 10:17:29 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 10:17:29 INFO - PROCESS | 1674 | colorDepth:24 10:17:29 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 10:17:29 INFO - PROCESS | 1674 | __metrics 10:17:29 INFO - PROCESS | 1674 | 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" 10:17:29 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:17:30 INFO - TEST-INFO | 1674: exit 0 10:17:30 INFO - Browser initialized. 10:17:30 INFO - Running cycle 1/1 for kraken test... 10:17:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp9t1KBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:42 INFO - PROCESS | 1676 | RSS: Main: 237891584 10:17:42 INFO - PROCESS | 1676 | 10:17:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:45 INFO - PROCESS | 1676 | RSS: Main: 286941184 10:17:45 INFO - PROCESS | 1676 | 10:17:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:17:49 INFO - PROCESS | 1676 | RSS: Main: 299028480 10:17:49 INFO - PROCESS | 1676 | 10:17:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:17:53 INFO - PROCESS | 1676 | RSS: Main: 387792896 10:17:53 INFO - PROCESS | 1676 | 10:17:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:17:55 INFO - PROCESS | 1676 | RSS: Main: 288145408 10:17:55 INFO - PROCESS | 1676 | 10:17:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:58 INFO - PROCESS | 1676 | RSS: Main: 292077568 10:17:58 INFO - PROCESS | 1676 | 10:18:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:02 INFO - PROCESS | 1676 | RSS: Main: 328863744 10:18:02 INFO - PROCESS | 1676 | 10:18:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:05 INFO - PROCESS | 1676 | RSS: Main: 330952704 10:18:05 INFO - PROCESS | 1676 | 10:18:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:18:09 INFO - PROCESS | 1676 | RSS: Main: 330190848 10:18:09 INFO - PROCESS | 1676 | 10:18:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:11 INFO - PROCESS | 1676 | RSS: Main: 320106496 10:18:11 INFO - PROCESS | 1676 | 10:18:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:13 INFO - PROCESS | 1676 | RSS: Main: 326209536 10:18:13 INFO - PROCESS | 1676 | 10:18:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:16 INFO - PROCESS | 1676 | RSS: Main: 329801728 10:18:16 INFO - PROCESS | 1676 | 10:18:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:20 INFO - PROCESS | 1676 | RSS: Main: 332144640 10:18:20 INFO - PROCESS | 1676 | 10:18:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:23 INFO - PROCESS | 1676 | RSS: Main: 332328960 10:18:23 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:18:25 INFO - PROCESS | 1676 | RSS: Main: 396210176 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | __start_tp_report 10:18:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 10:18:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 10:18:25 INFO - PROCESS | 1676 | |i|pagename|runs| 10:18:25 INFO - PROCESS | 1676 | |0;ai-astar;115;109;112;113;113;114;119;112;114;115 10:18:25 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;121;145;169;120;143;142;143;203;123 10:18:25 INFO - PROCESS | 1676 | |2;audio-dft;186;187;186;192;187;188;182;185;187;184 10:18:25 INFO - PROCESS | 1676 | |3;audio-fft;76;74;79;151;57;73;75;97;144;73 10:18:25 INFO - PROCESS | 1676 | |4;audio-oscillator;89;92;172;113;100;81;122;79;76;120 10:18:25 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;92;120;71;117;129;122;87;89;85 10:18:25 INFO - PROCESS | 1676 | |6;imaging-darkroom;95;95;96;96;94;96;95;95;95;95 10:18:25 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;90;88;86;88;87;88;86;84;87 10:18:25 INFO - PROCESS | 1676 | |8;json-parse-financial;55;56;54;55;55;55;54;68;56;53 10:18:25 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;65;74;82;71;69;67;68;73;68 10:18:25 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;83;86;85;84;84;84;83;85;86;86 10:18:25 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;145;146;150;163;166;142;144;142;225;143 10:18:25 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;174;172;170;184;174;171;172;169;170;168 10:18:25 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;70;69;68;71;68;68;60;87;91 10:18:25 INFO - PROCESS | 1676 | __end_tp_report 10:18:25 INFO - PROCESS | 1676 | __start_cc_report 10:18:25 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1909 10:18:25 INFO - PROCESS | 1676 | __end_cc_report 10:18:25 INFO - PROCESS | 1676 | __startTimestamp1460481505704__endTimestamp 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | ------- Summary: start ------- 10:18:25 INFO - PROCESS | 1676 | Number of tests: 14 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.59 (2.3%) stddev-sans-first:2.70 10:18:25 INFO - PROCESS | 1676 | Values: 115.0 109.0 112.0 113.0 113.0 114.0 119.0 112.0 114.0 115.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:144.00 stddev:25.26 (17.5%) stddev-sans-first:26.55 10:18:25 INFO - PROCESS | 1676 | Values: 156.0 121.0 145.0 169.0 120.0 143.0 142.0 143.0 203.0 123.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:186.40 Median:187.00 stddev:2.63 (1.4%) stddev-sans-first:2.79 10:18:25 INFO - PROCESS | 1676 | Values: 186.0 187.0 186.0 192.0 187.0 188.0 182.0 185.0 187.0 184.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:89.90 Median:74.50 stddev:31.89 (42.8%) stddev-sans-first:33.42 10:18:25 INFO - PROCESS | 1676 | Values: 76.0 74.0 79.0 151.0 57.0 73.0 75.0 97.0 144.0 73.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:77.50 stddev:29.07 (37.5%) stddev-sans-first:30.30 10:18:25 INFO - PROCESS | 1676 | Values: 89.0 92.0 172.0 113.0 100.0 81.0 122.0 79.0 76.0 120.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:86.00 stddev:19.94 (23.2%) stddev-sans-first:20.67 10:18:25 INFO - PROCESS | 1676 | Values: 88.0 92.0 120.0 71.0 117.0 129.0 122.0 87.0 89.0 85.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:18:25 INFO - PROCESS | 1676 | Values: 95.0 95.0 96.0 96.0 94.0 96.0 95.0 95.0 95.0 95.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.50 stddev:1.60 (1.8%) stddev-sans-first:1.69 10:18:25 INFO - PROCESS | 1676 | Values: 87.0 90.0 88.0 86.0 88.0 87.0 88.0 86.0 84.0 87.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:4.28 (7.8%) stddev-sans-first:4.52 10:18:25 INFO - PROCESS | 1676 | Values: 55.0 56.0 54.0 55.0 55.0 55.0 54.0 68.0 56.0 53.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:5.55 (7.9%) stddev-sans-first:5.09 10:18:25 INFO - PROCESS | 1676 | Values: 62.0 65.0 74.0 82.0 71.0 69.0 67.0 68.0 73.0 68.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 10:18:25 INFO - PROCESS | 1676 | Values: 83.0 86.0 85.0 84.0 84.0 84.0 83.0 85.0 86.0 86.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:148.00 stddev:25.54 (17.3%) stddev-sans-first:26.74 10:18:25 INFO - PROCESS | 1676 | Values: 145.0 146.0 150.0 163.0 166.0 142.0 144.0 142.0 225.0 143.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:4.53 (2.6%) stddev-sans-first:4.76 10:18:25 INFO - PROCESS | 1676 | Values: 174.0 172.0 170.0 184.0 174.0 171.0 172.0 169.0 170.0 168.0 10:18:25 INFO - PROCESS | 1676 | 10:18:25 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.50 stddev:9.43 (13.6%) stddev-sans-first:9.94 10:18:25 INFO - PROCESS | 1676 | Values: 69.0 70.0 69.0 68.0 71.0 68.0 68.0 60.0 87.0 91.0 10:18:25 INFO - PROCESS | 1676 | -------- Summary: end -------- 10:18:25 INFO - PROCESS | 1676 | 10:18:26 INFO - TEST-INFO | 1676: exit 0 10:18:26 INFO - TEST-OK | kraken | took 59275ms 10:18:26 INFO - SUITE-END | took 1174s 10:18:26 INFO - Completed test suite (00:19:34) 10:18:26 INFO - javascript benchmark 10:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.2534842334685, 3430.365382404254, 3473.1664400543877, 3474.6004209515904, 3509.0876372143234, 5494.945050549493, 5601.3558440779325, 5661.348944871341, 5662.971685141579, 5688.00459919514, 5583.4974852263285, 5677.630953987988, 5716.7141642917795, 5718.7426565804535, 5751.741171647275, 5086.160783470723, 5116.565091967187, 5170.25031370453, 5184.611154163434, 5278.181881808326, 5260.263563101169, 5262.473752624745, 5309.0709125903, 5335.733213339317, 5367.731613419313, 5075.593952483811, 5126.92309615356, 5167.457416971201, 5242.947570524284, 5256.684598924038, 4260.744355338689, 5175.560077393426, 5192.039472697563, 5198.40218374888, 5201.193814958688, 5111.284420181178, 5169.508896654849, 5201.505856943584, 5203.60972927032, 5223.869403264911, 5448.782048718046, 5550.4449555044175, 5577.274954255961, 5589.944100559023, 5608.10270356741, 6159.969200154015, 6203.379662033761, 6212.471939885115, 6226.128342032119, 6236.781712640081, 6190.473809726179, 6199.256089269316, 6222.066689996536, 6239.750409983595, 6242.438180563726, 5485.6982865942355, 5592.189132575753, 5731.799387021434, 5793.826185214451, 5796.652200867919, 6191.473724733358, 6205.782797602063, 6215.0, 6219.689015549205, 6222.968885155546, 6050.909236361458, 6081.604695694854, 6110.938890611126, 6121.877562448726, 6130.386961303834, 6026.728797204137, 6126.700892189639, 6126.884121540821, 6225.782097626561, 6232.844178895473, 6131.152125279649, 6144.941444616104, 6150.231221097363, 6152.292486364126, 6157.630542167484, 6152.969235153795, 6180.536459765535, 6183.072539119078, 6199.3490683478485, 6211.068339749074, 4778.1399348117675, 4858.708477491291, 4863.392075990501, 4894.779734911866, 4969.577585905238, 4343.891402714958, 4432.977835110803, 4440.4671439427475, 4446.066326071496, 4455.487618923865, 5591.245181900392, 5603.467670571289, 5604.915926261027, 5612.663240205601, 5612.747426365823, 6129.542179248731, 6132.63204207749, 6144.617461071312, 6148.339948214047, 6224.62652240867, 5655.688937108416, 5660.688662123541, 5661.320641523043, 5679.829605111853, 5686.630369026, 5315.574754019669, 5351.384590772033, 5364.839054828361, 5388.38033626138, 5437.32033495813, 6129.603311142676, 6172.567920245539, 6192.535559832941, 6234.314225435108, 6234.812955611339, 6182.196314479089, 6198.845028874314, 6202.472789812917, 6204.5036397089025, 6206.813795586139, 6231.283402408781, 6242.469390101892, 6252.562320637512, 6259.374062593704, 6260.060990851409, 5921.437463440966, 6103.03463616155, 6128.540359473147, 6145.709401025656, 6186.81439556814, 5166.793328266827, 6018.789342372996, 6161.815145545641, 6168.0, 6201.534884883742, 5053.0, 5812.128180772918, 6107.267127944675, 6109.266887973472, 6118.051701986199, 4706.764661766966, 6033.577649564664, 6081.331053584191, 6108.08378743192, 6122.38776122402, 5865.266841644794, 5911.113333000085, 5912.586118971631, 5915.58590898633, 5919.4968427684125, 5861.062230043343, 5930.021546444961, 6067.362926892789, 6078.118672792332, 6080.300765411857, 5933.643981361132, 5951.672658003678, 5988.101784732325, 6011.489023433057, 6042.516598672008], "value": 5640.642851456636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.21789335476683, 515.4819406496471, 533.5624787674107, 544.8855740294539, 583.7536858806452, 25816.483670326583, 29385.559216611768, 29391.85304073482, 29443.852780736066, 29542.81828726851, 29547.704522954766, 38704.419433708514, 39967.20065598686, 40091.0, 40157.19685606286, 9377.812443751138, 9603.903960960406, 9610.135087842093, 9611.807763844754, 9614.0, 8451.154884511561, 9428.151466368026, 9608.951955240214, 9629.711108666716, 9636.951815240915, 8585.871211931826, 11399.145064120183, 11753.764924701502, 11767.470463829106, 11770.823437648442, 11379.317240965527, 11481.540738370455, 11495.827562586568, 11499.77000459986, 11500.309981401142, 8439.156084391512, 11240.718982025515, 11289.98390144891, 11452.656420307405, 11610.767784644344, 37048.629513704785, 37569.43645845314, 37595.62404375976, 37674.623253767386, 37724.43413348802, 3080.2299425143715, 3264.5103234514777, 3314.983425082859, 3409.641987591292, 3658.762180458262, 26882.0, 27466.0, 28037.859810700815, 28335.0, 28359.85820070907, 2235.0724449353497, 2655.6016597510334, 2711.3763834318215, 2764.7235276472193, 2826.0815235048485, 464000.0, 464163.0, 465575.9999999966, 466015.0, 467356.0, 57913.71043144757, 58429.0, 58501.0, 58509.70745146332, 58551.0, 60684.0, 60997.69501152466, 61078.38921610727, 61123.970743364196, 61131.0, 15900.0, 16325.0, 16375.017498950101, 16376.918115409586, 16395.262213200436, 10672.30630009047, 12776.169548979287, 12818.230906145474, 12908.0, 12922.741545169043, 13593.52422665202, 13990.86009139916, 15027.09837409759, 15141.394344226328, 15523.689526209413, 6772.187337519529, 6910.997905303703, 6997.230304666585, 7022.508424410242, 7046.718131274692, 906.5014242166782, 953.7234202081319, 956.067833861979, 1013.4729940430934, 1051.7370657335666, 23587.29238122859, 28518.714812851606, 29224.26939326534, 29285.7071429283, 29445.411091778475, 1013.1995723378449, 1111.3998440841856, 1134.5461815273957, 1173.5540494611994, 1218.2933898338943, 13639.181649100887, 13642.863571364358, 13909.234992075331, 13967.511137110152, 14158.50445234412, 594173.0, 598065.0, 600060.0, 602317.0, 604381.0, 52326.0, 54063.0, 54259.6435089118, 54361.0, 54365.72817135889, 1304.562971404571, 1347.1378317876568, 1348.2315080404076, 1448.1311213271952, 1468.9118652880861, 23562.764372356058, 26986.0080665233, 27949.0, 28619.713802862538, 29661.85169074141, 46807.553282438115, 47202.0, 47707.76146119247, 47771.0, 47877.0, 355307.22346389137, 357798.0, 359101.0, 359706.0, 360108.0, 22255.77744222537, 23902.282931512083, 24324.0, 24534.754652453248, 25236.74763252344, 38387.0, 38735.0, 38919.6108038916, 39010.41484377794, 39373.409398859614, 32168.67831321657, 33158.5026224602, 33215.681771662355, 33998.150046249044, 34079.659203407646, 28699.867520752967, 32396.514052289705, 32643.836780816895, 33025.66974330226, 33142.17144571405, 33535.83232083824, 33963.97428299743, 34727.65272347345, 34817.69231922963, 34878.0, 27914.02300919458, 30019.249518762204, 30115.0, 30255.546166807955, 30676.079717608507, 17646.382376616755, 20574.382768516967, 20887.8955605221, 21321.36035918925, 21361.89319053395], "value": 18502.21986800426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.45644781976955, 395.7486995757695, 396.3183324681548, 398.5357059026235, 410.7371282379278, 18760.249590016418, 19327.806721932775, 19620.117094730736, 20336.38990830274, 20384.796152038474, 19248.615027699438, 19483.123259453325, 19753.604927901433, 20476.8976155119, 20515.07682154303, 5672.546196304285, 5756.8272951811405, 5992.940070599304, 5997.580169388145, 6001.519878409738, 5913.0, 5928.6739229342365, 5944.256967879015, 5966.999999999978, 5983.461488466037, 6582.703778329987, 6605.801825945229, 6609.074729537869, 6610.8677826443445, 6615.867682646368, 6087.299960504554, 6115.602485838406, 6288.842778930518, 6589.472842172615, 6618.569792963442, 5645.8023969161295, 5820.272465941757, 5845.473907348317, 5846.9707651461895, 5852.6488410695065, 13692.589222323346, 16053.759193612104, 20343.5931281375, 24553.281270311087, 25089.749102508922, 2055.1162999910034, 2055.126571207246, 2127.5000374911883, 2164.286284209688, 2213.380253529014, 8988.101189881025, 9698.806023879482, 9787.706368808947, 9817.067378599022, 10331.380117192992, 1706.1810331041045, 1707.9573010674708, 1710.7604935309066, 1781.980541249269, 1804.124999375302, 83273.0, 102058.0, 119980.0, 123241.0, 126107.0, 8780.165884240987, 9504.667336643184, 11506.654800356002, 11598.478068486938, 11686.941565292289, 15028.0, 15070.397184112731, 15121.470748523969, 15136.848631513763, 15142.848571514363, 8409.95795021021, 8634.618461046202, 8668.056034504412, 8751.081136480705, 8758.912410875937, 8538.701145460003, 8565.52889591066, 8578.699745509002, 8678.349123815738, 8684.175003374668, 4535.29702896045, 4634.25851863707, 4638.721676699409, 4662.860114196579, 4707.270373092176, 1893.4887580353502, 1945.114972687424, 1950.1224448998007, 1950.658634738915, 1953.5897461532952, 857.7126662567985, 899.5187574647532, 933.2440723014245, 984.9704508864745, 1000.309786247487, 17504.5623859402, 19421.902890485457, 20217.89891050535, 20450.23921770542, 20487.18051277962, 809.9757007289791, 927.3971918253189, 939.8496240601471, 943.4150826487621, 968.5544649461327, 10492.527836247387, 10776.568937242422, 10777.976092271221, 10778.407187604756, 10808.189385796097, 633942.0, 639570.0, 641718.0, 653024.7348763226, 658990.0, 86349.0, 102074.0, 111275.0, 117367.0, 122992.0, 1011.2668315471371, 1031.515187861704, 1052.889446608095, 1064.8189807732704, 1067.9145668346514, 13555.39000744949, 16540.917295413445, 18018.90990545039, 18124.365647202285, 18422.907885461023, 33706.66293337035, 46764.53235467602, 48609.756951216434, 49359.51921442363, 50676.0, 71372.28627713864, 73274.63362683152, 73420.0, 73747.63126184334, 75242.0, 5968.552358573038, 6963.79108626742, 7473.551586904803, 7979.92020079815, 8413.621387037476, 9853.458059806493, 11539.480723367637, 12733.981281497643, 12785.872141278469, 13183.802242966554, 10604.575816967543, 10994.780104398027, 11010.779784404427, 11167.609133680282, 11263.549458021587, 9004.279657627243, 10326.070653641209, 10642.988916052962, 10756.0, 10905.073068789241, 10249.846252306072, 10410.791784164123, 11056.170787190831, 11435.085193184692, 11604.013658838756, 6961.79114626562, 6998.475114366544, 7138.607376594337, 7182.640867956686, 7254.528455650366, 8864.73405797827, 9993.60025598997, 10029.04724051214, 10172.949135254275, 10215.59137634516], "value": 9272.533106042196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.9269640169787, 1574.2364952997793, 1586.373382513907, 1811.175914958693, 1941.8446524278058, 7946.6026698665055, 8587.828243435135, 8860.556972151382, 8894.82210355794, 8902.065283145266, 8489.023762267341, 8699.260562852149, 8706.477611343324, 8708.172723591264, 8720.040795512488, 2138.1447421031557, 2402.8798560072014, 2456.5455390752722, 2489.4772097859473, 2500.099964012954, 2492.8504289742673, 2514.245726282117, 2519.722830488645, 2523.3943853475125, 2528.2415275417393, 2391.1272385579314, 2478.30607429919, 2480.937976550583, 2481.5161043596504, 2482.7641374069435, 2122.9787702123012, 2371.703537057868, 2444.9511009779794, 2456.3736247257016, 2471.122751423237, 2448.069733501276, 2448.3879030242438, 2472.629105634151, 2474.9752502474926, 2499.662545556363, 8580.141985801432, 8726.86909696355, 8739.21347078766, 8742.08208138149, 8757.124287571256, 5300.0, 5471.5896307776675, 5475.972620136874, 5492.505674489275, 5512.062949298629, 3582.301451217014, 3598.226381328027, 3653.8538458461894, 3659.8536058557625, 3670.6696397324367, 1046.7016900183487, 1053.4311471805215, 1058.9523471443804, 1070.892910708923, 1072.394097335011, 11759.294442333401, 11765.941170294094, 11775.999040081604, 11784.528618855236, 11786.646400607995, 4720.8743812184075, 4724.622030237572, 4787.952120478821, 4906.9263961040615, 4953.455119936804, 9858.570507276405, 9901.554430050664, 9904.15814655748, 9908.950455247821, 9923.057309555581, 5433.0763770159165, 5433.565314774809, 5439.782408703608, 5448.101063324586, 5450.345958485007, 4416.734995900256, 4595.6783025187915, 4826.61387089032, 4948.480409556944, 4960.280759289955, 3781.9243615128094, 3965.3457179565626, 3971.781552014667, 4095.6928230382246, 4124.463819703419, 1343.147101590497, 1348.6089034179977, 1348.9123206991515, 1361.3125371687236, 1366.3782978744648, 1312.783390740536, 1339.604816579092, 1380.5375199308344, 1381.6891199480237, 1383.197745307719, 8094.190580941977, 8109.675612975415, 8118.02583689961, 8121.0, 8445.366597505212, 1171.496256609666, 1175.9647210583696, 1177.7408970026581, 1192.266755945105, 1203.8976686981705, 5370.0, 6143.723532441051, 6325.620462772248, 6345.555811093272, 6350.396712312323, 9823.557939892722, 10593.311434756715, 10628.681139565826, 10751.301165424222, 10780.94609526963, 10265.538050787733, 10805.189610779224, 10828.24202305831, 10912.454377281105, 10982.670519884416, 8001.4398992071165, 8155.959220203979, 8187.1812818718845, 8255.0, 8265.46274492156, 8025.518468891885, 8149.79625509367, 8236.258736713724, 8264.876026859481, 8267.503949763033, 9630.085141911508, 9776.608935642495, 9801.558929848317, 9830.75423114428, 9903.603855845686, 9892.208623310262, 9917.355371900803, 10196.847047294148, 10258.384496930208, 10296.536655850356, 6837.521373503807, 7085.716571337089, 7418.703251869865, 7531.8117047074265, 7635.274648908345, 8250.339972802281, 8310.87533686983, 8342.624581893708, 8344.207300306462, 8353.331733461187, 7213.531120477152, 7291.708331666886, 7350.77947661571, 7538.698452061856, 7542.434317426325, 7199.640017998974, 7232.0959880015, 7239.348458638748, 7258.963705181441, 7394.815129621587, 7621.237876212334, 7703.768886933401, 7734.7679569613, 7742.38060955111, 7788.260115289038, 6849.760258390932, 6953.756618518328, 6991.545549539263, 6998.125234345707, 7039.296070393125, 7032.191298000591, 7230.74692385764, 7234.095738032746, 7243.7464688735645, 7248.818779530343], "value": 4970.14584347518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7695428225996, 322.30382374071996, 325.5279844225872, 331.1159204922854, 331.8281845322365, 4709.0, 5303.151495760679, 5568.0, 5741.913871291928, 5791.478766910977, 4858.538438848313, 5782.190493330926, 5826.941730582693, 5845.970770146154, 5849.619774714641, 4088.632023117919, 4202.415514458601, 4312.116016216683, 4452.220861349267, 4470.776461176944, 3849.7305188636806, 4430.623397011242, 4453.170273564731, 4465.151621191963, 4501.932471012938, 3598.892033239007, 4431.711938723973, 4443.955560444403, 4444.400005999181, 4455.598996090352, 4179.665626749853, 4210.642095421893, 4346.826126954918, 4446.622037126848, 4460.397846290758, 3337.499375093731, 3839.462475253467, 3848.826802793881, 3849.672777813861, 3851.9984803951174, 5596.832095037155, 5603.467670571289, 5628.32460104786, 5658.519025882805, 5662.263905692274, 4038.6365227129404, 4233.788310584489, 4982.60139188864, 5120.769565369567, 5125.282460455539, 5657.632253903483, 5699.953033346329, 6116.938830611726, 6174.382561743834, 6217.378262173792, 3808.5810560838286, 4146.357314616239, 4156.833726650931, 4175.457190565237, 4178.26880295947, 6335.588186767845, 6495.870082598369, 6537.5750576212395, 6572.441342485942, 6634.369734875179, 4078.3882417636996, 4090.1615168890307, 4095.32427149517, 4098.180363927227, 4110.958890411118, 4153.466385504839, 4156.334986402161, 4170.207660544487, 4180.163967206571, 4182.707210495236, 4715.646326525524, 4917.262410638361, 4920.114379411741, 5040.2691609716385, 5062.240663900445, 4994.725290109006, 5911.615744976649, 6313.210848643919, 6316.62100273985, 6368.0, 1455.0978393396163, 1473.8599833015846, 1480.3190532355238, 1482.1181397068726, 1485.717713634406, 922.6632279218171, 967.5984466446487, 979.941663003954, 981.2052237687496, 984.1929617713549, 5749.85625359361, 5773.826785196451, 5795.94204057954, 5798.5071268941765, 5964.463198312173, 5282.603804714662, 5689.687067211343, 6080.9391906081255, 6418.422341989243, 6502.902456463157, 4843.564079232886, 5766.826995190151, 5899.439553242435, 5902.2327097477055, 5907.734151963086, 3099.7365223956217, 3430.7598468107494, 3437.553118094682, 3444.569428821397, 3464.359093567698, 6444.2589102252905, 6735.360140786617, 6761.797146085625, 6786.0, 6810.0, 5187.273781670569, 6152.16945712332, 6571.474282057424, 6678.362046991411, 6728.0, 5246.091661711973, 6459.612423254526, 6700.798976030727, 6701.932980670131, 6713.328667133248, 6123.663198524124, 6451.3226111257645, 6459.838504037437, 6465.903011454738, 6480.481561474976, 5231.55531779803, 5705.743241554057, 6241.658043520665, 6362.586431881913, 6366.490680745436, 5904.114382842608, 6657.535342224703, 6692.83267918306, 6720.361565651256, 6728.3271672832325, 3961.8613348532663, 4119.949412899691, 4187.7696726679105, 4212.304969679968, 4234.153169366077, 6379.457746091634, 6415.454686351713, 6426.4216220540375, 6436.195475565554, 6461.967690161519, 5916.0, 6043.909341359795, 6096.481799047131, 6231.345708700521, 6242.53181011435, 5446.50981411659, 5826.329972053268, 5921.851953701192, 6165.599236049642, 6227.283862355887, 5016.648834581544, 6013.067974463965, 6059.363766804422, 6094.202210347869, 6095.573309868444, 4720.834770783006, 5735.59133040634, 6180.536459765445, 6197.597156185014, 6201.627902325875, 5579.721013949367, 6054.091886217103, 6102.491067636039, 6105.511559075175, 6127.387261273837], "value": 4502.636070651411, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.4995403493346, 725.6263024542359, 739.8594267089253, 749.0337464670575, 764.0602059466859, 14699.706005879889, 15155.772663410044, 17146.142692865353, 17928.462146135636, 17940.730889036677, 16280.26738796754, 16316.75524867125, 16382.590435239124, 16399.4260200893, 16418.26117824698, 728.3735987051132, 912.3522299167582, 933.6872147830485, 936.4896131608256, 937.0535758883509, 739.9408047356226, 898.0794685447436, 919.9494027828467, 920.6685593186447, 922.0963455813308, 963.9421634701905, 973.8295798235281, 974.6491263145263, 975.3660120921387, 982.3123813330661, 754.9886751698729, 943.9244860411219, 970.3110791338123, 971.2958105373583, 981.1022914033687, 704.6828926982878, 707.1231672725835, 707.7558242406361, 710.9466789990771, 716.0333549707905, 15611.0, 15696.686066278724, 15723.685526289524, 15734.68530629381, 15736.977096488692, 11886.227395219283, 12362.567310144103, 12449.75100497985, 12667.873321266761, 12762.80855787164, 9891.109800117953, 10282.61184740058, 10371.792564148675, 10734.248602597821, 10901.0, 3432.7768695034742, 3482.547268855058, 3528.1003344147334, 3532.5584301962253, 3595.2989167112423, 88274.5586272071, 89404.0, 89792.65311020405, 89819.55090224507, 90894.0, 9566.760830979281, 9581.185599224144, 9818.214542836557, 9866.963968783319, 10019.649312274181, 21163.470913226985, 21374.679379809317, 21378.679319810217, 21383.25158619441, 21384.358469245948, 7475.7009719610605, 7576.469647124759, 7653.464257501922, 7666.271704188093, 7681.3854891608535, 3974.4833171687496, 4129.772862492532, 4194.748315101104, 4217.135487225111, 4237.470316210473, 3420.7776494528275, 3542.91142721434, 3551.236484155919, 3552.4493703476, 3553.6979356754964, 540.7053156029973, 634.3497914637534, 649.1139594453537, 650.0444346810182, 652.7389044382285, 540.5054375246606, 560.6243816642859, 583.2563481561043, 608.9117078023751, 627.6704730016686, 5938.673372964442, 7837.843243135106, 7953.721619743281, 7973.035450627139, 8398.832023359499, 500.51950127876916, 531.4366771222517, 536.9758360873692, 604.5163868904858, 610.8350745298744, 3750.2124553843996, 3792.488014118059, 3814.8092595370676, 3868.2456920900154, 3875.4380614811257, 69558.95661565081, 72174.63912680403, 72288.63855680688, 72466.0, 80589.79115313276, 64605.0, 66167.66916165389, 71149.0, 71185.64407177932, 72148.0, 46684.0, 47148.5285147151, 62866.68566657137, 63632.681836591444, 63943.680281598296, 7910.5649189295145, 7949.0, 7978.680852765824, 8148.307393871587, 8280.296174825207, 41758.37362439505, 42474.575254248295, 42493.0, 42601.786991064844, 43691.56308436875, 58921.410785893306, 60980.390196099244, 61106.77786444335, 61353.0, 61426.38573614207, 10784.406857622906, 10860.131189504662, 10914.836277456003, 11227.943860280646, 11682.532698691957, 11910.821337680116, 11951.163418560618, 11953.402329883646, 12198.451069702061, 12239.571614993432, 9637.74709287788, 10002.949985250027, 11569.595064172714, 11629.99350639697, 11689.824652630388, 11257.887421126012, 11387.259828111146, 11498.310101393943, 11727.179097463437, 11778.587749428729, 11406.429678516208, 11543.36511491876, 11612.419379030845, 11664.76670466569, 11706.824397633873, 9490.810183796148, 9608.087231712976, 9641.566129524328, 10003.899961000589, 10057.396556206359, 9197.89625244975, 9448.48033358172, 9574.90425095768, 9745.220382369534, 9807.264455166034], "value": 6804.83358655869, "unit": "score"}], "name": "dromaeo_css", "value": 7267.863957697953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 112.0, 113.0, 113.0, 114.0, 119.0, 112.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 145.0, 169.0, 120.0, 143.0, 142.0, 143.0, 203.0, 123.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 186.0, 192.0, 187.0, 188.0, 182.0, 185.0, 187.0, 184.0], "value": 186.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 79.0, 151.0, 57.0, 73.0, 75.0, 97.0, 144.0, 73.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 172.0, 113.0, 100.0, 81.0, 122.0, 79.0, 76.0, 120.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 120.0, 71.0, 117.0, 129.0, 122.0, 87.0, 89.0, 85.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 88.0, 86.0, 88.0, 87.0, 88.0, 86.0, 84.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 55.0, 55.0, 54.0, 68.0, 56.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 74.0, 82.0, 71.0, 69.0, 67.0, 68.0, 73.0, 68.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 85.0, 84.0, 84.0, 84.0, 83.0, 85.0, 86.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 150.0, 163.0, 166.0, 142.0, 144.0, 142.0, 225.0, 143.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 170.0, 184.0, 174.0, 171.0, 172.0, 169.0, 170.0, 168.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 71.0, 68.0, 68.0, 60.0, 87.0, 91.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1534.8, "alertThreshold": 2.0}]} 10:18:26 INFO - Return code: 0 10:18:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:26 ERROR - # TBPL SUCCESS # 10:18:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:26 INFO - 2016-04-12 10:18:26.991 screenresolution[1680:9615] starting screenresolution argv=screenresolution get 10:18:26 INFO - 2016-04-12 10:18:26.994 screenresolution[1680:9615] Display 0: 1600x1200x32@60 10:18:27 INFO - 2016-04-12 10:18:27.001 screenresolution[1681:9618] starting screenresolution argv=screenresolution list 10:18:27 INFO - Available Modes on Display 0 10:18:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:27 INFO - Intel Iris: 10:18:27 INFO - Chipset Model: Intel Iris 10:18:27 INFO - Type: GPU 10:18:27 INFO - Bus: Built-In 10:18:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:27 INFO - Vendor: Intel (0x8086) 10:18:27 INFO - Device ID: 0x0a2e 10:18:27 INFO - Revision ID: 0x0009 10:18:27 INFO - Displays: 10:18:27 INFO - Display: 10:18:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:27 INFO - Display Serial Number: 1600x1200 60 10:18:27 INFO - Main Display: Yes 10:18:27 INFO - Mirror: Off 10:18:27 INFO - Online: Yes 10:18:27 INFO - Rotation: Supported 10:18:27 INFO - Return code: 0 10:18:27 INFO - Running post-action listener: _resource_record_post_action 10:18:27 INFO - Running post-run listener: _resource_record_post_run 10:18:28 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37709312; Write bytes: 694878208; Read time: 402; Write time: 2183 10:18:28 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 389366272; Write bytes: 379533312; Read time: 28442; Write time: 724 10:18:28 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30580224; Write bytes: 295350784; Read time: 302; Write time: 1248 10:18:28 INFO - Running post-run listener: _upload_blobber_files 10:18:28 INFO - Blob upload gear active. 10:18:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:28 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 10:18:28 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'] 10:18:28 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 10:18:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:29 INFO - (blobuploader) - INFO - Done attempting. 10:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:30 INFO - (blobuploader) - INFO - Done attempting. 10:18:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:30 INFO - Return code: 0 10:18:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af5d1bf5bbd072ef65dcbc96a5e1eae51638ae559e15dc739b1afa12044a413878202293a754a78e1052b5b59804f9faab5622840dbd2e769bcefb7491b9a0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b39e70fa17c8f0bff09883b0ae8a4467f564ced0c0d7746d6ec0745e2518f805e48406d2d0874cd9d441b1dcb2d56a2a7897d120d2592643291b82d627feee5"} 10:18:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:30 INFO - Contents: 10:18:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af5d1bf5bbd072ef65dcbc96a5e1eae51638ae559e15dc739b1afa12044a413878202293a754a78e1052b5b59804f9faab5622840dbd2e769bcefb7491b9a0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b39e70fa17c8f0bff09883b0ae8a4467f564ced0c0d7746d6ec0745e2518f805e48406d2d0874cd9d441b1dcb2d56a2a7897d120d2592643291b82d627feee5"} 10:18:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:30 INFO - Copying logs to upload dir... 10:18:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.176941 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-12 10:18:30.761838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 10:18:30.762948) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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/8af5d1bf5bbd072ef65dcbc96a5e1eae51638ae559e15dc739b1afa12044a413878202293a754a78e1052b5b59804f9faab5622840dbd2e769bcefb7491b9a0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b39e70fa17c8f0bff09883b0ae8a4467f564ced0c0d7746d6ec0745e2518f805e48406d2d0874cd9d441b1dcb2d56a2a7897d120d2592643291b82d627feee5"} build_url:https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/Qi7swpcHTGqOkxmHhzu7tQ/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/8af5d1bf5bbd072ef65dcbc96a5e1eae51638ae559e15dc739b1afa12044a413878202293a754a78e1052b5b59804f9faab5622840dbd2e769bcefb7491b9a0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b39e70fa17c8f0bff09883b0ae8a4467f564ced0c0d7746d6ec0745e2518f805e48406d2d0874cd9d441b1dcb2d56a2a7897d120d2592643291b82d627feee5"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 10:18:30.859011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-12 10:18:30.865586) ========= 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.lXv2i1pCYD/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.5rV2Aa8HCE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.004714 ========= master_lag: 4.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-12 10:18:35.264835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 10:18:35.265166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 10:18:35.432180) ========= ========= Total master_lag: 10.32 =========