builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1457454944.38 results: success (0) buildid: 20160308074036 builduid: ca63c716fa00403b97b3ce9442aa7e96 revision: e330626de260b21a6ea62d741131d04715ef39a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.377890) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.378310) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.378596) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005164 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.407839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.408108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.428433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.428700) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005456 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.476053) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.476312) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.479651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.479929) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-08 08:35:44-- 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% 175M=0s 2016-03-08 08:35:44 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.684906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.685205) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.026130 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:44.736011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 08:35:44.736313) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e330626de260b21a6ea62d741131d04715ef39a1 --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 e330626de260b21a6ea62d741131d04715ef39a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-08 08:35:44,819 truncating revision to first 12 chars 2016-03-08 08:35:44,820 Setting DEBUG logging. 2016-03-08 08:35:44,820 attempt 1/10 2016-03-08 08:35:44,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e330626de260?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 08:35:45,971 unpacking tar archive at: fx-team-e330626de260/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 08:35:46.156186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:46.156536) ========= echo e330626de260b21a6ea62d741131d04715ef39a1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e330626de260b21a6ea62d741131d04715ef39a1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 e330626de260b21a6ea62d741131d04715ef39a1 program finished with exit code 0 elapsedTime=0.006313 script_repo_revision: 'e330626de260b21a6ea62d741131d04715ef39a1' ========= master_lag: 0.21 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:46.371678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:46.371980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 08:35:46.386300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-08 08:35:46.386569) ========= /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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:35:46 INFO - MultiFileLogger online at 20160308 08:35:46 in /builds/slave/test 08:35:46 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 08:35:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:46 INFO - {'append_to_log': False, 08:35:46 INFO - 'base_work_dir': '/builds/slave/test', 08:35:46 INFO - 'blob_upload_branch': 'Fx-Team', 08:35:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:46 INFO - 'branch': 'Fx-Team', 08:35:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:46 INFO - 'config_files': ('talos/mac_config.py',), 08:35:46 INFO - 'default_actions': ('clobber', 08:35:46 INFO - 'read-buildbot-config', 08:35:46 INFO - 'download-and-extract', 08:35:46 INFO - 'populate-webroot', 08:35:46 INFO - 'create-virtualenv', 08:35:46 INFO - 'install', 08:35:46 INFO - 'run-tests'), 08:35:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:46 INFO - 'download_minidump_stackwalk': True, 08:35:46 INFO - 'download_symbols': 'ondemand', 08:35:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:46 INFO - 'installer_path': 'installer.exe', 08:35:46 INFO - 'log_level': 'info', 08:35:46 INFO - 'log_name': 'talos', 08:35:46 INFO - 'log_to_console': True, 08:35:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:35:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:35:46 INFO - 'opt_config_files': (), 08:35:46 INFO - 'pip_index': False, 08:35:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:46 INFO - 'cmd': ('bash', 08:35:46 INFO - '-c', 08:35:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:46 INFO - 'enabled': True, 08:35:46 INFO - 'halt_on_failure': False, 08:35:46 INFO - 'name': 'check_screen_resolution'},), 08:35:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:46 INFO - 'cmd': ('bash', 08:35:46 INFO - '-c', 08:35:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:46 INFO - 'enabled': True, 08:35:46 INFO - 'halt_on_failure': False, 08:35:46 INFO - 'name': 'check_screen_resolution'},), 08:35:46 INFO - 'run_cmd_checks_enabled': True, 08:35:46 INFO - 'sps_profile': False, 08:35:46 INFO - 'sps_profile_interval': 0, 08:35:46 INFO - 'suite': 'dromaeojs', 08:35:46 INFO - 'system_bits': '32', 08:35:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:46 INFO - 'title': 't-yosemite-r7-0171', 08:35:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:46 INFO - 'use_talos_json': True, 08:35:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:46 INFO - 'work_dir': 'build'} 08:35:46 INFO - ##### 08:35:46 INFO - ##### Running clobber step. 08:35:46 INFO - ##### 08:35:46 INFO - Running pre-action listener: _resource_record_pre_action 08:35:46 INFO - Running main action method: clobber 08:35:46 INFO - rmtree: /builds/slave/test/build 08:35:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - ##### 08:35:48 INFO - ##### Running read-buildbot-config step. 08:35:48 INFO - ##### 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: read_buildbot_config 08:35:48 INFO - Using buildbot properties: 08:35:48 INFO - { 08:35:48 INFO - "project": "", 08:35:48 INFO - "product": "firefox", 08:35:48 INFO - "script_repo_revision": "production", 08:35:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:35:48 INFO - "repository": "", 08:35:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:35:48 INFO - "buildid": "20160308074036", 08:35:48 INFO - "pgo_build": "False", 08:35:48 INFO - "basedir": "/builds/slave/test", 08:35:48 INFO - "buildnumber": 564, 08:35:48 INFO - "slavename": "t-yosemite-r7-0171", 08:35:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:35:48 INFO - "platform": "yosemite_r7", 08:35:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:35:48 INFO - "branch": "fx-team", 08:35:48 INFO - "repo_path": "integration/fx-team", 08:35:48 INFO - "revision": "e330626de260b21a6ea62d741131d04715ef39a1", 08:35:48 INFO - "stage_platform": "macosx64", 08:35:48 INFO - "builduid": "ca63c716fa00403b97b3ce9442aa7e96", 08:35:48 INFO - "slavebuilddir": "test" 08:35:48 INFO - } 08:35:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - ##### 08:35:48 INFO - ##### Running download-and-extract step. 08:35:48 INFO - ##### 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: download_and_extract 08:35:48 INFO - mkdir: /builds/slave/test/build/tests 08:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:48 INFO - https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 08:35:49 INFO - Downloaded 1277 bytes. 08:35:49 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:35:49 INFO - Using the following test package requirements: 08:35:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:35:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:35:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:35:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'jsshell-mac.zip'], 08:35:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:35:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:35:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:35:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:35:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:35:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:35:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:35:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:35:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:35:49 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')]} 08:35:49 INFO - https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:35:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:35:50 INFO - Downloaded 17866472 bytes. 08:35:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:35:53 INFO - Return code: 0 08:35:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:53 INFO - https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:35:54 INFO - Downloaded 17866472 bytes. 08:35:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:35:58 INFO - Return code: 0 08:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:58 INFO - https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:35:59 INFO - Downloaded 10845161 bytes. 08:35:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:35:59 INFO - Return code: 0 08:35: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')]} 08:35:59 INFO - https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 08:36:02 INFO - Downloaded 110987924 bytes. 08:36:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:36:02 INFO - mkdir: /builds/slave/test/properties 08:36:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:02 INFO - Contents: 08:36:02 INFO - build_url:https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:36:03 INFO - Running post-action listener: _resource_record_post_action 08:36:03 INFO - Running post-action listener: set_extra_try_arguments 08:36:03 INFO - ##### 08:36:03 INFO - ##### Running populate-webroot step. 08:36:03 INFO - ##### 08:36:03 INFO - Running pre-action listener: _resource_record_pre_action 08:36:03 INFO - Running main action method: populate_webroot 08:36:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:03 INFO - '--tppagecycles', 08:36:03 INFO - '7'], 08:36:03 INFO - 'tests': ['tsvgm']}}, 08:36:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:36:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:36:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'tests': ['damp', 'tps']}, 08:36:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['damp', 'tps']}, 08:36:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:36:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:03 INFO - 'other': {'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'other_l64': {'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'other_nol64': {'tests': ['a11yr', 08:36:03 INFO - 'ts_paint', 08:36:03 INFO - 'tpaint', 08:36:03 INFO - 'sessionrestore', 08:36:03 INFO - 'sessionrestore_no_auto_restore', 08:36:03 INFO - 'tabpaint']}, 08:36:03 INFO - 'svgr': {'tests': ['tsvgx', 08:36:03 INFO - 'tsvgr_opacity', 08:36:03 INFO - 'tart', 08:36:03 INFO - 'tscrollx', 08:36:03 INFO - 'cart']}, 08:36:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['tsvgx', 08:36:03 INFO - 'tsvgr_opacity', 08:36:03 INFO - 'tart', 08:36:03 INFO - 'tscrollx', 08:36:03 INFO - 'cart']}, 08:36:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'tests': ['tp5o']}, 08:36:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'talos_options': ['--e10s'], 08:36:03 INFO - 'tests': ['tp5o']}, 08:36:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'talos_options': ['--xperf_path', 08:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:03 INFO - 'tests': ['tp5n']}, 08:36:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:03 INFO - 'talos_options': ['--e10s', 08:36:03 INFO - '--xperf_path', 08:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:03 INFO - 'tests': ['tp5n']}}, 08:36:03 INFO - 'talos.zip': {'path': '', 08:36:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:03 INFO - Running post-action listener: _resource_record_post_action 08:36:03 INFO - ##### 08:36:03 INFO - ##### Running create-virtualenv step. 08:36:03 INFO - ##### 08:36:03 INFO - Running pre-action listener: _resource_record_pre_action 08:36:03 INFO - Running main action method: create_virtualenv 08:36:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:03 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 08:36:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:03 INFO - Using real prefix '/tools/python27' 08:36:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:07 INFO - Installing pip.................done. 08:36:07 INFO - Return code: 0 08:36:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:07 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')]} 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 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')]} 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:07 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 08:36:07 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 08:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:07 INFO - 'HOME': '/Users/cltbld', 08:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:07 INFO - 'LOGNAME': 'cltbld', 08:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:07 INFO - 'MOZ_NO_REMOTE': '1', 08:36:07 INFO - 'NO_EM_RESTART': '1', 08:36:07 INFO - 'PAGER': '/bin/cat', 08:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:07 INFO - 'PWD': '/builds/slave/test', 08:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:07 INFO - 'SHELL': '/bin/bash', 08:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:07 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:07 INFO - 'USER': 'cltbld', 08:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:07 INFO - 'XPC_FLAGS': '0x0', 08:36:07 INFO - 'XPC_SERVICE_NAME': '0', 08:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:07 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 08:36:07 INFO - Cleaning up... 08:36:07 INFO - Return code: 0 08:36:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:36:07 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')]} 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 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')]} 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:07 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 08:36:07 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 08:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:07 INFO - 'HOME': '/Users/cltbld', 08:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:07 INFO - 'LOGNAME': 'cltbld', 08:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:07 INFO - 'MOZ_NO_REMOTE': '1', 08:36:07 INFO - 'NO_EM_RESTART': '1', 08:36:07 INFO - 'PAGER': '/bin/cat', 08:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:07 INFO - 'PWD': '/builds/slave/test', 08:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:07 INFO - 'SHELL': '/bin/bash', 08:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:07 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:07 INFO - 'USER': 'cltbld', 08:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:07 INFO - 'XPC_FLAGS': '0x0', 08:36:07 INFO - 'XPC_SERVICE_NAME': '0', 08:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:07 INFO - Downloading/unpacking psutil>=0.7.1 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:10 INFO - Installing collected packages: psutil 08:36:10 INFO - Running setup.py install for psutil 08:36:10 INFO - building 'psutil._psutil_osx' extension 08:36:10 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 INFO - building 'psutil._psutil_posix' extension 08:36:11 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 08:36:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:36:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:36:11 INFO - ^ 08:36:11 INFO - 1 warning generated. 08:36:11 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 08:36:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:11 INFO - Successfully installed psutil 08:36:11 INFO - Cleaning up... 08:36:11 INFO - Return code: 0 08:36:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:36:11 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')]} 08:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 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')]} 08:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:11 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 08:36:11 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 08:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:11 INFO - 'HOME': '/Users/cltbld', 08:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:11 INFO - 'LOGNAME': 'cltbld', 08:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:11 INFO - 'MOZ_NO_REMOTE': '1', 08:36:11 INFO - 'NO_EM_RESTART': '1', 08:36:11 INFO - 'PAGER': '/bin/cat', 08:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:11 INFO - 'PWD': '/builds/slave/test', 08:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:11 INFO - 'SHELL': '/bin/bash', 08:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:11 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:11 INFO - 'USER': 'cltbld', 08:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:11 INFO - 'XPC_FLAGS': '0x0', 08:36:11 INFO - 'XPC_SERVICE_NAME': '0', 08:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:36:14 INFO - Installing collected packages: mozsystemmonitor 08:36:14 INFO - Running setup.py install for mozsystemmonitor 08:36:14 INFO - Successfully installed mozsystemmonitor 08:36:14 INFO - Cleaning up... 08:36:14 INFO - Return code: 0 08:36:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:14 INFO - 'HOME': '/Users/cltbld', 08:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:14 INFO - 'LOGNAME': 'cltbld', 08:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:14 INFO - 'MOZ_NO_REMOTE': '1', 08:36:14 INFO - 'NO_EM_RESTART': '1', 08:36:14 INFO - 'PAGER': '/bin/cat', 08:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:14 INFO - 'PWD': '/builds/slave/test', 08:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:14 INFO - 'SHELL': '/bin/bash', 08:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:14 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:14 INFO - 'USER': 'cltbld', 08:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:14 INFO - 'XPC_FLAGS': '0x0', 08:36:14 INFO - 'XPC_SERVICE_NAME': '0', 08:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:18 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 08:36:18 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 08:36:18 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 08:36:18 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 08:36:18 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 08:36:18 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 08:36:18 INFO - Downloading docopt-0.6.1.tar.gz 08:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:18 INFO - Running setup.py install for blobuploader 08:36:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:18 INFO - Running setup.py install for requests 08:36:19 INFO - Running setup.py install for docopt 08:36:19 INFO - Successfully installed blobuploader requests docopt 08:36:19 INFO - Cleaning up... 08:36:19 INFO - Return code: 0 08:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:19 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:19 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 08:36:19 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 08:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:19 INFO - 'HOME': '/Users/cltbld', 08:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:19 INFO - 'LOGNAME': 'cltbld', 08:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:19 INFO - 'MOZ_NO_REMOTE': '1', 08:36:19 INFO - 'NO_EM_RESTART': '1', 08:36:19 INFO - 'PAGER': '/bin/cat', 08:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:19 INFO - 'PWD': '/builds/slave/test', 08:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:19 INFO - 'SHELL': '/bin/bash', 08:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:19 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:19 INFO - 'USER': 'cltbld', 08:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:19 INFO - 'XPC_FLAGS': '0x0', 08:36:19 INFO - 'XPC_SERVICE_NAME': '0', 08:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-PUnKLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-bDe32g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sf8OyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CiDmG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-i3V8oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-xuQAis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ZnXkPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vtJx9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-RBywUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-bhP8nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6N0tEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-k_c54t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:20 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1AZCn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:21 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-qPhZR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:21 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-9QEY2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:21 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-eZqWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:21 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Vwh70t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:21 INFO - Running setup.py install for manifestparser 08:36:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:21 INFO - Running setup.py install for mozcrash 08:36:21 INFO - Running setup.py install for mozdebug 08:36:21 INFO - Running setup.py install for mozdevice 08:36:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozfile 08:36:22 INFO - Running setup.py install for mozhttpd 08:36:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozinfo 08:36:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozInstall 08:36:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozleak 08:36:22 INFO - Running setup.py install for mozlog 08:36:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for moznetwork 08:36:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozprocess 08:36:23 INFO - Running setup.py install for mozprofile 08:36:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozrunner 08:36:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozscreenshot 08:36:23 INFO - Running setup.py install for moztest 08:36:23 INFO - Running setup.py install for mozversion 08:36:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:24 INFO - Cleaning up... 08:36:24 INFO - Return code: 0 08:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:24 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 08:36:24 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 08:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:24 INFO - 'HOME': '/Users/cltbld', 08:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:24 INFO - 'LOGNAME': 'cltbld', 08:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:24 INFO - 'MOZ_NO_REMOTE': '1', 08:36:24 INFO - 'NO_EM_RESTART': '1', 08:36:24 INFO - 'PAGER': '/bin/cat', 08:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:24 INFO - 'PWD': '/builds/slave/test', 08:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:24 INFO - 'SHELL': '/bin/bash', 08:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:24 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:24 INFO - 'USER': 'cltbld', 08:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:24 INFO - 'XPC_FLAGS': '0x0', 08:36:24 INFO - 'XPC_SERVICE_NAME': '0', 08:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0Frkjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6FTCWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-wHmKJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-d3rxjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-kqU_NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-eT7WJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-PE_f8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-AQlHHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-710xFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1GccNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-r4rXDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-OQ1wXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sjXh5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-pHpdIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0X5_Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-wbn0EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:26 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-luSCGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:26 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)) 08:36:26 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)) 08:36:26 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)) 08:36:26 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)) 08:36:26 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)) 08:36:26 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)) 08:36:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:26 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 08:36:26 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 08:36:26 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 08:36:26 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 08:36:26 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 08:36:26 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 08:36:28 INFO - Downloading blessings-1.6.tar.gz 08:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:28 INFO - Installing collected packages: blessings 08:36:28 INFO - Running setup.py install for blessings 08:36:28 INFO - Successfully installed blessings 08:36:28 INFO - Cleaning up... 08:36:28 INFO - Return code: 0 08:36:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:29 INFO - Reading from file tmpfile_stdout 08:36:29 INFO - Current package versions: 08:36:29 INFO - blessings == 1.6 08:36:29 INFO - blobuploader == 1.2.4 08:36:29 INFO - docopt == 0.6.1 08:36:29 INFO - manifestparser == 1.1 08:36:29 INFO - mozInstall == 1.12 08:36:29 INFO - mozcrash == 0.17 08:36:29 INFO - mozdebug == 0.1 08:36:29 INFO - mozdevice == 0.48 08:36:29 INFO - mozfile == 1.2 08:36:29 INFO - mozhttpd == 0.7 08:36:29 INFO - mozinfo == 0.9 08:36:29 INFO - mozleak == 0.1 08:36:29 INFO - mozlog == 3.1 08:36:29 INFO - moznetwork == 0.27 08:36:29 INFO - mozprocess == 0.22 08:36:29 INFO - mozprofile == 0.28 08:36:29 INFO - mozrunner == 6.11 08:36:29 INFO - mozscreenshot == 0.1 08:36:29 INFO - mozsystemmonitor == 0.0 08:36:29 INFO - moztest == 0.7 08:36:29 INFO - mozversion == 1.4 08:36:29 INFO - psutil == 3.1.1 08:36:29 INFO - requests == 1.2.3 08:36:29 INFO - wsgiref == 0.1.2 08:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:29 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')]} 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:29 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')]} 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:29 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:29 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 08:36:29 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 08:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:29 INFO - 'HOME': '/Users/cltbld', 08:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:29 INFO - 'LOGNAME': 'cltbld', 08:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:29 INFO - 'MOZ_NO_REMOTE': '1', 08:36:29 INFO - 'NO_EM_RESTART': '1', 08:36:29 INFO - 'PAGER': '/bin/cat', 08:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:29 INFO - 'PWD': '/builds/slave/test', 08:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:29 INFO - 'SHELL': '/bin/bash', 08:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:29 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:29 INFO - 'USER': 'cltbld', 08:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:29 INFO - 'XPC_FLAGS': '0x0', 08:36:29 INFO - 'XPC_SERVICE_NAME': '0', 08:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 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)) 08:36:29 INFO - Cleaning up... 08:36:29 INFO - Return code: 0 08:36:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:29 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')]} 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:29 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')]} 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:29 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:29 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 08:36:29 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 08:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:29 INFO - 'HOME': '/Users/cltbld', 08:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:29 INFO - 'LOGNAME': 'cltbld', 08:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:29 INFO - 'MOZ_NO_REMOTE': '1', 08:36:29 INFO - 'NO_EM_RESTART': '1', 08:36:29 INFO - 'PAGER': '/bin/cat', 08:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:29 INFO - 'PWD': '/builds/slave/test', 08:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:29 INFO - 'SHELL': '/bin/bash', 08:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:29 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:29 INFO - 'USER': 'cltbld', 08:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:29 INFO - 'XPC_FLAGS': '0x0', 08:36:29 INFO - 'XPC_SERVICE_NAME': '0', 08:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:29 INFO - Downloading/unpacking jsonschema 08:36:29 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 08:36:29 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 08:36:29 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 08:36:29 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 08:36:29 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 08:36:29 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 08:36:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:31 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36:31 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 08:36:31 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 08:36:31 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 08:36:31 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 08:36:31 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 08:36:31 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 08:36:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:32 INFO - warning: no files found matching '*.txt' 08:36:32 INFO - no previously-included directories found matching 'build' 08:36:32 INFO - no previously-included directories found matching 'dist' 08:36:32 INFO - no previously-included directories found matching '.git*' 08:36:32 INFO - Installing collected packages: jsonschema, functools32 08:36:32 INFO - Running setup.py install for functools32 08:36:32 INFO - warning: no files found matching '*.txt' 08:36:32 INFO - no previously-included directories found matching 'build' 08:36:32 INFO - no previously-included directories found matching 'dist' 08:36:32 INFO - no previously-included directories found matching '.git*' 08:36:32 INFO - Successfully installed jsonschema functools32 08:36:32 INFO - Cleaning up... 08:36:32 INFO - Return code: 0 08:36:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:36:32 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')]} 08:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:32 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')]} 08:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:32 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 0x10fdfaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93b4a5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, '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.k0tLzeM3bg/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.E6vERcY8la/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 08:36:32 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 08:36:32 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 08:36:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:36:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:32 INFO - 'HOME': '/Users/cltbld', 08:36:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:32 INFO - 'LOGNAME': 'cltbld', 08:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:32 INFO - 'MOZ_NO_REMOTE': '1', 08:36:32 INFO - 'NO_EM_RESTART': '1', 08:36:32 INFO - 'PAGER': '/bin/cat', 08:36:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:32 INFO - 'PWD': '/builds/slave/test', 08:36:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:32 INFO - 'SHELL': '/bin/bash', 08:36:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:36:32 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:36:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:32 INFO - 'USER': 'cltbld', 08:36:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:32 INFO - 'XPC_FLAGS': '0x0', 08:36:32 INFO - 'XPC_SERVICE_NAME': '0', 08:36:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:32 INFO - Downloading/unpacking flake8 08:36:32 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 08:36:32 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 08:36:32 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 08:36:32 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 08:36:32 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 08:36:32 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 08:36:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:35 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 08:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:36 INFO - no previously-included directories found matching 'docs/_build' 08:36:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:36 INFO - Running setup.py install for pep8 08:36:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:36 INFO - no previously-included directories found matching 'docs/_build' 08:36:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:36:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:36 INFO - Cleaning up... 08:36:36 INFO - Return code: 0 08:36:36 INFO - Running post-action listener: _resource_record_post_action 08:36:36 INFO - Running post-action listener: _start_resource_monitoring 08:36:36 INFO - Starting resource monitoring. 08:36:36 INFO - ##### 08:36:36 INFO - ##### Running install step. 08:36:36 INFO - ##### 08:36:36 INFO - Running pre-action listener: _resource_record_pre_action 08:36:36 INFO - Running main action method: install 08:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:37 INFO - Reading from file tmpfile_stdout 08:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:37 INFO - Reading from file tmpfile_stdout 08:36:37 INFO - Output received: 08:36:37 INFO - Usage: mozinstall [options] installer 08:36:37 INFO - Options: 08:36:37 INFO - -h, --help show this help message and exit 08:36:37 INFO - -d DEST, --destination=DEST 08:36:37 INFO - Directory to install application into. [default: 08:36:37 INFO - "/builds/slave/test"] 08:36:37 INFO - --app=APP Application being installed. [default: firefox] 08:36:37 INFO - mkdir: /builds/slave/test/build/application 08:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:37:10 INFO - Reading from file tmpfile_stdout 08:37:10 INFO - Output received: 08:37:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:37:10 INFO - Running post-action listener: _resource_record_post_action 08:37:10 INFO - ##### 08:37:10 INFO - ##### Running run-tests step. 08:37:10 INFO - ##### 08:37:10 INFO - Running pre-action listener: _resource_record_pre_action 08:37:10 INFO - Running main action method: run_tests 08:37:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:37:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:37:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:37:10 INFO - 2016-03-08 08:37:10.955 screenresolution[1644:7346] starting screenresolution argv=screenresolution get 08:37:10 INFO - 2016-03-08 08:37:10.957 screenresolution[1644:7346] Display 0: 1600x1200x32@60 08:37:10 INFO - 2016-03-08 08:37:10.963 screenresolution[1645:7348] starting screenresolution argv=screenresolution list 08:37:10 INFO - Available Modes on Display 0 08:37:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:37:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:37:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:37:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:37:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:37:11 INFO - Intel Iris: 08:37:11 INFO - Chipset Model: Intel Iris 08:37:11 INFO - Type: GPU 08:37:11 INFO - Bus: Built-In 08:37:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:37:11 INFO - Vendor: Intel (0x8086) 08:37:11 INFO - Device ID: 0x0a2e 08:37:11 INFO - Revision ID: 0x0009 08:37:11 INFO - Displays: 08:37:11 INFO - Display: 08:37:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:37:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:37:11 INFO - Display Serial Number: 1600x1200 60 08:37:11 INFO - Main Display: Yes 08:37:11 INFO - Mirror: Off 08:37:11 INFO - Online: Yes 08:37:11 INFO - Rotation: Supported 08:37:11 INFO - Return code: 0 08:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:11 INFO - Python 2.7.3 08:37:11 INFO - Return code: 0 08:37:11 INFO - grabbing minidump binary from tooltool 08:37:11 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')]} 08:37:11 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 0x10fc9ed30>, '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 0x10fac2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc95b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:11 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 08:37:11 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 08:37:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:11 INFO - Return code: 0 08:37:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:37:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:37:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:37:12 INFO - Return code: 0 08:37:12 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/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 08:37:12 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/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --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 08:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k0tLzeM3bg/Render', 08:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:12 INFO - 'HOME': '/Users/cltbld', 08:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:12 INFO - 'LOGNAME': 'cltbld', 08:37:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:12 INFO - 'MOZ_NO_REMOTE': '1', 08:37:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:12 INFO - 'NO_EM_RESTART': '1', 08:37:12 INFO - 'PAGER': '/bin/cat', 08:37:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:12 INFO - 'PWD': '/builds/slave/test', 08:37:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:12 INFO - 'SHELL': '/bin/bash', 08:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E6vERcY8la/Listeners', 08:37:12 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 08:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:12 INFO - 'USER': 'cltbld', 08:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:12 INFO - 'XPC_FLAGS': '0x0', 08:37:12 INFO - 'XPC_SERVICE_NAME': '0', 08:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:12 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/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 08:37:12 INFO - mozversion application_buildid: 20160308074036 08:37:12 INFO - mozversion application_changeset: e330626de260b21a6ea62d741131d04715ef39a1 08:37:12 INFO - mozversion application_display_name: Nightly 08:37:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:12 INFO - mozversion application_name: Firefox 08:37:12 INFO - mozversion application_remotingname: firefox 08:37:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:37:12 INFO - mozversion application_vendor: Mozilla 08:37:12 INFO - mozversion application_version: 47.0a1 08:37:12 INFO - mozversion platform_buildid: 20160308074036 08:37:12 INFO - mozversion platform_changeset: e330626de260b21a6ea62d741131d04715ef39a1 08:37:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:37:12 INFO - mozversion platform_version: 47.0a1 08:37:12 INFO - using testdate: 1457455032 08:37:12 INFO - actual date: 1457455032 08:37:12 INFO - starting webserver on 'localhost:49270' 08:37:12 INFO - SUITE-START | Running 2 tests 08:37:12 INFO - TEST-START | dromaeo_css 08:37:12 INFO - operating with platform_type : mac_ 08:37:12 INFO - Initialising browser for dromaeo_css test... 08:37:12 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpy3ZRmq/profile http://localhost:49270/getInfo.html) 08:37:15 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:37:15 INFO - PROCESS | 1663 | colorDepth:24 08:37:15 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:37:15 INFO - PROCESS | 1663 | __metrics 08:37:15 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:37:15 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:16 INFO - TEST-INFO | 1663: exit 0 08:37:16 INFO - Browser initialized. 08:37:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:16 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpy3ZRmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:28 INFO - PROCESS | 1666 | RSS: Main: 245878784 08:37:28 INFO - PROCESS | 1666 | 08:38:19 INFO - PROCESS | 1666 | 1457455099042 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] 08:40:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:40:30 INFO - PROCESS | 1666 | RSS: Main: 382406656 08:40:30 INFO - PROCESS | 1666 | 08:43:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:43:33 INFO - PROCESS | 1666 | RSS: Main: 376684544 08:43:33 INFO - PROCESS | 1666 | 08:46:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:46:36 INFO - PROCESS | 1666 | RSS: Main: 375152640 08:46:36 INFO - PROCESS | 1666 | 08:49:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:49:39 INFO - PROCESS | 1666 | RSS: Main: 335081472 08:49:39 INFO - PROCESS | 1666 | 08:52:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:52:42 INFO - PROCESS | 1666 | RSS: Main: 334106624 08:52:42 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 08:55:45 INFO - PROCESS | 1666 | RSS: Main: 398655488 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | __start_tp_report 08:55:45 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 08:55:45 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 08:55:45 INFO - PROCESS | 1666 | |i|pagename|runs| 08:55:45 INFO - PROCESS | 1666 | |0;dojo.html;3149.4016136933983;3444.7416443766706;3468.445048792193;3470.8785192518267;3515.17393412548;5308;5519.39286678465;5563.554915606752;5587.022271102556;5598.552115830734;5528.695921724304;5586.720663966806;5588.692621905793;5704.201411802351;5712.371639119693;4899.240617704244;5020.447750747424;5045.823396181135;5058.848234552951;5198.506141916512;5127.589792816584;5130.692158470485;5135.255387968742;5151.278820965068;5162.406323272834;4979.900401991958;5017.448080711119;5074.873128171788;5120.667156634807;5154.969006198738;5025.1708468102715;5039.294498770175;5048.444671086214;5054.545090941796;5112.258722485219;4967.975160124212;4983.501649835024;5010.423801262828;5018.096742586333;5036.370453693288;5407.432219616923;5479.561635069185;5511.559075273968;5527.613067085305;5623.662580245198;6028.608140470856;6047.395260473917;6052.182955301022;6054.606450580698;6054.939450605481;5350.35795704514;6117.969410152965;6126.816195514141;6136.815895523141;6138.232720909887;5488.231647569343;5560.971220324253;5595.608307418523;5595.804146854841;5658.632188907708;6248.75004999804;6255.155554000152;6264.060390941304;6284.780032698925;6293.622382657055;5976.970115149396;6006.429389208019;6042.818715438544;6056.939430605637;6059.091136329585;5968.791092311748;6079.878402432015;6118.4364438206485;6136.917362303815;6150.261968563801;6110.4980065817745;6126.27339965311;6136.746076527064;6142.06524944641;6148.6925653717135;6102.246889800143;6119.796206005239;6130.000698177752;6141.877162456815;6142.78500252489;4705.1765940960195;4729.976350118296;4782.593479554207;4786.832460863853;4833.782479788348;4327.675424343187;4353.73877567347;4358.6295164911335;4377.9781101094295;4387.3857659927635;5595.328560572676;5596.1605759136455;5603.075492543685;5605.411431799684;5610.13042978339;6084.636441487559;6087.740325088945;6111.470193407285;6203.844903877349;6208.906866397007;5603.991281569357;5645.350784659735;5651.886962260732;5685.943140568541;5691.8861622768145;5214.217867319857;5253.474652534716;5274.815381461631;5276.762545685453;5320.17537281722;6175;6192.721327540272;6193.659348735863;6222.968885155636;6241.500679945593;6191.5665903388135;6196.535259855619;6199.783007594712;6200.286966998853;6215;6189.226346706661;6200.720967556381;6215.192025036717;6221.471174949999;6229.719662615103;5932.9703351484695;5989.011813050798;6062.969685151546;6073.787417440369;6134.754609815557;5234.633575649668;6146.385361463817;6164.229471316085;6168.938310616836;6172.4136207060255;5827.3007239131575;5911.438413350725;5922.407759224043;5956.612820166675;5974.2233509643465;5728.112142617901;5846.9183201107935;5921.230240068763;5940.970295148497;5992.520598352208;5558.194061860927;5734.7132643368495;5763.308402991668;5771.451712087345;5784.4504772046585;5757.251557297524;5927.110933360031;5928.79249226275;5940.405959404025;6000.21997140369;5681.119426488901;5701.714914254354;5704.686242256716;5718.914216286842;5745.770169193353 08:55:45 INFO - PROCESS | 1666 | |1;ext.html;479.2451888275966;558.0903127901522;585.537425433907;609.8597322615797;642.8907085795415;29580.112596622082;30363.240918977037;37850;38222.04444888872;38321.616783832156;40590;41066.178676426454;41095;41136.38295425571;41209;9388;9618.470984095871;9625.663101791439;9630.988746181654;9649.083337082966;9417.293702972305;9534.856977145348;9538.189253913426;9551.85672214914;9566.904330956671;8367.456115352514;8421.326293896474;9509.904900951005;9617.182539484153;9632.84405871293;8440.324774018063;9679.370840895319;9690.806183876282;9691.563879625433;9699.981501942335;9581;9672.516374181263;9681.903180968171;9701.611935522642;9707.369021013612;40339;40797;40823.59176408257;40853.57012504578;40877.59122408768;3253.609566851993;3265.4122257993554;3406.3017081498233;3477.2176260341475;3663.303972245265;23236.883815580983;28390.148295551167;28587.428251434856;28596.856125754945;28846.42307153845;2722.0744946718014;2734.3027527980435;2743.903963361293;2772.9306767330777;2859.914202573905;487212;488597;488899;489414;490470.99999999645;55226.34320970377;62082;62392.68803655953;62463;62489.687551561954;63710.36289637137;71363.64318178479;72072.63963680148;72325.6383718078;72413.63793181106;16281.185940702917;16536.677065834705;16779.91610041942;16798.076105814296;16830.57923551921;12703.237805731686;12789.104762666524;12798;12800.551980680631;12819.230846149261;17387.435130838287;20747.68878466824;20773.065212065492;21024.26415075465;21037.263695770576;9424.717258482257;9677.516124193762;9684.806303873884;9705.369151005161;9759.951200243953;945.7541039329824;969.5636963366513;990.5641517732175;1021.2953062386929;1121.4560937945091;28827;28997.7100228995;29226.41547169045;29464.705352946625;29673.406531869674;1027.7893031928436;1130.2427373659668;1133.812920868064;1136.4261048170622;1220.2190598017098;14660.56018319452;14693.706125877423;14811.111333320036;15120.697586048438;15132.773008404884;479572.6021369871;528023;537769;545071.1196660267;545760;56790;58903.705481472316;58934.70532647309;59052;59111;1342.6509107631891;1362.9182249065088;1483.3102607287447;1504.5110339139824;1635.9611646604492;26351;28038.971621101562;28194.43611127725;28762.568561471177;29104.27239319034;44239.778801105786;44317.556824432635;44792.77603611961;44996.55003450054;45133.32300015568;279306.6034669814;279316;279568;279871.2012879845;280087;28079.859600701864;29693.554596680635;32001;32915.83542082274;33401.66598333986;40517.581884633895;40861.795691021354;41249.96875078147;41887.58112418837;42087.158256835304;34151.487727683605;35258.94223173309;35341.64658353384;35983.46024809578;36043.459348109274;31829.8859539915;33920.06398880236;34071.65928340784;34828.30343393169;34936.9518914433;35631.46552801658;35826.74606388764;36688.63311366852;36792;36801.26397471982;30941.91703290464;31911.361772764878;32128.678713213503;32194.67805321917;32240.83879580587;19729.901350493157;20634.27780027692;23334;23626.881865590563;24244 08:55:45 INFO - PROCESS | 1666 | |2;jquery.html;352.6297387742869;354.36745409444137;361.2594181927049;363.1520399866312;363.41127373654683;19796;20068;21598.99999999998;21625.567488650217;21640.891795541;19953.900230498828;20269.797302026975;20903.581928361422;21002.89498552509;21008.05463754131;5838.9124163137485;5992.161097446339;6047.879042419149;6051.848703782419;6066.514678825683;4194.790260486979;4270.466191726035;4364.361187828196;5394.7842086316505;6284.591501552407;5597.972010139943;6553.311902250267;6592.6703664816805;6592.901106483407;6594.802155935329;5519.69641669708;5837.270341207349;5851.268591426072;6569.835754106138;6571.539992200548;3738;3915.4714113594587;5395.973020134874;5630.943690563083;5631.986242476352;13039.869601304055;13196.14225075367;13280.933595332059;19195.424137275764;24570.754292457026;2072.274703853654;2082.6563617003326;2095.549456866781;2141.6145093883097;2152.4726442021806;9544.284178686627;9621.18219951305;9665.90334096664;9999.200063994864;10045.296829221885;1716.519374575121;1740.3647668600995;1809.1677828199045;1830.130687923239;1922.807859127336;97538.51230743872;100089.9982000356;102792;105497;107277.92722072758;9241.3531052827;11097.33415995043;11162.939520745516;11225.550977960791;11296.435178241056;13700.314984250947;13816.37826297819;13857.514986975408;13862.514811981733;13892.09701369428;6784.694688739019;8627.6980305689;8643.17889800468;8724.258438032712;8745.956270218609;7646.23537646242;8337.583120843934;8839;8841.381103322834;8943.731688049369;4442.289233722653;4534.206513860127;4535.886602834956;4575.290829921368;4576.473705523841;1802.567383827872;1870.326682394337;1876.718492226177;1878.6618408686568;1879.586490971984;887.5118684723506;914.9085091490798;991.2268430623981;997.4713401896861;1025.7179275699243;19089;19375.90312048431;19841.900790496245;19957.20171193136;20665.55690526544;822.116225058065;891.4963045879058;893.9821203575892;950.5437390052813;970.5777986575721;6764.93235067643;10942.4528773561;11018.338899666045;11027.779444411068;11098.944505277583;634781;647853.7607312028;649445.0332980036;650180;665295;101805;117594.41202793931;122270;122514.77485225211;128515.35742321229;1040.7138037039724;1052.578968412641;1055.4142450939803;1070.7269646240159;1074.1997212076897;14983.7003259932;17945.461636150936;18266.178021989308;18308.90845545817;18359.888612809696;50484.49515504798;50641.74679126581;51002.41057659089;51557;52475.73762131165;73748.26251737414;74093;74675;74954;77501;7984;8073.313768329758;8151.184881511801;8230.876536852073;8406.621702023302;9694.5152742364;13288;13345.266010369134;13456.25990570528;13681.247531385869;11327.433628318717;11545.653630391102;11663.358515281741;11794.410279485819;11811.527538898348;8227.873328417336;11106.50020749052;11244.26912250701;11667.708307292047;11759;9039.68361107358;10116.848247276444;10552.630657926935;11788.76422471563;12032.819507707216;8093.797655058671;8101.392395570238;8203.507789532647;8228.341732661493;8239.835203295781;8678.262347700263;11457.656270311903;11694.4737486815;11711.355875426932;11837.940810295893 08:55:45 INFO - PROCESS | 1666 | |3;mootools.html;1352.2427440633244;1443.3721331220927;1632.836716328367;1843.4285371534818;2047.1299697628513;7903.091144518375;8465.57672116394;8633.611487483062;8640.524771137585;8645.135486451352;8272.875906861402;8503.659853605848;8509.829803403929;8519.616617252223;8521.91478085219;2139.1336508713994;2192.177933275022;2193.967090493644;2437.2200895713336;2459.213051823417;2426.599611064172;2494.239257026606;2497.500499900018;2498.038255271724;2503.4617557225192;2365.526894621074;2400.3639035655565;2400.4838959623676;2418.9840267087866;2420.854748715074;2426.8543887366814;2435.6224785158242;2436.756324367567;2446.559619268531;2461.1755062054235;2438.878056097188;2439.329184474266;2439.621858611918;2441.816863735227;2460.4218008767925;7984.880226796603;8061.435699501038;8694.913050869474;8748.125187481264;8766.430182038148;5278.656887302313;5421.159720243369;5457.154141108134;5467.972660136714;5472;3493.930121397583;3618.5295911531593;3635.1820840310984;3642.981785091084;3672.577653569847;1032.4012072997643;1051.9421431821247;1053.1416895230363;1055.4036969112426;1063.4310643805604;11853.762924741543;11880.465379057876;11881.108916831272;11881.821772673416;11926.224795388358;4769.689970151929;4824.517548245148;4880.560749532559;4883;4907.533784290558;9860.605575776888;9860.950695246478;9864.358816676893;9870.901290986998;9892.307538472382;5385.299911011543;5421.566274698014;5438.483344082306;5447.155690867922;5480.369757477862;4361.869143925687;4544.227481328182;4714.740689262124;4893.972265824217;4933.309336692866;3839.117003089305;3879.7866117363815;3927.509061367329;3929.4695216146024;3950.841966321315;1289.5357671238346;1308.640123965898;1314.5530519623373;1322.9470821167238;1326.6882282663566;1282.6344491819973;1286.5175559165314;1305.8171855940177;1355.0920883008407;1356.220173400279;7967.641456134488;8242.29940455056;8278.461899976483;8286.58567071644;8293.668253269921;1178.5757127434117;1200.5197920831563;1204.4880925606583;1207.7161866961258;1235.1292338901053;6169.383061693795;6208.689565521706;6242.906356404657;6247.96876015617;6253.218347706536;10200.795984080276;10440.791184176425;10461.110805581458;10467.214958878114;10559.524821383056;9803.411795292306;10481.633142839964;10486.213533984981;10519.053285204369;10590.887956764429;7878.763637090897;7954;8008.27925486709;8084.717034903868;8104.797380065427;7783.92216077832;7790.5325680459355;7823.374130069467;7878.960605196938;7881.645325960231;8007.35941124697;8710.390272680852;9026.323025773225;9240;9260.53697315118;9246.815063698554;9507.144357007903;9690.854637180308;9717.757056073371;9732.902670973199;6505.902411463927;6700.46396288286;6725;7332.5967071811565;7458.47790654649;7185.353318201387;7716.459847810599;7718.382529397747;7726.0342457192855;7727.729529466442;6114.327423983447;7260.310270524292;7297.270272972661;7387.852242955219;7432.145303290191;7062.717491300496;7149.60677162761;7221.205667376479;7257.818554536178;7371.963140184264;7469.5891725953425;7592.4305677073335;7663.386929045551;7663.540187588763;7674.424418168548;6857.794266172023;6937.479689023243;6951.16586009682;6953.991671207546;6979.895301570582;6975.965120174366;7054.329838665319;7064.293570642894;7071.681774320065;7071.681774320271 08:55:45 INFO - PROCESS | 1666 | |4;prototype.html;316.90334447993365;326.74513879174236;327.9049075768027;332.37845229420986;337.2714935738806;5154.381474223093;6361.872762544752;6427.068075129104;6427.228732552088;6444.96777516113;6314.7789827356055;6356.68216589171;6358.141650877142;6360.204974378203;6374.426301632852;4550.453945526525;4628.583427491525;4665.9066818663605;4756.096341695067;4782.28265760137;4307.655387568987;4546.590556927346;4732.503087175849;4733.905321893577;4758.500357462469;4707.576318131368;4709.2229782085915;4725.976370118145;4748.928766068511;4752.667313288071;4470.061287129723;4551.772411379451;4681.993371425126;4749.525047495257;4752.59602933751;3364.52896594477;3501.9669197586772;4069.8168582413864;4088.9386659200136;4097.201045796071;6109.847253818646;6114;6154.230721159855;6156.261248650146;6177.907331390033;5564.054110801174;5577.52591029763;5581.162825576155;5604.075327570946;5606.467385598403;5357.8392648220615;5865.501432378253;6774.356436138559;6778.356056174655;6780.254172041072;4247.469066366704;4255.63827074699;4358.735966569691;4408.20652282589;4582.404287442611;6144.907826382608;7181.389581885546;7196.280371962762;7218.783436496913;7218.8917166242545;4530.411046563926;4537.909241815211;4539.275075471366;4547.204239258117;4549.249373853278;4598.379218805485;4600.125976064604;4601.608863246662;4606.56237657422;4612.723236605814;5450.809221677222;5451.945480545223;5452.318460192476;5456.699881506476;5466.34403871538;6544.476441884638;6786.966065169642;6851.794446166623;6855.897161542581;6861.897071543931;1567.396552327362;1570.3797000184863;1592.16411384022;1595.3219881550294;1597.25727536696;965.6427121964778;1013.0527956360826;1016.3800081950004;1025.2413214221422;1039.210200247817;6127.908081378783;6273;6505.60966342021;6510.739570417225;6511.967440162864;7041.929580704127;7200.459965502609;7205.675744591506;7213.963930180315;7214.242504537053;6473.676316184172;6476.740930362827;6486.967565162144;6492.772752953719;6504.5121615879;3724.0689827543115;3765.585785563586;3772.3775577030033;3774.037620406779;3780.6219378061974;6010.699465026819;6047.516198704093;7181.856362872713;7468.365188958999;7478.326950574475;7315.561066336037;7363.705451781976;7374.668139933716;7380.077490313711;7414.147373052168;6108.7861924833305;7399.038125043818;7457.738979135921;7458.366038886756;7465.552066876005;7139.357457828821;7144.464165187528;7145.892811607726;7148.4281257500315;7151.2491188424465;6742.730290788313;6995.860082798214;7021.719131234693;7022.157341119098;7047.083879095685;7420.40636749048;7441.479096463412;7446.920196571575;7453.850922981618;7467.477276590586;4533.682642215013;4534.093181363674;4538.909221815479;4539.863804085882;4540.614047805841;7083.327083927019;7109.537880037988;7109.857802844018;7112.075430194249;7128.750493732695;6530.151080359523;6837.145356830396;6865.725370985105;6893.482988775761;6893.517453778188;6341.0805433212845;6443.420092191725;6808.795736127924;6867.450603951572;6885.173779146535;6698.83252918681;6700.530962832555;6701.631410272482;6706.597604143767;6732.831679208059;6851.588904665736;6852;6858.6227757471825;6877.140357455318;6885.552439091443;5231.712255825814;6453.290138084713;6566.967165164144;6568.638724870178;6638.668066596554 08:55:45 INFO - PROCESS | 1666 | |5;yui.html;750.182301291592;759.7948553890446;762.7787941496966;768.8423873106012;771.7761849063771;13572.524961626345;15050.397984080624;15055.623609409757;15084.32120554575;15188;13825.032247742662;13874.583762487142;13917.512887048955;13946.23295718735;13951.302434878266;722.8482018776037;734.4418242135988;908.1191244492832;917.7430319510531;931.5249222896338;919.3610440743686;924.3344791749963;928.5728564860138;928.6563971330617;929.0384452092086;998.6804222648756;999.3254553176613;1000.2997901468965;1001.1040119093443;1002.0230275481384;757.2768006553728;961.1061712607342;980.0836218136066;980.1668581705565;992.7220378294053;734.4821900560092;734.5115498193695;735.0811485642946;736.065197199559;736.5727877830899;14745.262736863115;14769.926150369287;14791.630209244855;14802.555923322318;14825.925870370687;10669.573217071307;11734.647960561197;12248.326342051183;12266.448009839489;12613.495460181673;9539.332246742732;9966.398149664778;10026.548805303706;10095.697129086138;10364.067233948981;3451.137215696076;3528.0474271946687;3541.3448512025357;3607.7474576779637;3619.457081437779;77686.22313776903;78110;78370;78634.6068269655;79296.60351698204;9493.90506094944;9539.713808585753;9608.231341492663;9625.614975401046;9960.252981026451;21755.238566650092;21800.781992179876;21810.890945545172;21830.45423864416;21841;7295.52579082358;7430.28794490018;7446.813829654194;7517.398608111338;7662;3941.7043721720984;3997.709904662347;4004.3192657248337;4012.6388625023887;4079.347304431277;3572.2319701264355;3625.9093522661615;3633.5639723232853;3634.545681789776;3638.272345530904;624.3382015064046;650.278191207759;655.4199533412964;662.1822049768532;669.4142625202948;544.0940833512237;570.5606682854179;577.5812535911431;586.2730214533947;615.2555407956423;8089.47418417801;8207.302379297827;8250.669973201006;8339.12439193888;8405;575.2607898849958;582.8338923406809;592.2330581896455;606.1513880567242;618.5700937848243;3843.2374186854017;3846.480725102131;3875.7210120660116;3912.5891781363116;3947.921041579152;60255;77644.61177694076;77785.61107194428;84349;87252;56829;72947.63526182335;78595;83585.32829343379;84597.57701211577;66518.33481665218;66912.99630505547;67528;68777.65611172012;75007.62496187484;6951.513394062367;8280.544570048705;8392.076871544248;8564.989476192199;8622.870656940026;49002.84334790474;50218.22490413503;50716;50998.490015100855;51770;56499;59706.70146649239;61456.46358841065;64500;66673.33326666865;9417.670381536613;11539.36533490666;11546.19176657626;11624.593139240085;11858.703532411413;11869.708138260852;11885.465154067915;12027.21823081497;12079.033677305619;13079.149855259378;11392.772144556897;11410.657680269605;11441.713957150805;11770.234934729215;11848.822267666164;11302.604408845651;11312.377819220023;11351.659450216506;11686.006689431493;12039.819402709141;11003.449827508754;11036.834447483454;11509.228016487243;11623.941880290882;11915.927566519054;9484.620615175316;9515.714528564155;9550.95224523873;9585.233181345337;9865.143725110978;8145.551994640115;9282.72151835446;9300.860487092834;9630.229581633312;9769.31614786958 08:55:45 INFO - PROCESS | 1666 | __end_tp_report 08:55:45 INFO - PROCESS | 1666 | __start_cc_report 08:55:45 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1228 08:55:45 INFO - PROCESS | 1666 | __end_cc_report 08:55:45 INFO - PROCESS | 1666 | __startTimestamp1457456145811__endTimestamp 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | ------- Summary: start ------- 08:55:45 INFO - PROCESS | 1666 | Number of tests: 6 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5612.09 Median:5728.11 stddev:623.40 (10.9%) stddev-sans-first:594.63 08:55:45 INFO - PROCESS | 1666 | Values: 3149.4 3444.7 3468.4 3470.9 3515.2 5308.0 5519.4 5563.6 5587.0 5598.6 5528.7 5586.7 5588.7 5704.2 5712.4 4899.2 5020.4 5045.8 5058.8 5198.5 5127.6 5130.7 5135.3 5151.3 5162.4 4979.9 5017.4 5074.9 5120.7 5155.0 5025.2 5039.3 5048.4 5054.5 5112.3 4968.0 4983.5 5010.4 5018.1 5036.4 5407.4 5479.6 5511.6 5527.6 5623.7 6028.6 6047.4 6052.2 6054.6 6054.9 5350.4 6118.0 6126.8 6136.8 6138.2 5488.2 5561.0 5595.6 5595.8 5658.6 6248.8 6255.2 6264.1 6284.8 6293.6 5977.0 6006.4 6042.8 6056.9 6059.1 5968.8 6079.9 6118.4 6136.9 6150.3 6110.5 6126.3 6136.7 6142.1 6148.7 6102.2 6119.8 6130.0 6141.9 6142.8 4705.2 4730.0 4782.6 4786.8 4833.8 4327.7 4353.7 4358.6 4378.0 4387.4 5595.3 5596.2 5603.1 5605.4 5610.1 6084.6 6087.7 6111.5 6203.8 6208.9 5604.0 5645.4 5651.9 5685.9 5691.9 5214.2 5253.5 5274.8 5276.8 5320.2 6175.0 6192.7 6193.7 6223.0 6241.5 6191.6 6196.5 6199.8 6200.3 6215.0 6189.2 6200.7 6215.2 6221.5 6229.7 5933.0 5989.0 6063.0 6073.8 6134.8 5234.6 6146.4 6164.2 6168.9 6172.4 5827.3 5911.4 5922.4 5956.6 5974.2 5728.1 5846.9 5921.2 5941.0 5992.5 5558.2 5734.7 5763.3 5771.5 5784.5 5757.3 5927.1 5928.8 5940.4 6000.2 5681.1 5701.7 5704.7 5718.9 5745.8 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:58223.08 Median:20175.97 stddev:118704.37 (588.3%) stddev-sans-first:118958.19 08:55:45 INFO - PROCESS | 1666 | Values: 479.2 558.1 585.5 609.9 642.9 29580.1 30363.2 37850.0 38222.0 38321.6 40590.0 41066.2 41095.0 41136.4 41209.0 9388.0 9618.5 9625.7 9631.0 9649.1 9417.3 9534.9 9538.2 9551.9 9566.9 8367.5 8421.3 9509.9 9617.2 9632.8 8440.3 9679.4 9690.8 9691.6 9700.0 9581.0 9672.5 9681.9 9701.6 9707.4 40339.0 40797.0 40823.6 40853.6 40877.6 3253.6 3265.4 3406.3 3477.2 3663.3 23236.9 28390.1 28587.4 28596.9 28846.4 2722.1 2734.3 2743.9 2772.9 2859.9 487212.0 488597.0 488899.0 489414.0 490471.0 55226.3 62082.0 62392.7 62463.0 62489.7 63710.4 71363.6 72072.6 72325.6 72413.6 16281.2 16536.7 16779.9 16798.1 16830.6 12703.2 12789.1 12798.0 12800.6 12819.2 17387.4 20747.7 20773.1 21024.3 21037.3 9424.7 9677.5 9684.8 9705.4 9760.0 945.8 969.6 990.6 1021.3 1121.5 28827.0 28997.7 29226.4 29464.7 29673.4 1027.8 1130.2 1133.8 1136.4 1220.2 14660.6 14693.7 14811.1 15120.7 15132.8 479572.6 528023.0 537769.0 545071.1 545760.0 56790.0 58903.7 58934.7 59052.0 59111.0 1342.7 1362.9 1483.3 1504.5 1636.0 26351.0 28039.0 28194.4 28762.6 29104.3 44239.8 44317.6 44792.8 44996.6 45133.3 279306.6 279316.0 279568.0 279871.2 280087.0 28079.9 29693.6 32001.0 32915.8 33401.7 40517.6 40861.8 41250.0 41887.6 42087.2 34151.5 35258.9 35341.6 35983.5 36043.5 31829.9 33920.1 34071.7 34828.3 34937.0 35631.5 35826.7 36688.6 36792.0 36801.3 30941.9 31911.4 32128.7 32194.7 32240.8 19729.9 20634.3 23334.0 23626.9 24244.0 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35249.15 Median:353.50 stddev:107493.99 (30408.6%) stddev-sans-first:107763.60 08:55:45 INFO - PROCESS | 1666 | Values: 352.6 354.4 361.3 363.2 363.4 19796.0 20068.0 21599.0 21625.6 21640.9 19953.9 20269.8 20903.6 21002.9 21008.1 5838.9 5992.2 6047.9 6051.8 6066.5 4194.8 4270.5 4364.4 5394.8 6284.6 5598.0 6553.3 6592.7 6592.9 6594.8 5519.7 5837.3 5851.3 6569.8 6571.5 3738.0 3915.5 5396.0 5630.9 5632.0 13039.9 13196.1 13280.9 19195.4 24570.8 2072.3 2082.7 2095.5 2141.6 2152.5 9544.3 9621.2 9665.9 9999.2 10045.3 1716.5 1740.4 1809.2 1830.1 1922.8 97538.5 100090.0 102792.0 105497.0 107277.9 9241.4 11097.3 11162.9 11225.6 11296.4 13700.3 13816.4 13857.5 13862.5 13892.1 6784.7 8627.7 8643.2 8724.3 8746.0 7646.2 8337.6 8839.0 8841.4 8943.7 4442.3 4534.2 4535.9 4575.3 4576.5 1802.6 1870.3 1876.7 1878.7 1879.6 887.5 914.9 991.2 997.5 1025.7 19089.0 19375.9 19841.9 19957.2 20665.6 822.1 891.5 894.0 950.5 970.6 6764.9 10942.5 11018.3 11027.8 11098.9 634781.0 647853.8 649445.0 650180.0 665295.0 101805.0 117594.4 122270.0 122514.8 128515.4 1040.7 1052.6 1055.4 1070.7 1074.2 14983.7 17945.5 18266.2 18308.9 18359.9 50484.5 50641.7 51002.4 51557.0 52475.7 73748.3 74093.0 74675.0 74954.0 77501.0 7984.0 8073.3 8151.2 8230.9 8406.6 9694.5 13288.0 13345.3 13456.3 13681.2 11327.4 11545.7 11663.4 11794.4 11811.5 8227.9 11106.5 11244.3 11667.7 11759.0 9039.7 10116.8 10552.6 11788.8 12032.8 8093.8 8101.4 8203.5 8228.3 8239.8 8678.3 11457.7 11694.5 11711.4 11837.9 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5933.92 Median:5462.56 stddev:3081.30 (56.4%) stddev-sans-first:3070.69 08:55:45 INFO - PROCESS | 1666 | Values: 1352.2 1443.4 1632.8 1843.4 2047.1 7903.1 8465.6 8633.6 8640.5 8645.1 8272.9 8503.7 8509.8 8519.6 8521.9 2139.1 2192.2 2194.0 2437.2 2459.2 2426.6 2494.2 2497.5 2498.0 2503.5 2365.5 2400.4 2400.5 2419.0 2420.9 2426.9 2435.6 2436.8 2446.6 2461.2 2438.9 2439.3 2439.6 2441.8 2460.4 7984.9 8061.4 8694.9 8748.1 8766.4 5278.7 5421.2 5457.2 5468.0 5472.0 3493.9 3618.5 3635.2 3643.0 3672.6 1032.4 1051.9 1053.1 1055.4 1063.4 11853.8 11880.5 11881.1 11881.8 11926.2 4769.7 4824.5 4880.6 4883.0 4907.5 9860.6 9861.0 9864.4 9870.9 9892.3 5385.3 5421.6 5438.5 5447.2 5480.4 4361.9 4544.2 4714.7 4894.0 4933.3 3839.1 3879.8 3927.5 3929.5 3950.8 1289.5 1308.6 1314.6 1322.9 1326.7 1282.6 1286.5 1305.8 1355.1 1356.2 7967.6 8242.3 8278.5 8286.6 8293.7 1178.6 1200.5 1204.5 1207.7 1235.1 6169.4 6208.7 6242.9 6248.0 6253.2 10200.8 10440.8 10461.1 10467.2 10559.5 9803.4 10481.6 10486.2 10519.1 10590.9 7878.8 7954.0 8008.3 8084.7 8104.8 7783.9 7790.5 7823.4 7879.0 7881.6 8007.4 8710.4 9026.3 9240.0 9260.5 9246.8 9507.1 9690.9 9717.8 9732.9 6505.9 6700.5 6725.0 7332.6 7458.5 7185.4 7716.5 7718.4 7726.0 7727.7 6114.3 7260.3 7297.3 7387.9 7432.1 7062.7 7149.6 7221.2 7257.8 7372.0 7469.6 7592.4 7663.4 7663.5 7674.4 6857.8 6937.5 6951.2 6954.0 6979.9 6976.0 7054.3 7064.3 7071.7 7071.7 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5568.04 Median:6348.88 stddev:1782.35 (28.1%) stddev-sans-first:1743.23 08:55:45 INFO - PROCESS | 1666 | Values: 316.9 326.7 327.9 332.4 337.3 5154.4 6361.9 6427.1 6427.2 6445.0 6314.8 6356.7 6358.1 6360.2 6374.4 4550.5 4628.6 4665.9 4756.1 4782.3 4307.7 4546.6 4732.5 4733.9 4758.5 4707.6 4709.2 4726.0 4748.9 4752.7 4470.1 4551.8 4682.0 4749.5 4752.6 3364.5 3502.0 4069.8 4088.9 4097.2 6109.8 6114.0 6154.2 6156.3 6177.9 5564.1 5577.5 5581.2 5604.1 5606.5 5357.8 5865.5 6774.4 6778.4 6780.3 4247.5 4255.6 4358.7 4408.2 4582.4 6144.9 7181.4 7196.3 7218.8 7218.9 4530.4 4537.9 4539.3 4547.2 4549.2 4598.4 4600.1 4601.6 4606.6 4612.7 5450.8 5451.9 5452.3 5456.7 5466.3 6544.5 6787.0 6851.8 6855.9 6861.9 1567.4 1570.4 1592.2 1595.3 1597.3 965.6 1013.1 1016.4 1025.2 1039.2 6127.9 6273.0 6505.6 6510.7 6512.0 7041.9 7200.5 7205.7 7214.0 7214.2 6473.7 6476.7 6487.0 6492.8 6504.5 3724.1 3765.6 3772.4 3774.0 3780.6 6010.7 6047.5 7181.9 7468.4 7478.3 7315.6 7363.7 7374.7 7380.1 7414.1 6108.8 7399.0 7457.7 7458.4 7465.6 7139.4 7144.5 7145.9 7148.4 7151.2 6742.7 6995.9 7021.7 7022.2 7047.1 7420.4 7441.5 7446.9 7453.9 7467.5 4533.7 4534.1 4538.9 4539.9 4540.6 7083.3 7109.5 7109.9 7112.1 7128.8 6530.2 6837.1 6865.7 6893.5 6893.5 6341.1 6443.4 6808.8 6867.5 6885.2 6698.8 6700.5 6701.6 6706.6 6732.8 6851.6 6852.0 6858.6 6877.1 6885.6 5231.7 6453.3 6567.0 6568.6 6638.7 08:55:45 INFO - PROCESS | 1666 | 08:55:45 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17555.70 Median:30430.58 stddev:23993.19 (78.8%) stddev-sans-first:24027.31 08:55:45 INFO - PROCESS | 1666 | Values: 750.2 759.8 762.8 768.8 771.8 13572.5 15050.4 15055.6 15084.3 15188.0 13825.0 13874.6 13917.5 13946.2 13951.3 722.8 734.4 908.1 917.7 931.5 919.4 924.3 928.6 928.7 929.0 998.7 999.3 1000.3 1001.1 1002.0 757.3 961.1 980.1 980.2 992.7 734.5 734.5 735.1 736.1 736.6 14745.3 14769.9 14791.6 14802.6 14825.9 10669.6 11734.6 12248.3 12266.4 12613.5 9539.3 9966.4 10026.5 10095.7 10364.1 3451.1 3528.0 3541.3 3607.7 3619.5 77686.2 78110.0 78370.0 78634.6 79296.6 9493.9 9539.7 9608.2 9625.6 9960.3 21755.2 21800.8 21810.9 21830.5 21841.0 7295.5 7430.3 7446.8 7517.4 7662.0 3941.7 3997.7 4004.3 4012.6 4079.3 3572.2 3625.9 3633.6 3634.5 3638.3 624.3 650.3 655.4 662.2 669.4 544.1 570.6 577.6 586.3 615.3 8089.5 8207.3 8250.7 8339.1 8405.0 575.3 582.8 592.2 606.2 618.6 3843.2 3846.5 3875.7 3912.6 3947.9 60255.0 77644.6 77785.6 84349.0 87252.0 56829.0 72947.6 78595.0 83585.3 84597.6 66518.3 66913.0 67528.0 68777.7 75007.6 6951.5 8280.5 8392.1 8565.0 8622.9 49002.8 50218.2 50716.0 50998.5 51770.0 56499.0 59706.7 61456.5 64500.0 66673.3 9417.7 11539.4 11546.2 11624.6 11858.7 11869.7 11885.5 12027.2 12079.0 13079.1 11392.8 11410.7 11441.7 11770.2 11848.8 11302.6 11312.4 11351.7 11686.0 12039.8 11003.4 11036.8 11509.2 11623.9 11915.9 9484.6 9515.7 9551.0 9585.2 9865.1 8145.6 9282.7 9300.9 9630.2 9769.3 08:55:45 INFO - PROCESS | 1666 | -------- Summary: end -------- 08:55:45 INFO - PROCESS | 1666 | 08:55:46 INFO - TEST-INFO | 1666: exit 0 08:55:46 INFO - TEST-OK | dromaeo_css | took 1113697ms 08:55:46 INFO - TEST-START | kraken 08:55:46 INFO - operating with platform_type : mac_ 08:55:46 INFO - Initialising browser for kraken test... 08:55:46 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpc_551E/profile http://localhost:49270/getInfo.html) 08:55:48 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 08:55:48 INFO - PROCESS | 1676 | colorDepth:24 08:55:48 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 08:55:48 INFO - PROCESS | 1676 | __metrics 08:55:48 INFO - PROCESS | 1676 | 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" 08:55:48 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:49 INFO - TEST-INFO | 1676: exit 0 08:55:49 INFO - Browser initialized. 08:55:49 INFO - Running cycle 1/1 for kraken test... 08:55:49 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpc_551E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:01 INFO - PROCESS | 1678 | RSS: Main: 245706752 08:56:01 INFO - PROCESS | 1678 | 08:56:04 INFO - PROCESS | 1678 | 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) 08:56:04 INFO - PROCESS | 1678 | RSS: Main: 290115584 08:56:04 INFO - PROCESS | 1678 | 08:56:07 INFO - PROCESS | 1678 | 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) 08:56:07 INFO - PROCESS | 1678 | RSS: Main: 301195264 08:56:07 INFO - PROCESS | 1678 | 08:56:11 INFO - PROCESS | 1678 | 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) 08:56:11 INFO - PROCESS | 1678 | RSS: Main: 284774400 08:56:11 INFO - PROCESS | 1678 | 08:56:13 INFO - PROCESS | 1678 | 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) 08:56:14 INFO - PROCESS | 1678 | RSS: Main: 287682560 08:56:14 INFO - PROCESS | 1678 | 08:56:16 INFO - PROCESS | 1678 | 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) 08:56:17 INFO - PROCESS | 1678 | RSS: Main: 288460800 08:56:17 INFO - PROCESS | 1678 | 08:56:20 INFO - PROCESS | 1678 | 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) 08:56:20 INFO - PROCESS | 1678 | RSS: Main: 290353152 08:56:20 INFO - PROCESS | 1678 | 08:56:23 INFO - PROCESS | 1678 | 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) 08:56:24 INFO - PROCESS | 1678 | RSS: Main: 288866304 08:56:24 INFO - PROCESS | 1678 | 08:56:26 INFO - PROCESS | 1678 | 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) 08:56:27 INFO - PROCESS | 1678 | RSS: Main: 289808384 08:56:27 INFO - PROCESS | 1678 | 08:56:28 INFO - PROCESS | 1678 | 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) 08:56:29 INFO - PROCESS | 1678 | RSS: Main: 324567040 08:56:29 INFO - PROCESS | 1678 | 08:56:31 INFO - PROCESS | 1678 | 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) 08:56:31 INFO - PROCESS | 1678 | RSS: Main: 324468736 08:56:31 INFO - PROCESS | 1678 | 08:56:33 INFO - PROCESS | 1678 | 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) 08:56:34 INFO - PROCESS | 1678 | RSS: Main: 332419072 08:56:34 INFO - PROCESS | 1678 | 08:56:37 INFO - PROCESS | 1678 | 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) 08:56:37 INFO - PROCESS | 1678 | RSS: Main: 333516800 08:56:37 INFO - PROCESS | 1678 | 08:56:40 INFO - PROCESS | 1678 | 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) 08:56:40 INFO - PROCESS | 1678 | RSS: Main: 333819904 08:56:40 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | 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) 08:56:42 INFO - PROCESS | 1678 | RSS: Main: 394477568 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | __start_tp_report 08:56:42 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 08:56:42 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 08:56:42 INFO - PROCESS | 1678 | |i|pagename|runs| 08:56:42 INFO - PROCESS | 1678 | |0;ai-astar;111;108;111;110;112;111;117;111;110;110 08:56:42 INFO - PROCESS | 1678 | |1;audio-beat-detection;153;120;143;160;122;142;139;120;161;119 08:56:42 INFO - PROCESS | 1678 | |2;audio-dft;187;184;184;187;184;185;185;184;220;257 08:56:42 INFO - PROCESS | 1678 | |3;audio-fft;74;79;84;78;57;57;58;79;76;55 08:56:42 INFO - PROCESS | 1678 | |4;audio-oscillator;96;130;173;95;78;86;113;77;80;114 08:56:42 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;95;108;113;87;87;85;89;86;87;84 08:56:42 INFO - PROCESS | 1678 | |6;imaging-darkroom;126;93;93;93;91;92;93;94;93;93 08:56:42 INFO - PROCESS | 1678 | |7;imaging-desaturate;87;86;86;86;88;85;85;84;86;87 08:56:42 INFO - PROCESS | 1678 | |8;json-parse-financial;56;55;54;53;53;53;53;63;59;61 08:56:42 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;68;66;81;73;70;69;66;69;68;68 08:56:42 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;82;82;82;82;82;82;82;82;84 08:56:42 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;120;123;134;130;149;127;106;126;117;128 08:56:42 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;138;127;139;138;138;128;143;139;136;138 08:56:42 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;57;65;65;68;67;66;69;67;67;68 08:56:42 INFO - PROCESS | 1678 | __end_tp_report 08:56:42 INFO - PROCESS | 1678 | __start_cc_report 08:56:42 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1235 08:56:42 INFO - PROCESS | 1678 | __end_cc_report 08:56:42 INFO - PROCESS | 1678 | __startTimestamp1457456202814__endTimestamp 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | ------- Summary: start ------- 08:56:42 INFO - PROCESS | 1678 | Number of tests: 14 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:2.47 08:56:42 INFO - PROCESS | 1678 | Values: 111.0 108.0 111.0 110.0 112.0 111.0 117.0 111.0 110.0 110.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:142.50 stddev:16.82 (11.8%) stddev-sans-first:16.92 08:56:42 INFO - PROCESS | 1678 | Values: 153.0 120.0 143.0 160.0 122.0 142.0 139.0 120.0 161.0 119.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:195.70 Median:186.00 stddev:24.21 (13.0%) stddev-sans-first:25.48 08:56:42 INFO - PROCESS | 1678 | Values: 187.0 184.0 184.0 187.0 184.0 185.0 185.0 184.0 220.0 257.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.70 Median:77.00 stddev:11.45 (14.9%) stddev-sans-first:12.04 08:56:42 INFO - PROCESS | 1678 | Values: 74.0 79.0 84.0 78.0 57.0 57.0 58.0 79.0 76.0 55.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:79.00 stddev:29.94 (37.9%) stddev-sans-first:31.61 08:56:42 INFO - PROCESS | 1678 | Values: 96.0 130.0 173.0 95.0 78.0 86.0 113.0 77.0 80.0 114.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:87.00 stddev:10.21 (11.7%) stddev-sans-first:10.78 08:56:42 INFO - PROCESS | 1678 | Values: 95.0 108.0 113.0 87.0 87.0 85.0 89.0 86.0 87.0 84.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:93.00 stddev:10.54 (11.3%) stddev-sans-first:0.83 08:56:42 INFO - PROCESS | 1678 | Values: 126.0 93.0 93.0 93.0 91.0 92.0 93.0 94.0 93.0 93.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 08:56:42 INFO - PROCESS | 1678 | Values: 87.0 86.0 86.0 86.0 88.0 85.0 85.0 84.0 86.0 87.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.71 (6.7%) stddev-sans-first:3.94 08:56:42 INFO - PROCESS | 1678 | Values: 56.0 55.0 54.0 53.0 53.0 53.0 53.0 63.0 59.0 61.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:4.42 (6.4%) stddev-sans-first:4.64 08:56:42 INFO - PROCESS | 1678 | Values: 68.0 66.0 81.0 73.0 70.0 69.0 66.0 69.0 68.0 68.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 08:56:42 INFO - PROCESS | 1678 | Values: 82.0 82.0 82.0 82.0 82.0 82.0 82.0 82.0 82.0 84.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:11.25 (8.8%) stddev-sans-first:11.73 08:56:42 INFO - PROCESS | 1678 | Values: 120.0 123.0 134.0 130.0 149.0 127.0 106.0 126.0 117.0 128.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:138.00 stddev:5.02 (3.6%) stddev-sans-first:5.29 08:56:42 INFO - PROCESS | 1678 | Values: 138.0 127.0 139.0 138.0 138.0 128.0 143.0 139.0 136.0 138.0 08:56:42 INFO - PROCESS | 1678 | 08:56:42 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:67.00 stddev:3.38 (5.0%) stddev-sans-first:1.36 08:56:42 INFO - PROCESS | 1678 | Values: 57.0 65.0 65.0 68.0 67.0 66.0 69.0 67.0 67.0 68.0 08:56:42 INFO - PROCESS | 1678 | -------- Summary: end -------- 08:56:42 INFO - PROCESS | 1678 | 08:56:43 INFO - TEST-INFO | 1678: exit 0 08:56:43 INFO - TEST-OK | kraken | took 57117ms 08:56:43 INFO - SUITE-END | took 1170s 08:56:43 INFO - Completed test suite (00:19:31) 08:56:43 INFO - javascript benchmark 08:56:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3149.4016136933983, 3444.7416443766706, 3468.445048792193, 3470.8785192518267, 3515.17393412548, 5308.0, 5519.39286678465, 5563.554915606752, 5587.022271102556, 5598.552115830734, 5528.695921724304, 5586.720663966806, 5588.692621905793, 5704.201411802351, 5712.371639119693, 4899.240617704244, 5020.447750747424, 5045.823396181135, 5058.848234552951, 5198.506141916512, 5127.589792816584, 5130.692158470485, 5135.255387968742, 5151.278820965068, 5162.406323272834, 4979.900401991958, 5017.448080711119, 5074.873128171788, 5120.667156634807, 5154.969006198738, 5025.1708468102715, 5039.294498770175, 5048.444671086214, 5054.545090941796, 5112.258722485219, 4967.975160124212, 4983.501649835024, 5010.423801262828, 5018.096742586333, 5036.370453693288, 5407.432219616923, 5479.561635069185, 5511.559075273968, 5527.613067085305, 5623.662580245198, 6028.608140470856, 6047.395260473917, 6052.182955301022, 6054.606450580698, 6054.939450605481, 5350.35795704514, 6117.969410152965, 6126.816195514141, 6136.815895523141, 6138.232720909887, 5488.231647569343, 5560.971220324253, 5595.608307418523, 5595.804146854841, 5658.632188907708, 6248.75004999804, 6255.155554000152, 6264.060390941304, 6284.780032698925, 6293.622382657055, 5976.970115149396, 6006.429389208019, 6042.818715438544, 6056.939430605637, 6059.091136329585, 5968.791092311748, 6079.878402432015, 6118.4364438206485, 6136.917362303815, 6150.261968563801, 6110.4980065817745, 6126.27339965311, 6136.746076527064, 6142.06524944641, 6148.6925653717135, 6102.246889800143, 6119.796206005239, 6130.000698177752, 6141.877162456815, 6142.78500252489, 4705.1765940960195, 4729.976350118296, 4782.593479554207, 4786.832460863853, 4833.782479788348, 4327.675424343187, 4353.73877567347, 4358.6295164911335, 4377.9781101094295, 4387.3857659927635, 5595.328560572676, 5596.1605759136455, 5603.075492543685, 5605.411431799684, 5610.13042978339, 6084.636441487559, 6087.740325088945, 6111.470193407285, 6203.844903877349, 6208.906866397007, 5603.991281569357, 5645.350784659735, 5651.886962260732, 5685.943140568541, 5691.8861622768145, 5214.217867319857, 5253.474652534716, 5274.815381461631, 5276.762545685453, 5320.17537281722, 6175.0, 6192.721327540272, 6193.659348735863, 6222.968885155636, 6241.500679945593, 6191.5665903388135, 6196.535259855619, 6199.783007594712, 6200.286966998853, 6215.0, 6189.226346706661, 6200.720967556381, 6215.192025036717, 6221.471174949999, 6229.719662615103, 5932.9703351484695, 5989.011813050798, 6062.969685151546, 6073.787417440369, 6134.754609815557, 5234.633575649668, 6146.385361463817, 6164.229471316085, 6168.938310616836, 6172.4136207060255, 5827.3007239131575, 5911.438413350725, 5922.407759224043, 5956.612820166675, 5974.2233509643465, 5728.112142617901, 5846.9183201107935, 5921.230240068763, 5940.970295148497, 5992.520598352208, 5558.194061860927, 5734.7132643368495, 5763.308402991668, 5771.451712087345, 5784.4504772046585, 5757.251557297524, 5927.110933360031, 5928.79249226275, 5940.405959404025, 6000.21997140369, 5681.119426488901, 5701.714914254354, 5704.686242256716, 5718.914216286842, 5745.770169193353], "unit": "score", "name": "dojo.html", "value": 5573.097343498246}, {"lowerIsBetter": false, "replicates": [479.2451888275966, 558.0903127901522, 585.537425433907, 609.8597322615797, 642.8907085795415, 29580.112596622082, 30363.240918977037, 37850.0, 38222.04444888872, 38321.616783832156, 40590.0, 41066.178676426454, 41095.0, 41136.38295425571, 41209.0, 9388.0, 9618.470984095871, 9625.663101791439, 9630.988746181654, 9649.083337082966, 9417.293702972305, 9534.856977145348, 9538.189253913426, 9551.85672214914, 9566.904330956671, 8367.456115352514, 8421.326293896474, 9509.904900951005, 9617.182539484153, 9632.84405871293, 8440.324774018063, 9679.370840895319, 9690.806183876282, 9691.563879625433, 9699.981501942335, 9581.0, 9672.516374181263, 9681.903180968171, 9701.611935522642, 9707.369021013612, 40339.0, 40797.0, 40823.59176408257, 40853.57012504578, 40877.59122408768, 3253.609566851993, 3265.4122257993554, 3406.3017081498233, 3477.2176260341475, 3663.303972245265, 23236.883815580983, 28390.148295551167, 28587.428251434856, 28596.856125754945, 28846.42307153845, 2722.0744946718014, 2734.3027527980435, 2743.903963361293, 2772.9306767330777, 2859.914202573905, 487212.0, 488597.0, 488899.0, 489414.0, 490470.99999999645, 55226.34320970377, 62082.0, 62392.68803655953, 62463.0, 62489.687551561954, 63710.36289637137, 71363.64318178479, 72072.63963680148, 72325.6383718078, 72413.63793181106, 16281.185940702917, 16536.677065834705, 16779.91610041942, 16798.076105814296, 16830.57923551921, 12703.237805731686, 12789.104762666524, 12798.0, 12800.551980680631, 12819.230846149261, 17387.435130838287, 20747.68878466824, 20773.065212065492, 21024.26415075465, 21037.263695770576, 9424.717258482257, 9677.516124193762, 9684.806303873884, 9705.369151005161, 9759.951200243953, 945.7541039329824, 969.5636963366513, 990.5641517732175, 1021.2953062386929, 1121.4560937945091, 28827.0, 28997.7100228995, 29226.41547169045, 29464.705352946625, 29673.406531869674, 1027.7893031928436, 1130.2427373659668, 1133.812920868064, 1136.4261048170622, 1220.2190598017098, 14660.56018319452, 14693.706125877423, 14811.111333320036, 15120.697586048438, 15132.773008404884, 479572.6021369871, 528023.0, 537769.0, 545071.1196660267, 545760.0, 56790.0, 58903.705481472316, 58934.70532647309, 59052.0, 59111.0, 1342.6509107631891, 1362.9182249065088, 1483.3102607287447, 1504.5110339139824, 1635.9611646604492, 26351.0, 28038.971621101562, 28194.43611127725, 28762.568561471177, 29104.27239319034, 44239.778801105786, 44317.556824432635, 44792.77603611961, 44996.55003450054, 45133.32300015568, 279306.6034669814, 279316.0, 279568.0, 279871.2012879845, 280087.0, 28079.859600701864, 29693.554596680635, 32001.0, 32915.83542082274, 33401.66598333986, 40517.581884633895, 40861.795691021354, 41249.96875078147, 41887.58112418837, 42087.158256835304, 34151.487727683605, 35258.94223173309, 35341.64658353384, 35983.46024809578, 36043.459348109274, 31829.8859539915, 33920.06398880236, 34071.65928340784, 34828.30343393169, 34936.9518914433, 35631.46552801658, 35826.74606388764, 36688.63311366852, 36792.0, 36801.26397471982, 30941.91703290464, 31911.361772764878, 32128.678713213503, 32194.67805321917, 32240.83879580587, 19729.901350493157, 20634.27780027692, 23334.0, 23626.881865590563, 24244.0], "unit": "score", "name": "ext.html", "value": 19275.59726570493}, {"lowerIsBetter": false, "replicates": [352.6297387742869, 354.36745409444137, 361.2594181927049, 363.1520399866312, 363.41127373654683, 19796.0, 20068.0, 21598.99999999998, 21625.567488650217, 21640.891795541, 19953.900230498828, 20269.797302026975, 20903.581928361422, 21002.89498552509, 21008.05463754131, 5838.9124163137485, 5992.161097446339, 6047.879042419149, 6051.848703782419, 6066.514678825683, 4194.790260486979, 4270.466191726035, 4364.361187828196, 5394.7842086316505, 6284.591501552407, 5597.972010139943, 6553.311902250267, 6592.6703664816805, 6592.901106483407, 6594.802155935329, 5519.69641669708, 5837.270341207349, 5851.268591426072, 6569.835754106138, 6571.539992200548, 3738.0, 3915.4714113594587, 5395.973020134874, 5630.943690563083, 5631.986242476352, 13039.869601304055, 13196.14225075367, 13280.933595332059, 19195.424137275764, 24570.754292457026, 2072.274703853654, 2082.6563617003326, 2095.549456866781, 2141.6145093883097, 2152.4726442021806, 9544.284178686627, 9621.18219951305, 9665.90334096664, 9999.200063994864, 10045.296829221885, 1716.519374575121, 1740.3647668600995, 1809.1677828199045, 1830.130687923239, 1922.807859127336, 97538.51230743872, 100089.9982000356, 102792.0, 105497.0, 107277.92722072758, 9241.3531052827, 11097.33415995043, 11162.939520745516, 11225.550977960791, 11296.435178241056, 13700.314984250947, 13816.37826297819, 13857.514986975408, 13862.514811981733, 13892.09701369428, 6784.694688739019, 8627.6980305689, 8643.17889800468, 8724.258438032712, 8745.956270218609, 7646.23537646242, 8337.583120843934, 8839.0, 8841.381103322834, 8943.731688049369, 4442.289233722653, 4534.206513860127, 4535.886602834956, 4575.290829921368, 4576.473705523841, 1802.567383827872, 1870.326682394337, 1876.718492226177, 1878.6618408686568, 1879.586490971984, 887.5118684723506, 914.9085091490798, 991.2268430623981, 997.4713401896861, 1025.7179275699243, 19089.0, 19375.90312048431, 19841.900790496245, 19957.20171193136, 20665.55690526544, 822.116225058065, 891.4963045879058, 893.9821203575892, 950.5437390052813, 970.5777986575721, 6764.93235067643, 10942.4528773561, 11018.338899666045, 11027.779444411068, 11098.944505277583, 634781.0, 647853.7607312028, 649445.0332980036, 650180.0, 665295.0, 101805.0, 117594.41202793931, 122270.0, 122514.77485225211, 128515.35742321229, 1040.7138037039724, 1052.578968412641, 1055.4142450939803, 1070.7269646240159, 1074.1997212076897, 14983.7003259932, 17945.461636150936, 18266.178021989308, 18308.90845545817, 18359.888612809696, 50484.49515504798, 50641.74679126581, 51002.41057659089, 51557.0, 52475.73762131165, 73748.26251737414, 74093.0, 74675.0, 74954.0, 77501.0, 7984.0, 8073.313768329758, 8151.184881511801, 8230.876536852073, 8406.621702023302, 9694.5152742364, 13288.0, 13345.266010369134, 13456.25990570528, 13681.247531385869, 11327.433628318717, 11545.653630391102, 11663.358515281741, 11794.410279485819, 11811.527538898348, 8227.873328417336, 11106.50020749052, 11244.26912250701, 11667.708307292047, 11759.0, 9039.68361107358, 10116.848247276444, 10552.630657926935, 11788.76422471563, 12032.819507707216, 8093.797655058671, 8101.392395570238, 8203.507789532647, 8228.341732661493, 8239.835203295781, 8678.262347700263, 11457.656270311903, 11694.4737486815, 11711.355875426932, 11837.940810295893], "unit": "score", "name": "jquery.html", "value": 9247.611220934059}, {"lowerIsBetter": false, "replicates": [1352.2427440633244, 1443.3721331220927, 1632.836716328367, 1843.4285371534818, 2047.1299697628513, 7903.091144518375, 8465.57672116394, 8633.611487483062, 8640.524771137585, 8645.135486451352, 8272.875906861402, 8503.659853605848, 8509.829803403929, 8519.616617252223, 8521.91478085219, 2139.1336508713994, 2192.177933275022, 2193.967090493644, 2437.2200895713336, 2459.213051823417, 2426.599611064172, 2494.239257026606, 2497.500499900018, 2498.038255271724, 2503.4617557225192, 2365.526894621074, 2400.3639035655565, 2400.4838959623676, 2418.9840267087866, 2420.854748715074, 2426.8543887366814, 2435.6224785158242, 2436.756324367567, 2446.559619268531, 2461.1755062054235, 2438.878056097188, 2439.329184474266, 2439.621858611918, 2441.816863735227, 2460.4218008767925, 7984.880226796603, 8061.435699501038, 8694.913050869474, 8748.125187481264, 8766.430182038148, 5278.656887302313, 5421.159720243369, 5457.154141108134, 5467.972660136714, 5472.0, 3493.930121397583, 3618.5295911531593, 3635.1820840310984, 3642.981785091084, 3672.577653569847, 1032.4012072997643, 1051.9421431821247, 1053.1416895230363, 1055.4036969112426, 1063.4310643805604, 11853.762924741543, 11880.465379057876, 11881.108916831272, 11881.821772673416, 11926.224795388358, 4769.689970151929, 4824.517548245148, 4880.560749532559, 4883.0, 4907.533784290558, 9860.605575776888, 9860.950695246478, 9864.358816676893, 9870.901290986998, 9892.307538472382, 5385.299911011543, 5421.566274698014, 5438.483344082306, 5447.155690867922, 5480.369757477862, 4361.869143925687, 4544.227481328182, 4714.740689262124, 4893.972265824217, 4933.309336692866, 3839.117003089305, 3879.7866117363815, 3927.509061367329, 3929.4695216146024, 3950.841966321315, 1289.5357671238346, 1308.640123965898, 1314.5530519623373, 1322.9470821167238, 1326.6882282663566, 1282.6344491819973, 1286.5175559165314, 1305.8171855940177, 1355.0920883008407, 1356.220173400279, 7967.641456134488, 8242.29940455056, 8278.461899976483, 8286.58567071644, 8293.668253269921, 1178.5757127434117, 1200.5197920831563, 1204.4880925606583, 1207.7161866961258, 1235.1292338901053, 6169.383061693795, 6208.689565521706, 6242.906356404657, 6247.96876015617, 6253.218347706536, 10200.795984080276, 10440.791184176425, 10461.110805581458, 10467.214958878114, 10559.524821383056, 9803.411795292306, 10481.633142839964, 10486.213533984981, 10519.053285204369, 10590.887956764429, 7878.763637090897, 7954.0, 8008.27925486709, 8084.717034903868, 8104.797380065427, 7783.92216077832, 7790.5325680459355, 7823.374130069467, 7878.960605196938, 7881.645325960231, 8007.35941124697, 8710.390272680852, 9026.323025773225, 9240.0, 9260.53697315118, 9246.815063698554, 9507.144357007903, 9690.854637180308, 9717.757056073371, 9732.902670973199, 6505.902411463927, 6700.46396288286, 6725.0, 7332.5967071811565, 7458.47790654649, 7185.353318201387, 7716.459847810599, 7718.382529397747, 7726.0342457192855, 7727.729529466442, 6114.327423983447, 7260.310270524292, 7297.270272972661, 7387.852242955219, 7432.145303290191, 7062.717491300496, 7149.60677162761, 7221.205667376479, 7257.818554536178, 7371.963140184264, 7469.5891725953425, 7592.4305677073335, 7663.386929045551, 7663.540187588763, 7674.424418168548, 6857.794266172023, 6937.479689023243, 6951.16586009682, 6953.991671207546, 6979.895301570582, 6975.965120174366, 7054.329838665319, 7064.293570642894, 7071.681774320065, 7071.681774320271], "unit": "score", "name": "mootools.html", "value": 4876.276057404292}, {"lowerIsBetter": false, "replicates": [316.90334447993365, 326.74513879174236, 327.9049075768027, 332.37845229420986, 337.2714935738806, 5154.381474223093, 6361.872762544752, 6427.068075129104, 6427.228732552088, 6444.96777516113, 6314.7789827356055, 6356.68216589171, 6358.141650877142, 6360.204974378203, 6374.426301632852, 4550.453945526525, 4628.583427491525, 4665.9066818663605, 4756.096341695067, 4782.28265760137, 4307.655387568987, 4546.590556927346, 4732.503087175849, 4733.905321893577, 4758.500357462469, 4707.576318131368, 4709.2229782085915, 4725.976370118145, 4748.928766068511, 4752.667313288071, 4470.061287129723, 4551.772411379451, 4681.993371425126, 4749.525047495257, 4752.59602933751, 3364.52896594477, 3501.9669197586772, 4069.8168582413864, 4088.9386659200136, 4097.201045796071, 6109.847253818646, 6114.0, 6154.230721159855, 6156.261248650146, 6177.907331390033, 5564.054110801174, 5577.52591029763, 5581.162825576155, 5604.075327570946, 5606.467385598403, 5357.8392648220615, 5865.501432378253, 6774.356436138559, 6778.356056174655, 6780.254172041072, 4247.469066366704, 4255.63827074699, 4358.735966569691, 4408.20652282589, 4582.404287442611, 6144.907826382608, 7181.389581885546, 7196.280371962762, 7218.783436496913, 7218.8917166242545, 4530.411046563926, 4537.909241815211, 4539.275075471366, 4547.204239258117, 4549.249373853278, 4598.379218805485, 4600.125976064604, 4601.608863246662, 4606.56237657422, 4612.723236605814, 5450.809221677222, 5451.945480545223, 5452.318460192476, 5456.699881506476, 5466.34403871538, 6544.476441884638, 6786.966065169642, 6851.794446166623, 6855.897161542581, 6861.897071543931, 1567.396552327362, 1570.3797000184863, 1592.16411384022, 1595.3219881550294, 1597.25727536696, 965.6427121964778, 1013.0527956360826, 1016.3800081950004, 1025.2413214221422, 1039.210200247817, 6127.908081378783, 6273.0, 6505.60966342021, 6510.739570417225, 6511.967440162864, 7041.929580704127, 7200.459965502609, 7205.675744591506, 7213.963930180315, 7214.242504537053, 6473.676316184172, 6476.740930362827, 6486.967565162144, 6492.772752953719, 6504.5121615879, 3724.0689827543115, 3765.585785563586, 3772.3775577030033, 3774.037620406779, 3780.6219378061974, 6010.699465026819, 6047.516198704093, 7181.856362872713, 7468.365188958999, 7478.326950574475, 7315.561066336037, 7363.705451781976, 7374.668139933716, 7380.077490313711, 7414.147373052168, 6108.7861924833305, 7399.038125043818, 7457.738979135921, 7458.366038886756, 7465.552066876005, 7139.357457828821, 7144.464165187528, 7145.892811607726, 7148.4281257500315, 7151.2491188424465, 6742.730290788313, 6995.860082798214, 7021.719131234693, 7022.157341119098, 7047.083879095685, 7420.40636749048, 7441.479096463412, 7446.920196571575, 7453.850922981618, 7467.477276590586, 4533.682642215013, 4534.093181363674, 4538.909221815479, 4539.863804085882, 4540.614047805841, 7083.327083927019, 7109.537880037988, 7109.857802844018, 7112.075430194249, 7128.750493732695, 6530.151080359523, 6837.145356830396, 6865.725370985105, 6893.482988775761, 6893.517453778188, 6341.0805433212845, 6443.420092191725, 6808.795736127924, 6867.450603951572, 6885.173779146535, 6698.83252918681, 6700.530962832555, 6701.631410272482, 6706.597604143767, 6732.831679208059, 6851.588904665736, 6852.0, 6858.6227757471825, 6877.140357455318, 6885.552439091443, 5231.712255825814, 6453.290138084713, 6566.967165164144, 6568.638724870178, 6638.668066596554], "unit": "score", "name": "prototype.html", "value": 4975.467044666672}, {"lowerIsBetter": false, "replicates": [750.182301291592, 759.7948553890446, 762.7787941496966, 768.8423873106012, 771.7761849063771, 13572.524961626345, 15050.397984080624, 15055.623609409757, 15084.32120554575, 15188.0, 13825.032247742662, 13874.583762487142, 13917.512887048955, 13946.23295718735, 13951.302434878266, 722.8482018776037, 734.4418242135988, 908.1191244492832, 917.7430319510531, 931.5249222896338, 919.3610440743686, 924.3344791749963, 928.5728564860138, 928.6563971330617, 929.0384452092086, 998.6804222648756, 999.3254553176613, 1000.2997901468965, 1001.1040119093443, 1002.0230275481384, 757.2768006553728, 961.1061712607342, 980.0836218136066, 980.1668581705565, 992.7220378294053, 734.4821900560092, 734.5115498193695, 735.0811485642946, 736.065197199559, 736.5727877830899, 14745.262736863115, 14769.926150369287, 14791.630209244855, 14802.555923322318, 14825.925870370687, 10669.573217071307, 11734.647960561197, 12248.326342051183, 12266.448009839489, 12613.495460181673, 9539.332246742732, 9966.398149664778, 10026.548805303706, 10095.697129086138, 10364.067233948981, 3451.137215696076, 3528.0474271946687, 3541.3448512025357, 3607.7474576779637, 3619.457081437779, 77686.22313776903, 78110.0, 78370.0, 78634.6068269655, 79296.60351698204, 9493.90506094944, 9539.713808585753, 9608.231341492663, 9625.614975401046, 9960.252981026451, 21755.238566650092, 21800.781992179876, 21810.890945545172, 21830.45423864416, 21841.0, 7295.52579082358, 7430.28794490018, 7446.813829654194, 7517.398608111338, 7662.0, 3941.7043721720984, 3997.709904662347, 4004.3192657248337, 4012.6388625023887, 4079.347304431277, 3572.2319701264355, 3625.9093522661615, 3633.5639723232853, 3634.545681789776, 3638.272345530904, 624.3382015064046, 650.278191207759, 655.4199533412964, 662.1822049768532, 669.4142625202948, 544.0940833512237, 570.5606682854179, 577.5812535911431, 586.2730214533947, 615.2555407956423, 8089.47418417801, 8207.302379297827, 8250.669973201006, 8339.12439193888, 8405.0, 575.2607898849958, 582.8338923406809, 592.2330581896455, 606.1513880567242, 618.5700937848243, 3843.2374186854017, 3846.480725102131, 3875.7210120660116, 3912.5891781363116, 3947.921041579152, 60255.0, 77644.61177694076, 77785.61107194428, 84349.0, 87252.0, 56829.0, 72947.63526182335, 78595.0, 83585.32829343379, 84597.57701211577, 66518.33481665218, 66912.99630505547, 67528.0, 68777.65611172012, 75007.62496187484, 6951.513394062367, 8280.544570048705, 8392.076871544248, 8564.989476192199, 8622.870656940026, 49002.84334790474, 50218.22490413503, 50716.0, 50998.490015100855, 51770.0, 56499.0, 59706.70146649239, 61456.46358841065, 64500.0, 66673.33326666865, 9417.670381536613, 11539.36533490666, 11546.19176657626, 11624.593139240085, 11858.703532411413, 11869.708138260852, 11885.465154067915, 12027.21823081497, 12079.033677305619, 13079.149855259378, 11392.772144556897, 11410.657680269605, 11441.713957150805, 11770.234934729215, 11848.822267666164, 11302.604408845651, 11312.377819220023, 11351.659450216506, 11686.006689431493, 12039.819402709141, 11003.449827508754, 11036.834447483454, 11509.228016487243, 11623.941880290882, 11915.927566519054, 9484.620615175316, 9515.714528564155, 9550.95224523873, 9585.233181345337, 9865.143725110978, 8145.551994640115, 9282.72151835446, 9300.860487092834, 9630.229581633312, 9769.31614786958], "unit": "score", "name": "yui.html", "value": 6861.499901967349}], "name": "dromaeo_css", "value": 7408.866404125114}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 110.0, 112.0, 111.0, 117.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 143.0, 160.0, 122.0, 142.0, 139.0, 120.0, 161.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.9}, {"lowerIsBetter": true, "replicates": [187.0, 184.0, 184.0, 187.0, 184.0, 185.0, 185.0, 184.0, 220.0, 257.0], "unit": "score", "name": "audio-dft", "value": 195.7}, {"lowerIsBetter": true, "replicates": [74.0, 79.0, 84.0, 78.0, 57.0, 57.0, 58.0, 79.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [96.0, 130.0, 173.0, 95.0, 78.0, 86.0, 113.0, 77.0, 80.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 104.2}, {"lowerIsBetter": true, "replicates": [95.0, 108.0, 113.0, 87.0, 87.0, 85.0, 89.0, 86.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.1}, {"lowerIsBetter": true, "replicates": [126.0, 93.0, 93.0, 93.0, 91.0, 92.0, 93.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 96.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 86.0, 86.0, 88.0, 85.0, 85.0, 84.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 53.0, 53.0, 53.0, 63.0, 59.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 81.0, 73.0, 70.0, 69.0, 66.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [120.0, 123.0, 134.0, 130.0, 149.0, 127.0, 106.0, 126.0, 117.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [138.0, 127.0, 139.0, 138.0, 138.0, 128.0, 143.0, 139.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [57.0, 65.0, 65.0, 68.0, 67.0, 66.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1429.1000000000001}]} 08:56:44 INFO - Return code: 0 08:56:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:44 INFO - # TBPL SUCCESS # 08:56:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:44 INFO - 2016-03-08 08:56:44.120 screenresolution[1682:9627] starting screenresolution argv=screenresolution get 08:56:44 INFO - 2016-03-08 08:56:44.123 screenresolution[1682:9627] Display 0: 1600x1200x32@60 08:56:44 INFO - 2016-03-08 08:56:44.128 screenresolution[1683:9630] starting screenresolution argv=screenresolution list 08:56:44 INFO - Available Modes on Display 0 08:56:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:44 INFO - Intel Iris: 08:56:44 INFO - Chipset Model: Intel Iris 08:56:44 INFO - Type: GPU 08:56:44 INFO - Bus: Built-In 08:56:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:44 INFO - Vendor: Intel (0x8086) 08:56:44 INFO - Device ID: 0x0a2e 08:56:44 INFO - Revision ID: 0x0009 08:56:44 INFO - Displays: 08:56:44 INFO - Display: 08:56:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:44 INFO - Display Serial Number: 1600x1200 60 08:56:44 INFO - Main Display: Yes 08:56:44 INFO - Mirror: Off 08:56:44 INFO - Online: Yes 08:56:44 INFO - Rotation: Supported 08:56:44 INFO - Return code: 0 08:56:44 INFO - Running post-action listener: _resource_record_post_action 08:56:44 INFO - Running post-run listener: _resource_record_post_run 08:56:45 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39417344; Write bytes: 704492032; Read time: 498; Write time: 1890 08:56:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402553344; Write bytes: 404257792; Read time: 30236; Write time: 738 08:56:45 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 37635584; Write bytes: 299337216; Read time: 479; Write time: 1148 08:56:45 INFO - Running post-run listener: _upload_blobber_files 08:56:45 INFO - Blob upload gear active. 08:56:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:45 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 08:56:45 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'] 08:56:45 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 08:56:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:47 INFO - (blobuploader) - INFO - Done attempting. 08:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:48 INFO - (blobuploader) - INFO - Done attempting. 08:56:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:48 INFO - Return code: 0 08:56:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a02ce9f3564940ec14df9647e12a30b59ef68974eb1b227a4b71898429afb200d203228fe18ae9a0681e0795b05ca581e4975cf74acc96a24a2c70510946817", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a3e4ca197c0a73df5982fdf92feb3762235041d6f32ca4a6b8f8634ff98ee0ce2910b37e535283c001df6a6affff38794bb4269617658e8826fe5568c3b38f8"} 08:56:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:48 INFO - Contents: 08:56:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a02ce9f3564940ec14df9647e12a30b59ef68974eb1b227a4b71898429afb200d203228fe18ae9a0681e0795b05ca581e4975cf74acc96a24a2c70510946817", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a3e4ca197c0a73df5982fdf92feb3762235041d6f32ca4a6b8f8634ff98ee0ce2910b37e535283c001df6a6affff38794bb4269617658e8826fe5568c3b38f8"} 08:56:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:48 INFO - Copying logs to upload dir... 08:56:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.706844 ========= master_lag: 3.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-08 08:56:51.956548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-08 08:56:51.965016) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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/7a02ce9f3564940ec14df9647e12a30b59ef68974eb1b227a4b71898429afb200d203228fe18ae9a0681e0795b05ca581e4975cf74acc96a24a2c70510946817", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a3e4ca197c0a73df5982fdf92feb3762235041d6f32ca4a6b8f8634ff98ee0ce2910b37e535283c001df6a6affff38794bb4269617658e8826fe5568c3b38f8"} build_url:https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/CcX0PTKXRciRlrAweudEPg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a02ce9f3564940ec14df9647e12a30b59ef68974eb1b227a4b71898429afb200d203228fe18ae9a0681e0795b05ca581e4975cf74acc96a24a2c70510946817", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a3e4ca197c0a73df5982fdf92feb3762235041d6f32ca4a6b8f8634ff98ee0ce2910b37e535283c001df6a6affff38794bb4269617658e8826fe5568c3b38f8"}' ========= master_lag: 1.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-08 08:56:53.036499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:56:53.044891) ========= 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.k0tLzeM3bg/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.E6vERcY8la/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005176 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 08:56:53.207193) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-08 08:56:53.207566) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-08 08:56:58.132164) ========= ========= Total master_lag: 5.42 =========