builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0121 starttime: 1456415497.56 results: success (0) buildid: 20160225061027 builduid: b3560f6833c14ab386e19ba6062853ff revision: 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 07:51:37.560180) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 07:51:37.560717) ========= ========= Started set props: basedir (results: 0, elapsed: 14 secs) (at 2016-02-25 07:51:37.561064) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005669 basedir: '/builds/slave/test' ========= master_lag: 14.53 ========= ========= Finished set props: basedir (results: 0, elapsed: 14 secs) (at 2016-02-25 07:51:52.094015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 27 secs) (at 2016-02-25 07:51:52.094552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 27 secs) (at 2016-02-25 07:52:20.066340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-02-25 07:52:20.066638) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.006435 ========= master_lag: 8.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-02-25 07:52:28.498600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:28.498886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:28.499267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 07:52:28.499544) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-02-25 07:52:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.6M=0s 2016-02-25 07:52:29 (38.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187824 ========= master_lag: 0.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 07:52:29.502390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:29.502679) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.027168 ========= master_lag: 0.58 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:30.111400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 07:52:30.111774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 --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 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-02-25 07:52:30,206 truncating revision to first 12 chars 2016-02-25 07:52:30,207 Setting DEBUG logging. 2016-02-25 07:52:30,207 attempt 1/10 2016-02-25 07:52:30,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ac7627f1cf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 07:52:31,271 unpacking tar archive at: fx-team-3ac7627f1cf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312826 ========= master_lag: 3.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 07:52:34.777293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-25 07:52:34.778089) ========= echo 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 program finished with exit code 0 elapsedTime=0.006102 script_repo_revision: '3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72' ========= master_lag: 1.30 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-25 07:52:36.088598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:36.088895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 07:52:36.960895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-25 07:52:36.961186) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:52:37 INFO - MultiFileLogger online at 20160225 07:52:37 in /builds/slave/test 07:52:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:52:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:37 INFO - {'append_to_log': False, 07:52:37 INFO - 'base_work_dir': '/builds/slave/test', 07:52:37 INFO - 'blob_upload_branch': 'Fx-Team', 07:52:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:37 INFO - 'branch': 'Fx-Team', 07:52:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:37 INFO - 'config_files': ('talos/mac_config.py',), 07:52:37 INFO - 'default_actions': ('clobber', 07:52:37 INFO - 'read-buildbot-config', 07:52:37 INFO - 'download-and-extract', 07:52:37 INFO - 'populate-webroot', 07:52:37 INFO - 'create-virtualenv', 07:52:37 INFO - 'install', 07:52:37 INFO - 'run-tests'), 07:52:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:37 INFO - 'download_minidump_stackwalk': True, 07:52:37 INFO - 'download_symbols': 'ondemand', 07:52:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:37 INFO - 'installer_path': 'installer.exe', 07:52:37 INFO - 'log_level': 'info', 07:52:37 INFO - 'log_name': 'talos', 07:52:37 INFO - 'log_to_console': True, 07:52:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:52:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:52:37 INFO - 'opt_config_files': (), 07:52:37 INFO - 'pip_index': False, 07:52:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:37 INFO - 'cmd': ('bash', 07:52:37 INFO - '-c', 07:52:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:37 INFO - 'enabled': True, 07:52:37 INFO - 'halt_on_failure': False, 07:52:37 INFO - 'name': 'check_screen_resolution'},), 07:52:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:37 INFO - 'cmd': ('bash', 07:52:37 INFO - '-c', 07:52:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:37 INFO - 'enabled': True, 07:52:37 INFO - 'halt_on_failure': False, 07:52:37 INFO - 'name': 'check_screen_resolution'},), 07:52:37 INFO - 'run_cmd_checks_enabled': True, 07:52:37 INFO - 'sps_profile': False, 07:52:37 INFO - 'sps_profile_interval': 0, 07:52:37 INFO - 'suite': 'dromaeojs-e10s', 07:52:37 INFO - 'system_bits': '32', 07:52:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:37 INFO - 'title': 't-yosemite-r7-0121', 07:52:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:37 INFO - 'use_talos_json': True, 07:52:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:37 INFO - 'work_dir': 'build'} 07:52:37 INFO - ##### 07:52:37 INFO - ##### Running clobber step. 07:52:37 INFO - ##### 07:52:37 INFO - Running pre-action listener: _resource_record_pre_action 07:52:37 INFO - Running main action method: clobber 07:52:37 INFO - rmtree: /builds/slave/test/build 07:52:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:38 INFO - Running post-action listener: _resource_record_post_action 07:52:38 INFO - ##### 07:52:38 INFO - ##### Running read-buildbot-config step. 07:52:38 INFO - ##### 07:52:38 INFO - Running pre-action listener: _resource_record_pre_action 07:52:38 INFO - Running main action method: read_buildbot_config 07:52:38 INFO - Using buildbot properties: 07:52:38 INFO - { 07:52:38 INFO - "project": "", 07:52:38 INFO - "product": "firefox", 07:52:38 INFO - "script_repo_revision": "production", 07:52:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:52:38 INFO - "repository": "", 07:52:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:52:38 INFO - "buildid": "20160225061027", 07:52:38 INFO - "pgo_build": "False", 07:52:38 INFO - "basedir": "/builds/slave/test", 07:52:38 INFO - "buildnumber": 454, 07:52:38 INFO - "slavename": "t-yosemite-r7-0121", 07:52:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:52:38 INFO - "platform": "yosemite_r7", 07:52:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:52:38 INFO - "branch": "fx-team", 07:52:38 INFO - "repo_path": "integration/fx-team", 07:52:38 INFO - "revision": "3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72", 07:52:38 INFO - "stage_platform": "macosx64", 07:52:38 INFO - "builduid": "b3560f6833c14ab386e19ba6062853ff", 07:52:38 INFO - "slavebuilddir": "test" 07:52:38 INFO - } 07:52:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:52:38 INFO - Running post-action listener: _resource_record_post_action 07:52:38 INFO - ##### 07:52:38 INFO - ##### Running download-and-extract step. 07:52:38 INFO - ##### 07:52:38 INFO - Running pre-action listener: _resource_record_pre_action 07:52:38 INFO - Running main action method: download_and_extract 07:52:38 INFO - mkdir: /builds/slave/test/build/tests 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:38 INFO - https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/test_packages.json 07:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/test_packages.json 07:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:52:39 INFO - Downloaded 1277 bytes. 07:52:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:52:39 INFO - Using the following test package requirements: 07:52:39 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:52:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:52:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:52:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'jsshell-mac.zip'], 07:52:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:52:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:52:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:52:39 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:52:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:52:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:52:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:52:39 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:52:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:39 INFO - https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:40 INFO - Downloaded 17829657 bytes. 07:52:40 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'] 07:52:40 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 07:52:43 INFO - Return code: 0 07:52:43 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 07:52:43 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')]} 07:52:43 INFO - https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:46 INFO - Downloaded 17829657 bytes. 07:52:46 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'] 07:52:46 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 07:52:49 INFO - Return code: 0 07:52: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')]} 07:52:49 INFO - https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:50 INFO - Downloaded 10707015 bytes. 07:52:50 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'] 07:52:50 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 07:52:50 INFO - Return code: 0 07:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:50 INFO - https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOjbvxvMQDm50eDdv4_OaA/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 07:52:53 INFO - Downloaded 111444412 bytes. 07:52:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:52:53 INFO - mkdir: /builds/slave/test/properties 07:52:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:53 INFO - Contents: 07:52:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:52:54 INFO - Running post-action listener: _resource_record_post_action 07:52:54 INFO - Running post-action listener: set_extra_try_arguments 07:52:54 INFO - ##### 07:52:54 INFO - ##### Running populate-webroot step. 07:52:54 INFO - ##### 07:52:54 INFO - Running pre-action listener: _resource_record_pre_action 07:52:54 INFO - Running main action method: populate_webroot 07:52:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:54 INFO - '--tppagecycles', 07:52:54 INFO - '7'], 07:52:54 INFO - 'tests': ['tsvgm']}}, 07:52:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:52:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:52:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'tests': ['damp', 'tps']}, 07:52:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['damp', 'tps']}, 07:52:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:54 INFO - 'other': {'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'other_l64': {'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'other_nol64': {'tests': ['a11yr', 07:52:54 INFO - 'ts_paint', 07:52:54 INFO - 'tpaint', 07:52:54 INFO - 'sessionrestore', 07:52:54 INFO - 'sessionrestore_no_auto_restore']}, 07:52:54 INFO - 'svgr': {'tests': ['tsvgx', 07:52:54 INFO - 'tsvgr_opacity', 07:52:54 INFO - 'tart', 07:52:54 INFO - 'tscrollx', 07:52:54 INFO - 'cart']}, 07:52:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['tsvgx', 07:52:54 INFO - 'tsvgr_opacity', 07:52:54 INFO - 'tart', 07:52:54 INFO - 'tscrollx', 07:52:54 INFO - 'cart']}, 07:52:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'tests': ['tp5o']}, 07:52:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'talos_options': ['--e10s'], 07:52:54 INFO - 'tests': ['tp5o']}, 07:52:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'talos_options': ['--xperf_path', 07:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:54 INFO - 'tests': ['tp5n']}, 07:52:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:54 INFO - 'talos_options': ['--e10s', 07:52:54 INFO - '--xperf_path', 07:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:54 INFO - 'tests': ['tp5n']}}, 07:52:54 INFO - 'talos.zip': {'path': '', 07:52:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:54 INFO - Running post-action listener: _resource_record_post_action 07:52:54 INFO - ##### 07:52:54 INFO - ##### Running create-virtualenv step. 07:52:54 INFO - ##### 07:52:54 INFO - Running pre-action listener: _resource_record_pre_action 07:52:54 INFO - Running main action method: create_virtualenv 07:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:54 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 07:52:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:54 INFO - Using real prefix '/tools/python27' 07:52:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:58 INFO - Installing pip.................done. 07:52:58 INFO - Return code: 0 07:52:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:58 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:52:58 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 07:52:58 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 07:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:58 INFO - 'HOME': '/Users/cltbld', 07:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:58 INFO - 'LOGNAME': 'cltbld', 07:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:58 INFO - 'MOZ_NO_REMOTE': '1', 07:52:58 INFO - 'NO_EM_RESTART': '1', 07:52:58 INFO - 'PAGER': '/bin/cat', 07:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:58 INFO - 'PWD': '/builds/slave/test', 07:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:58 INFO - 'SHELL': '/bin/bash', 07:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:52:58 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:58 INFO - 'USER': 'cltbld', 07:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:58 INFO - 'XPC_FLAGS': '0x0', 07:52:58 INFO - 'XPC_SERVICE_NAME': '0', 07:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:58 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 07:52:58 INFO - Cleaning up... 07:52:58 INFO - Return code: 0 07:52:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:58 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:52:58 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 07:52:58 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 07:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:58 INFO - 'HOME': '/Users/cltbld', 07:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:58 INFO - 'LOGNAME': 'cltbld', 07:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:58 INFO - 'MOZ_NO_REMOTE': '1', 07:52:58 INFO - 'NO_EM_RESTART': '1', 07:52:58 INFO - 'PAGER': '/bin/cat', 07:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:58 INFO - 'PWD': '/builds/slave/test', 07:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:58 INFO - 'SHELL': '/bin/bash', 07:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:52:58 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:58 INFO - 'USER': 'cltbld', 07:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:58 INFO - 'XPC_FLAGS': '0x0', 07:52:58 INFO - 'XPC_SERVICE_NAME': '0', 07:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:58 INFO - Downloading/unpacking psutil>=0.7.1 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:01 INFO - Installing collected packages: psutil 07:53:01 INFO - Running setup.py install for psutil 07:53:01 INFO - building 'psutil._psutil_osx' extension 07:53:01 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 07:53:01 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 07:53:01 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 07:53:02 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 07:53:02 INFO - building 'psutil._psutil_posix' extension 07:53:02 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 07:53:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:53:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:53:02 INFO - ^ 07:53:02 INFO - 1 warning generated. 07:53:02 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 07:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:02 INFO - Successfully installed psutil 07:53:02 INFO - Cleaning up... 07:53:02 INFO - Return code: 0 07:53:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:53:02 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')]} 07:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:02 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')]} 07:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:02 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:02 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 07:53:02 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 07:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:02 INFO - 'HOME': '/Users/cltbld', 07:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:02 INFO - 'LOGNAME': 'cltbld', 07:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:02 INFO - 'MOZ_NO_REMOTE': '1', 07:53:02 INFO - 'NO_EM_RESTART': '1', 07:53:02 INFO - 'PAGER': '/bin/cat', 07:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:02 INFO - 'PWD': '/builds/slave/test', 07:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:02 INFO - 'SHELL': '/bin/bash', 07:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:02 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:02 INFO - 'USER': 'cltbld', 07:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:02 INFO - 'XPC_FLAGS': '0x0', 07:53:02 INFO - 'XPC_SERVICE_NAME': '0', 07:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:02 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 07:53:02 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 07:53:02 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 07:53:02 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 07:53:02 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 07:53:02 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 07:53:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:05 INFO - Installing collected packages: mozsystemmonitor 07:53:05 INFO - Running setup.py install for mozsystemmonitor 07:53:05 INFO - Successfully installed mozsystemmonitor 07:53:05 INFO - Cleaning up... 07:53:05 INFO - Return code: 0 07:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:05 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:05 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 07:53:05 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 07:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:05 INFO - 'HOME': '/Users/cltbld', 07:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:05 INFO - 'LOGNAME': 'cltbld', 07:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:05 INFO - 'MOZ_NO_REMOTE': '1', 07:53:05 INFO - 'NO_EM_RESTART': '1', 07:53:05 INFO - 'PAGER': '/bin/cat', 07:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:05 INFO - 'PWD': '/builds/slave/test', 07:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:05 INFO - 'SHELL': '/bin/bash', 07:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:05 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:05 INFO - 'USER': 'cltbld', 07:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:05 INFO - 'XPC_FLAGS': '0x0', 07:53:05 INFO - 'XPC_SERVICE_NAME': '0', 07:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:09 INFO - Downloading docopt-0.6.1.tar.gz 07:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:09 INFO - Running setup.py install for blobuploader 07:53:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:09 INFO - Running setup.py install for requests 07:53:09 INFO - Running setup.py install for docopt 07:53:09 INFO - Successfully installed blobuploader requests docopt 07:53:09 INFO - Cleaning up... 07:53:10 INFO - Return code: 0 07:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:10 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:10 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 07:53:10 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 07:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:10 INFO - 'HOME': '/Users/cltbld', 07:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:10 INFO - 'LOGNAME': 'cltbld', 07:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:10 INFO - 'MOZ_NO_REMOTE': '1', 07:53:10 INFO - 'NO_EM_RESTART': '1', 07:53:10 INFO - 'PAGER': '/bin/cat', 07:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:10 INFO - 'PWD': '/builds/slave/test', 07:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:10 INFO - 'SHELL': '/bin/bash', 07:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:10 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:10 INFO - 'USER': 'cltbld', 07:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:10 INFO - 'XPC_FLAGS': '0x0', 07:53:10 INFO - 'XPC_SERVICE_NAME': '0', 07:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-n9gMOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-op52is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-N91s4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-uKvTzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-SghFv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9S6EXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:10 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-vUbBmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-4wTV5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-E6nUly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-YYLO1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-zCbNDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-3zYNuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-BOZ8yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-K3ojvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-WXlLXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fh3Qrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-q53BCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:12 INFO - Running setup.py install for manifestparser 07:53:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:12 INFO - Running setup.py install for mozcrash 07:53:12 INFO - Running setup.py install for mozdebug 07:53:12 INFO - Running setup.py install for mozdevice 07:53:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:12 INFO - Running setup.py install for mozfile 07:53:12 INFO - Running setup.py install for mozhttpd 07:53:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:12 INFO - Running setup.py install for mozinfo 07:53:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Running setup.py install for mozInstall 07:53:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Running setup.py install for mozleak 07:53:13 INFO - Running setup.py install for mozlog 07:53:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Running setup.py install for moznetwork 07:53:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:13 INFO - Running setup.py install for mozprocess 07:53:13 INFO - Running setup.py install for mozprofile 07:53:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozrunner 07:53:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozscreenshot 07:53:14 INFO - Running setup.py install for moztest 07:53:14 INFO - Running setup.py install for mozversion 07:53:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:14 INFO - Cleaning up... 07:53:14 INFO - Return code: 0 07:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:14 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:14 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 07:53:14 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 07:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:14 INFO - 'HOME': '/Users/cltbld', 07:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:14 INFO - 'LOGNAME': 'cltbld', 07:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:14 INFO - 'MOZ_NO_REMOTE': '1', 07:53:14 INFO - 'NO_EM_RESTART': '1', 07:53:14 INFO - 'PAGER': '/bin/cat', 07:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:14 INFO - 'PWD': '/builds/slave/test', 07:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:14 INFO - 'SHELL': '/bin/bash', 07:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:14 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:14 INFO - 'USER': 'cltbld', 07:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:14 INFO - 'XPC_FLAGS': '0x0', 07:53:14 INFO - 'XPC_SERVICE_NAME': '0', 07:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:14 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-CghceL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-sCgdmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-zGKk_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-csA9is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ycYJ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-NMtNlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-6xpThS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-8QFOKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-UxpLxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:15 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)) 07:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-xg0Ekt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-cxPcHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-CwZLGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ckBsmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-EaYghp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-gylgeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-pLlzOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-rh2jpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:16 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)) 07:53:16 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:16 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:19 INFO - Downloading blessings-1.6.tar.gz 07:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:19 INFO - Installing collected packages: blessings 07:53:19 INFO - Running setup.py install for blessings 07:53:19 INFO - Successfully installed blessings 07:53:19 INFO - Cleaning up... 07:53:19 INFO - Return code: 0 07:53:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:19 INFO - Reading from file tmpfile_stdout 07:53:19 INFO - Current package versions: 07:53:19 INFO - blessings == 1.6 07:53:19 INFO - blobuploader == 1.2.4 07:53:19 INFO - docopt == 0.6.1 07:53:19 INFO - manifestparser == 1.1 07:53:19 INFO - mozInstall == 1.12 07:53:19 INFO - mozcrash == 0.16 07:53:19 INFO - mozdebug == 0.1 07:53:19 INFO - mozdevice == 0.48 07:53:19 INFO - mozfile == 1.2 07:53:19 INFO - mozhttpd == 0.7 07:53:19 INFO - mozinfo == 0.9 07:53:19 INFO - mozleak == 0.1 07:53:19 INFO - mozlog == 3.1 07:53:19 INFO - moznetwork == 0.27 07:53:19 INFO - mozprocess == 0.22 07:53:19 INFO - mozprofile == 0.28 07:53:19 INFO - mozrunner == 6.11 07:53:19 INFO - mozscreenshot == 0.1 07:53:19 INFO - mozsystemmonitor == 0.0 07:53:19 INFO - moztest == 0.7 07:53:19 INFO - mozversion == 1.4 07:53:19 INFO - psutil == 3.1.1 07:53:19 INFO - requests == 1.2.3 07:53:19 INFO - wsgiref == 0.1.2 07:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:19 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 07:53:19 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 07:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:19 INFO - 'HOME': '/Users/cltbld', 07:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PAGER': '/bin/cat', 07:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test', 07:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:19 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - 'XPC_FLAGS': '0x0', 07:53:19 INFO - 'XPC_SERVICE_NAME': '0', 07:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 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)) 07:53:19 INFO - Cleaning up... 07:53:19 INFO - Return code: 0 07:53:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:19 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 07:53:19 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 07:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:19 INFO - 'HOME': '/Users/cltbld', 07:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PAGER': '/bin/cat', 07:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test', 07:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:19 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - 'XPC_FLAGS': '0x0', 07:53:19 INFO - 'XPC_SERVICE_NAME': '0', 07:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 INFO - Downloading/unpacking jsonschema 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:22 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:22 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 07:53:22 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 07:53:22 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 07:53:22 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 07:53:22 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 07:53:22 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 07:53:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:23 INFO - warning: no files found matching '*.txt' 07:53:23 INFO - no previously-included directories found matching 'build' 07:53:23 INFO - no previously-included directories found matching 'dist' 07:53:23 INFO - no previously-included directories found matching '.git*' 07:53:23 INFO - Installing collected packages: jsonschema, functools32 07:53:23 INFO - Running setup.py install for functools32 07:53:23 INFO - warning: no files found matching '*.txt' 07:53:23 INFO - no previously-included directories found matching 'build' 07:53:23 INFO - no previously-included directories found matching 'dist' 07:53:23 INFO - no previously-included directories found matching '.git*' 07:53:23 INFO - Successfully installed jsonschema functools32 07:53:23 INFO - Cleaning up... 07:53:23 INFO - Return code: 0 07:53:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:53:23 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')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 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')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 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 0x102999a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6db565830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, '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.K5fNc3WlzJ/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.abvv4SbznY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 07:53:23 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 07:53:23 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 07:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:23 INFO - 'HOME': '/Users/cltbld', 07:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PAGER': '/bin/cat', 07:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test', 07:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:53:23 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - 'XPC_FLAGS': '0x0', 07:53:23 INFO - 'XPC_SERVICE_NAME': '0', 07:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:23 INFO - Downloading/unpacking flake8 07:53:23 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 07:53:23 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 07:53:23 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 07:53:23 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 07:53:23 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 07:53:23 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 07:53:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:27 INFO - no previously-included directories found matching 'docs/_build' 07:53:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:53:27 INFO - Running setup.py install for pep8 07:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:27 INFO - no previously-included directories found matching 'docs/_build' 07:53:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:53:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:53:27 INFO - Cleaning up... 07:53:27 INFO - Return code: 0 07:53:27 INFO - Running post-action listener: _resource_record_post_action 07:53:27 INFO - Running post-action listener: _start_resource_monitoring 07:53:27 INFO - Starting resource monitoring. 07:53:27 INFO - ##### 07:53:27 INFO - ##### Running install step. 07:53:27 INFO - ##### 07:53:27 INFO - Running pre-action listener: _resource_record_pre_action 07:53:27 INFO - Running main action method: install 07:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:27 INFO - Reading from file tmpfile_stdout 07:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:27 INFO - Reading from file tmpfile_stdout 07:53:27 INFO - Output received: 07:53:27 INFO - Usage: mozinstall [options] installer 07:53:27 INFO - Options: 07:53:27 INFO - -h, --help show this help message and exit 07:53:27 INFO - -d DEST, --destination=DEST 07:53:27 INFO - Directory to install application into. [default: 07:53:27 INFO - "/builds/slave/test"] 07:53:27 INFO - --app=APP Application being installed. [default: firefox] 07:53:27 INFO - mkdir: /builds/slave/test/build/application 07:53:27 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'] 07:53:27 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 07:54:02 INFO - Reading from file tmpfile_stdout 07:54:02 INFO - Output received: 07:54:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:54:02 INFO - Running post-action listener: _resource_record_post_action 07:54:02 INFO - ##### 07:54:02 INFO - ##### Running run-tests step. 07:54:02 INFO - ##### 07:54:02 INFO - Running pre-action listener: _resource_record_pre_action 07:54:02 INFO - Running main action method: run_tests 07:54:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:02 INFO - 2016-02-25 07:54:02.594 screenresolution[1653:7940] starting screenresolution argv=screenresolution get 07:54:02 INFO - 2016-02-25 07:54:02.597 screenresolution[1653:7940] Display 0: 1600x1200x32@60 07:54:02 INFO - 2016-02-25 07:54:02.604 screenresolution[1654:7942] starting screenresolution argv=screenresolution list 07:54:02 INFO - Available Modes on Display 0 07:54:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:02 INFO - Intel Iris: 07:54:02 INFO - Chipset Model: Intel Iris 07:54:02 INFO - Type: GPU 07:54:02 INFO - Bus: Built-In 07:54:02 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:02 INFO - Vendor: Intel (0x8086) 07:54:02 INFO - Device ID: 0x0a2e 07:54:02 INFO - Revision ID: 0x0009 07:54:02 INFO - Displays: 07:54:02 INFO - Display: 07:54:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:02 INFO - Display Serial Number: 1600x1200 60 07:54:02 INFO - Main Display: Yes 07:54:02 INFO - Mirror: Off 07:54:02 INFO - Online: Yes 07:54:02 INFO - Rotation: Supported 07:54:02 INFO - Return code: 0 07:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:02 INFO - Python 2.7.3 07:54:02 INFO - Return code: 0 07:54:02 INFO - grabbing minidump binary from tooltool 07:54:02 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')]} 07:54:02 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 0x10283dd30>, '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 0x102661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102834b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:02 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 07:54:02 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 07:54:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:02 INFO - Return code: 0 07:54:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:54:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:54:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:54:04 INFO - Return code: 0 07:54:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:54:04 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0121 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5fNc3WlzJ/Render', 07:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:04 INFO - 'HOME': '/Users/cltbld', 07:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:04 INFO - 'LOGNAME': 'cltbld', 07:54:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:04 INFO - 'MOZ_NO_REMOTE': '1', 07:54:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:04 INFO - 'NO_EM_RESTART': '1', 07:54:04 INFO - 'PAGER': '/bin/cat', 07:54:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:04 INFO - 'PWD': '/builds/slave/test', 07:54:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:04 INFO - 'SHELL': '/bin/bash', 07:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abvv4SbznY/Listeners', 07:54:04 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 07:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:04 INFO - 'USER': 'cltbld', 07:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:04 INFO - 'XPC_FLAGS': '0x0', 07:54:04 INFO - 'XPC_SERVICE_NAME': '0', 07:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:54:04 INFO - mozversion application_buildid: 20160225061027 07:54:04 INFO - mozversion application_changeset: 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 07:54:04 INFO - mozversion application_display_name: Nightly 07:54:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:04 INFO - mozversion application_name: Firefox 07:54:04 INFO - mozversion application_remotingname: firefox 07:54:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:54:04 INFO - mozversion application_vendor: Mozilla 07:54:04 INFO - mozversion application_version: 47.0a1 07:54:04 INFO - mozversion platform_buildid: 20160225061027 07:54:04 INFO - mozversion platform_changeset: 3ac7627f1cf7a049091bc639ea9c2a3e3a9acd72 07:54:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:54:04 INFO - mozversion platform_version: 47.0a1 07:54:04 INFO - using testdate: 1456415644 07:54:04 INFO - actual date: 1456415644 07:54:04 INFO - starting webserver on 'localhost:49274' 07:54:04 INFO - SUITE-START | Running 2 tests 07:54:04 INFO - TEST-START | dromaeo_css 07:54:04 INFO - operating with platform_type : mac_ 07:54:04 INFO - Initialising browser for dromaeo_css test... 07:54:04 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpVJBHZf/profile http://localhost:49274/getInfo.html) 07:54:07 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 07:54:07 INFO - PROCESS | 1672 | colorDepth:24 07:54:07 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 07:54:07 INFO - PROCESS | 1672 | __metrics 07:54:07 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:54:08 INFO - TEST-INFO | 1672: exit 0 07:54:08 INFO - Browser initialized. 07:54:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:08 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpVJBHZf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:20 INFO - PROCESS | 1677 | RSS: Main: 255578112 07:54:20 INFO - PROCESS | 1677 | 07:55:09 INFO - PROCESS | 1677 | 1456415709744 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] 07:57:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:57:21 INFO - PROCESS | 1677 | RSS: Main: 268566528 07:57:21 INFO - PROCESS | 1677 | 08:00:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 08:00:24 INFO - PROCESS | 1677 | RSS: Main: 281321472 08:00:24 INFO - PROCESS | 1677 | 08:03:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 08:03:26 INFO - PROCESS | 1677 | RSS: Main: 282349568 08:03:26 INFO - PROCESS | 1677 | 08:06:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 08:06:28 INFO - PROCESS | 1677 | RSS: Main: 284086272 08:06:28 INFO - PROCESS | 1677 | 08:09:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 08:09:32 INFO - PROCESS | 1677 | RSS: Main: 286113792 08:09:32 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 08:12:34 INFO - PROCESS | 1677 | RSS: Main: 288681984 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | __start_tp_report 08:12:34 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:12:34 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:12:34 INFO - PROCESS | 1677 | |i|pagename|runs| 08:12:34 INFO - PROCESS | 1677 | |0;dojo.html;2998.7451066659337;3571.3571557119726;3599.694026007789;3641.526601541799;3642.726795490339;5774.3936886626825;5801.738921748521;5880.088586269129;5908.497777688896;5939.287285525743;5843.941560584393;5921.674307913063;5923.200367950325;5974.671393073369;6044.546659000582;5261.526462618363;5286.392064912527;5299.390570084451;5405.891882162355;5415.593830462712;5354.41101478837;5371.973140134294;5421.810236641718;5477.260569823083;5493.121100623901;5187.559057480119;5230.895382092356;5324.467553244684;5352.91970620441;5361.276227709248;5304;5309.681419114865;5323.920141197885;5329.360476742777;5339;5199.714015729133;5275.815346462856;5329.094054010828;5362.651427657229;5389.757460914229;5705.258316418881;5782.624129431573;5859.091840764689;5859.355470898197;5918.911216331759;6246.750129994794;6264.561480696353;6270.749170033193;6272.153259310026;6281.309056003836;6156.538259630501;6216;6231.906521402183;6269.905951410732;6286.402791734778;5962.672053037081;5996;6044.214252147192;6062.363451837494;6081.847953801146;6304.968475157595;6366.013267943384;6380.585261957958;6384.265809431882;6397.072424498515;6107.206063211754;6196.0705894116245;6242;6266.717997690115;6301.369863013662;6212.254529456403;6212.409821066992;6250.843728906813;6265.248170219603;6326.2724786649205;4714.457837348748;6094.085887116968;6251.437370636664;6283.120363149163;6292.182016337847;5426.728663566885;6111.804454079419;6219.098230756515;6220;6255.56211065221;3931.8623848165175;4919.655624106278;4933.703977761274;4965.255211718199;5001.299818025479;3726.9937116978263;4386.868393948187;4420.557944205618;4441.333799929972;4480.551944805558;5707.71461426927;5878.735456904449;5883.794067207627;5887;5974.522038236931;6259.968700156561;6266.154069200691;6298.937010629835;6302.527310451735;6319.368063193736;5982.312034116046;6008.188894499274;6011.248593925759;6018.127371531104;6035.668038257938;5411.215373770781;5471.452854714496;5539.390667026624;5567.387587365387;5601;5444.455554444603;5852.502537284378;6030;6508.446782023581;6509.088727578238;6260.436560709558;6278.968605156945;6281.434670879643;6284.402981716729;6298.275698294755;6291.937080629135;6366.554341196072;6426.646534440651;6479.125318081999;6500.934990650033;6198.473129783839;6198.81403557894;6250.062490626442;6251.156093927261;6258.967270400333;6147.262328520427;6216.347283535345;6291.056341548804;6306.4639505642535;6319.873602527831;4716.764161791828;6014.2181516404335;6201.503879689704;6224.875502490016;6285.74857005733;5128.974355128201;6178.505719542516;6276.152719382825;6292.244930608356;6306.936930630635;5057.291979122852;6038.154658347923;6102.359252278447;6149.661768602591;6158.969205154125;6097.827165393427;6156.199694039746;6165.84585385369;6183.474404675653;6252.406021427957;6099.698590276447;6103.204357007117;6114.816555503342;6115;6137.693115344304 08:12:34 INFO - PROCESS | 1677 | |1;ext.html;444.77983398217884;459.4807867110165;492.24440483857273;562.9585267255576;589.7080944932254;37585.06037349061;37884.863454096354;38351.232975340514;38451.23097538047;38542.03644908879;39724.60275397245;40095.799521002424;40205.77839326872;40217.59782402175;40232.59767402325;9453.054694530561;9598.992105828893;9614.855777163348;9684.322097453181;9732.951335243313;9539;9706.805863882719;9756.024397560259;9775.657851975182;9831.164351030171;9718.951405242964;9771.26715496337;9799.265055120895;9819.459929703864;9845.310828242025;9730.708078757612;9807;9810.068043535888;9821;9837.360571562825;9526.285528585384;9636.95181524095;9674.22606191503;9676.225901927828;9695.563699633534;38656.61343386587;38809.417858732144;38932.80533597342;39067.21865562701;39178.60821391778;3102.7828052036366;3127.29635831936;3171.762117841171;3598.586162591283;3763.8306276217636;29451;29539.70460295391;29558.408831823457;30016;30155;2313.7339205991357;2776.7362100600612;2802.8178168418985;2807.242044647954;2865.111815337252;464259;466581.6670916658;472673;473709;473729.99999999657;36557.08607284786;45514.77242613832;46127.30809037867;54440.72779636076;65441;41607.75176744702;43660.345094823606;44895.326570101475;45014.774926125814;45334.54665453369;12590.307533085768;12972.351382430841;14812.333444995002;15229.543113706606;15398.692026159413;10582.788344233073;11765.705857353634;12152.027837772957;12318.322492262832;12469.563565275172;11799.292042477478;14530.85469145295;14824.555263342118;14873.33070011852;14939.402423903139;6162.445379915829;6300.558960872695;6327.4938004959495;6354.777582784581;6364.236291645032;886.8004698942815;916.7937214126902;931.6040682709821;939.8355287824741;1062.1608928946046;25589;29283.414331713248;29331.413371732448;29533.85233073821;29636.555451668242;875.2297977779641;1060.2949038889053;1064.3932958213743;1152.4410660829492;1234.6172686467044;14494;14984.951053426374;14986.775198372034;15288.770668439982;15456.38174473031;529943;531230;531237;531302;536265;57829.710851445474;58276;58744.7062764692;58860.70569647125;58994;1353.1001883747394;1383.7509248335396;1393.1780249652754;1402.754517959353;1404.2276747788676;29154;29328.41343173082;29358.412831743673;29912;29935;51029.489705102475;51068;51416.71458213575;51475.48524514707;51731.96536069182;419413;433517;433574;433950.9814705564;440584.1883162255;32649.510257345682;32722.83638581792;33533.49699754457;33855;34251.657483424846;44328;44806.55193448154;45720.54279457163;46316.768416157705;46444.30333545067;36028.09929751777;37151.81424092862;37411.812940935124;37510.8124459376;38143.80928095342;35557;35658.82170589131;36002.45996310005;36586;36758.26483470262;37282.254354912206;37719.81140094282;38784.03039924025;38862.80568597139;38927.026824329616;30590.235244119074;33136;33315;33351.49972750362;33352.83323583366;22547;24674;24933.625995610444;25248;25457.23628291154 08:12:34 INFO - PROCESS | 1677 | |2;jquery.html;303.8055644387592;351.52017496117793;355.67988810070943;359.2581319575079;361.8932414937593;15473;15933.44232951847;19691.507712307182;20062;20124;19206.711899321486;19423.514412139702;19625.607487850233;19706.11322490488;19717;4616.607588354994;5092.337996060516;5399.649022813504;5426.484483974016;5438.782448702047;5279.076161671711;5358.785648574052;5363.490468405495;5379.8386048418415;5395.325584301962;5348.090824559815;5391.946080539184;5392.622516423852;5516.338039435253;5688.374278829326;4817.566419022305;4858.295547145662;5550.944490555084;5707.571932105067;5749.108888122327;4766.666333356667;5343.786248550054;5491.368492623359;5702.885942281173;5717.571182161355;13197.802032969514;13256.939444844389;13272.601821945356;13299.335033248299;13385.66535836612;1728.9827101729072;2125.4792575819024;2187.7155969723995;2342.472943587696;2781.235160330905;9688;9899.752506187331;9947;10035.247356448295;10053.994600539962;1662.476319959221;1713.4602600180904;1734.0722713348298;1737.5134962210602;1783.8751287409757;89591;96415.03584964131;96707.9999999993;100106.49946750293;100529.99470005279;10822.458877056115;11123.443827808738;11152.386618735885;11206.943965280121;11309.321440713584;12409.813852792215;13277.668058298426;13347;13390.799138012937;13400;8321.916780832235;8426.410151289474;8443.155684431507;8572.828543429096;8701.21689047976;8480.53357065355;8482.406231563855;8557.828843423222;8820.985586657489;8966.596503157374;3652.324320000755;4305.48334199898;4381.3427985801745;4390.560943905648;4400.669949753781;1750.4048623468082;1813.4650278167971;1857.9966817918444;1860.3488778927267;1874.7562816833997;868.2272777228272;882.40725490489;887.7958069644018;897.6678628907215;902.7562558109274;19666.90166549158;20291.391258262276;20561.177552897716;20591.07340169666;20718.274860380116;826.9208682669174;873.3841894556541;891.0421297105637;914.6295750221171;918.86676431917;8183.508989460652;9138.268938484905;10921.962413570698;10992.395418251914;11023.393713345842;532179;606920.9653951701;609323.9067609356;629714;639805;109270.45364773125;112966;118589;119599.40200298943;121752;971.4656938683696;993.965211217604;1001.3491230700104;1004.5881188712593;1012.336919317848;15353.141161889142;16704.582385440463;17616.823831761518;18101.637967240844;18430.723539146657;28127.71872281251;49410.764730880575;52233;52370.73814631055;52980;69810;75211.62394187994;80381.59809200917;81801;83368;7506.9249307506225;7896.486728362638;8147.79630509242;8155.225253600898;8399.664013439395;11727.941360293486;12289.201201921847;12723.745525089631;12975.805362919375;13295;11003.646900134821;11015.284006539548;11116.610918618133;11168.609098681507;11233.775324493628;10117.544710487899;10426.582936682751;11027;11136.888631113909;11583.710407239887;11255.268407553483;11500.884991149982;11616.94191529037;11822.34977076269;11886.989605883597;8140.83718325642;8162.755117346489;8209.79475513117;8242.670293188205;8282.917170828214;10778.083862871743;11611.825822612498;11751.059915206934;11868.465919033837;11915.16593838423 08:12:34 INFO - PROCESS | 1677 | |3;mootools.html;1544.2741911301687;1555.3078879898446;1794.9012804295767;1903.3433465454423;1919.1076149590438;7769.067711874569;8456;8504.872426913593;8733.519656418894;8750.606222719976;8514.318854491641;8614.181652742995;8670.176333248332;8687.478751274912;8712.172343627346;2425.1511970810207;2428.781409673129;2435.391152211947;2447.449323902126;2451.779339859412;2418.8790560471994;2433.3916520869784;2448.669429626995;2451.5832308507597;2466.3094333586623;2362.5511152880986;2391.282615215437;2397.7961873240797;2424.5756992526326;2431.2706188143575;2033.6847788592793;2283.315005498344;2388.2118900762794;2395.3532546212514;2469.6665950096685;2359.5516851798275;2393.4854006388537;2393.6529203265427;2393.964090538626;2396.8801559921935;7992.680292788282;8732.738017859474;8751.737447876574;8786.824263514694;8788.384813063089;4960.454350021495;5406.567474602022;5407.324084489439;5444.237806707064;5454.318210223722;2894.1751600793673;2932.765378769693;2950.4246671898986;3460.7750496217664;3583.2654305867236;816.3877092180865;898.9437411042;1024.4160828327856;1037.725002874239;1043.8121138195122;11398.1451391146;11567.826482602684;11742.295462272206;11755.412229388496;11756.412179391082;4754.120487709784;4844.176489996709;4925.4335751388335;4926.975365123151;4938.728369939688;9968.800623987625;10021.849672254923;10028.298019138736;10041.397516149054;10045.547950342252;5424.918626220609;5455.754491047913;5468.234447177399;5477.123660214346;5479.342478902558;4407.493138289074;4802.51974802517;4869.123557759637;4894.853154405374;4926.236433352764;3454.7063499602314;3748.962510374916;3908.3746600544346;3917.334053210961;3928.1161738609158;1304.087139002683;1318.5319211679907;1318.6110097521062;1320.5972178485463;1334.6396472952442;1185.9978318321005;1266.2782214137853;1303.7653222419865;1331.9134256273505;1341.8591047940022;7874.133845277015;8071.677132914735;8133.430659853753;8134.511929284262;8147.551884646401;513.5762995528704;524.2162966365308;524.4126578232327;526.4104203292337;529.20090663099;6067.453929146398;6081.239845019372;6101.084837274444;6114.463955408552;6152.969235153795;10460.790784184426;10693.625723099654;10699.786004280026;10710.196735244888;10849.511771970281;9484.05159484046;10497.475126243657;10532.15742740579;10658.253922225369;10684.25210235276;8089.635966381527;8152.021757389151;8159.714409995621;8231.300339471092;8269.503829770112;7919.604019799102;7935.285824275843;7961.641726122222;8008.11910689812;8065.475744076616;9266.860997084914;9333.53332333367;9442.38624489406;9464.242860571276;9475.52622368865;9479.19426848698;9692.46691431978;9707.757306067404;9943.204543636637;10108.241881858743;6743.561668491532;7155.248698886542;7375.446841486802;7397.075365579302;7468.626568671436;8059.677612895419;8098.51408915467;8148.022237331558;8161.79595510117;8174.83650327002;7149.463790215651;7246.746363877239;7248.0939882514685;7383.593902335423;7389.704411823682;7109.573425594481;7184.784456466315;7220.974975981539;7277.636118194175;7319.597422141834;7631.122420921443;7655.272749088827;7655.578943157957;7678.385729141767;7692.692292308245;5624.381318054929;5920.881582368243;6966.094407726963;6984.26665200167;6987.650617469208;6921.757738479129;6977.546459480118;7034.929650703428;7038.40173585251;7080.2919708028785 08:12:34 INFO - PROCESS | 1677 | |4;prototype.html;319.6883039036939;320.9470437377833;325.6615311071494;326.59339122792113;329.43337459569545;6820.488463365243;6857.040014397989;6882.277360877105;6887.483438742096;6923.446124310043;6691.832704182398;6783.796486105425;6784.932150678492;6848.828779280508;6866.828329291758;4492.573205545468;4767.61859051275;4884.755762211893;4966.900661986758;5024.623153263511;4980.128477516439;5021.6986980781085;5036.798528058874;5040.966601846631;5062.341895553573;4015.4980627421573;4969.925451118236;4976.651634385595;5012.598992080643;5016.774245158958;4968.950310496885;4993.500649935032;4999.42506611737;5010.849674509753;5050.949490505103;4240.766757828318;4256.191323648497;4260.978695106504;4268.359746038088;4272.658187345005;6289.7169627366875;6505.447037001861;6566.5075119365765;6566.63883486408;6602.207735071822;5819.079703697812;5839.883202335929;5872.500837428824;5890.587658863881;5896.262967129109;7284.781456556312;7351.2281210472665;7372.631368431557;7383.48315617907;7404.0004599378935;4774.331593576902;4782.019685964369;4792.7124372537755;4797.328374027639;4817.421909370898;7345.706171753177;7724.922750772476;7776;7786.377089832799;7825.13923468418;4709.905801883943;4775.95224047762;4848.806047758121;4869.464358920516;4872.366592342973;4943.8022479101155;4957.380327459067;4967.801287948441;4971.105201063843;4991.575716064102;5841.678707671034;5846.239988801429;5849.385814489502;5865.384134665884;5888;7324.926750732531;7346.228645992094;7354.926450735424;7369;7382.2617738225745;1403.7716997627076;1628.51958672192;1683.9494815155565;1684.562013876401;1718.931242750276;1104.276698762312;1105.132471010253;1127.5997021057572;1130.141092769501;1132.3545579019878;6108.602940808833;6651.334866513407;6661.9000714989315;6681.899771503431;6693.832654183684;7472.393435411304;7475.887861682079;7477.476576639583;7483.102027756595;7531.849363012709;6632.668366581748;6682.164729408824;6694.933050669529;6710.0941372915;6739.056532085512;3734.6638802507905;3990.4213888986515;4004.799760011988;4007.158496715664;4019.93970090443;6479.352064793483;7803.531788092732;7868.331191848642;7929.603519823986;8124.268815806606;7957.124716281204;7957.482763620346;7972.441929064909;7974.481658692166;7984.361251099898;8025;8027.5584842834205;8030.759077227693;8047.114817370085;8060.516369017761;7370.705171793283;7691.923080769121;7737.5744334062165;7741.7677469676;7756.263155000266;7541.849163016599;7550.131734850563;7577.621118944141;7583.2416758323725;7601.353884919844;8047.275745182962;8053.718119865776;8062.919370806217;8093.352531797324;8125.553094579855;4670.252759558454;4722.622190224843;4738.478767335521;4740.217864052531;4770.451398089264;7401.962990185015;7693.769186924401;7697.496964275962;7735.6518956648215;7740.574268415291;7400.111986561647;7401;7406.518576292524;7415.184329723834;7422.851542969219;7368.668409921674;7378.520396174232;7379.557226566423;7392.852142957218;7411.99938008362;6899.379055884994;7218.963905180441;7244;7263.237360077327;7264.055672762507;6025.487833534199;7377.299156580117;7378.483506154517;7395.482316237812;7405.555666660018;5892.823215303548;7223.638818059181;7246.565206087652;7248.383887369422;7297.124345078624 08:12:34 INFO - PROCESS | 1677 | |5;yui.html;678.274246556185;713.2653367031955;733.9339459448648;740.3263030642116;750.4221749253079;16850.24173912174;17075;17207.65584688307;17231.827681723178;17288.56778580536;15783.605409864758;15818.525444236662;15928.203589820521;15928.761068583952;15947.362105515766;712.583138863764;855.8502262104138;873.5675840458981;893.4594570284982;899.7120921305185;862.8662557303628;879.5118709116438;879.5294517433175;882.4308321132866;886.8935727712684;911.225458360395;927.6614035876923;931.8462453695132;932.5896605493595;935.6210734652443;878.6704985630389;921.4425272709981;923.2521657457481;930.0559931669361;932.2774849491631;651.8891788395985;652.3965332067818;652.8139480248154;689.0387908867102;694.1011390249639;14918.030328028643;14931.954763166583;14941;15040.924795376062;15314.081155130727;12094.455749491293;12258.570950016796;12297.754044919051;12397.380130993415;12492.937535312356;10833;10891.727706807314;10898.182636302308;10905.18211134168;11185.48995885553;3022.9395412091853;3397.0827876473213;3434.261633748731;3478.3738926993133;3483.9303213935577;71459;74537.62731186363;75000;75144.87282690764;75248.24751752467;9330.906690933003;9481.24150067993;9511.239100871913;9533.427994320364;10079.193664506822;19547.902260488605;19797;20446.488837779176;20457;20458.488537786674;7277.053982982285;7324.853502930018;7325.706971721178;7642.770716878391;7675;3969.801509924492;3969.8412063517135;3994.3009973254566;4015.297322968469;4062.1266427718183;3512.5433693619666;3585.731070169748;3598.4062629666337;3608.7113030957985;3616.4575313703153;659.5416185750857;661.3882159002903;663.0617675988423;664.1200409457392;664.837114906851;497.0580749479716;568.6976823075195;595.3599880128879;596.7434003378502;610.2798697536949;7147.3210045045635;7928.524288542706;7933.404994625426;8080;8128;598.7844376024627;599.7001499250375;608.564876113572;608.6834845880118;612.5712001598898;3729.4219395993664;3774.0753515388906;3780;3800.847966081381;3870.1098747288283;81770.59114704389;83701;84200.73698894521;84790.57604711936;85146;66283.67432651417;66512.00231996524;66806.99789503161;68491.65754171197;75694.621526892;61479;66109;75389.62305188549;75838.9999999989;76859;6920.826979325356;7458.5151965122095;7468.962655186907;7627.733029343946;7640.159582445815;42838.14323713571;44345.89135271644;49442.75278623584;49758.75120624374;51259.2311115341;63464.36535634584;65656.67171664111;69124;69991.65004174947;70251.24371890744;10862;10930.289531180766;10949.945250273699;11033.172512061466;11178.664640060812;12003.939980300393;12028.09789265791;12185.086118541321;12448.31534265624;12504.562340318045;11335.546578136782;11392;11417.486213120595;11474.483648235682;11712.81766971264;11109.888901110886;11183.161262905478;11436.370999595103;11491.482883270106;11622.418879056182;11033.842838328623;11035.282706624044;11171;11176.441177941233;11429.714257143305;9438;9446.669366572138;9506.572204250688;9722.319437639297;9869.901300986898;9333.906660933575;9403.905960940303;9502.762430939281;9690.75773105678;9772.951135244279 08:12:34 INFO - PROCESS | 1677 | __end_tp_report 08:12:34 INFO - PROCESS | 1677 | __start_cc_report 08:12:34 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,353 08:12:34 INFO - PROCESS | 1677 | __end_cc_report 08:12:34 INFO - PROCESS | 1677 | __startTimestamp1456416754594__endTimestamp 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:12:34 INFO - PROCESS | 1677 | Number of tests: 6 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5794.95 Median:6044.55 stddev:666.39 (11.0%) stddev-sans-first:631.30 08:12:34 INFO - PROCESS | 1677 | Values: 2998.7 3571.4 3599.7 3641.5 3642.7 5774.4 5801.7 5880.1 5908.5 5939.3 5843.9 5921.7 5923.2 5974.7 6044.5 5261.5 5286.4 5299.4 5405.9 5415.6 5354.4 5372.0 5421.8 5477.3 5493.1 5187.6 5230.9 5324.5 5352.9 5361.3 5304.0 5309.7 5323.9 5329.4 5339.0 5199.7 5275.8 5329.1 5362.7 5389.8 5705.3 5782.6 5859.1 5859.4 5918.9 6246.8 6264.6 6270.7 6272.2 6281.3 6156.5 6216.0 6231.9 6269.9 6286.4 5962.7 5996.0 6044.2 6062.4 6081.8 6305.0 6366.0 6380.6 6384.3 6397.1 6107.2 6196.1 6242.0 6266.7 6301.4 6212.3 6212.4 6250.8 6265.2 6326.3 4714.5 6094.1 6251.4 6283.1 6292.2 5426.7 6111.8 6219.1 6220.0 6255.6 3931.9 4919.7 4933.7 4965.3 5001.3 3727.0 4386.9 4420.6 4441.3 4480.6 5707.7 5878.7 5883.8 5887.0 5974.5 6260.0 6266.2 6298.9 6302.5 6319.4 5982.3 6008.2 6011.2 6018.1 6035.7 5411.2 5471.5 5539.4 5567.4 5601.0 5444.5 5852.5 6030.0 6508.4 6509.1 6260.4 6279.0 6281.4 6284.4 6298.3 6291.9 6366.6 6426.6 6479.1 6500.9 6198.5 6198.8 6250.1 6251.2 6259.0 6147.3 6216.3 6291.1 6306.5 6319.9 4716.8 6014.2 6201.5 6224.9 6285.7 5129.0 6178.5 6276.2 6292.2 6306.9 5057.3 6038.2 6102.4 6149.7 6159.0 6097.8 6156.2 6165.8 6183.5 6252.4 6099.7 6103.2 6114.8 6115.0 6137.7 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:61422.82 Median:38836.11 stddev:127636.04 (328.7%) stddev-sans-first:127911.98 08:12:34 INFO - PROCESS | 1677 | Values: 444.8 459.5 492.2 563.0 589.7 37585.1 37884.9 38351.2 38451.2 38542.0 39724.6 40095.8 40205.8 40217.6 40232.6 9453.1 9599.0 9614.9 9684.3 9733.0 9539.0 9706.8 9756.0 9775.7 9831.2 9719.0 9771.3 9799.3 9819.5 9845.3 9730.7 9807.0 9810.1 9821.0 9837.4 9526.3 9637.0 9674.2 9676.2 9695.6 38656.6 38809.4 38932.8 39067.2 39178.6 3102.8 3127.3 3171.8 3598.6 3763.8 29451.0 29539.7 29558.4 30016.0 30155.0 2313.7 2776.7 2802.8 2807.2 2865.1 464259.0 466581.7 472673.0 473709.0 473730.0 36557.1 45514.8 46127.3 54440.7 65441.0 41607.8 43660.3 44895.3 45014.8 45334.5 12590.3 12972.4 14812.3 15229.5 15398.7 10582.8 11765.7 12152.0 12318.3 12469.6 11799.3 14530.9 14824.6 14873.3 14939.4 6162.4 6300.6 6327.5 6354.8 6364.2 886.8 916.8 931.6 939.8 1062.2 25589.0 29283.4 29331.4 29533.9 29636.6 875.2 1060.3 1064.4 1152.4 1234.6 14494.0 14985.0 14986.8 15288.8 15456.4 529943.0 531230.0 531237.0 531302.0 536265.0 57829.7 58276.0 58744.7 58860.7 58994.0 1353.1 1383.8 1393.2 1402.8 1404.2 29154.0 29328.4 29358.4 29912.0 29935.0 51029.5 51068.0 51416.7 51475.5 51732.0 419413.0 433517.0 433574.0 433951.0 440584.2 32649.5 32722.8 33533.5 33855.0 34251.7 44328.0 44806.6 45720.5 46316.8 46444.3 36028.1 37151.8 37411.8 37510.8 38143.8 35557.0 35658.8 36002.5 36586.0 36758.3 37282.3 37719.8 38784.0 38862.8 38927.0 30590.2 33136.0 33315.0 33351.5 33352.8 22547.0 24674.0 24933.6 25248.0 25457.2 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:33495.13 Median:14215.76 stddev:100272.98 (705.4%) stddev-sans-first:100523.30 08:12:34 INFO - PROCESS | 1677 | Values: 303.8 351.5 355.7 359.3 361.9 15473.0 15933.4 19691.5 20062.0 20124.0 19206.7 19423.5 19625.6 19706.1 19717.0 4616.6 5092.3 5399.6 5426.5 5438.8 5279.1 5358.8 5363.5 5379.8 5395.3 5348.1 5391.9 5392.6 5516.3 5688.4 4817.6 4858.3 5550.9 5707.6 5749.1 4766.7 5343.8 5491.4 5702.9 5717.6 13197.8 13256.9 13272.6 13299.3 13385.7 1729.0 2125.5 2187.7 2342.5 2781.2 9688.0 9899.8 9947.0 10035.2 10054.0 1662.5 1713.5 1734.1 1737.5 1783.9 89591.0 96415.0 96708.0 100106.5 100530.0 10822.5 11123.4 11152.4 11206.9 11309.3 12409.8 13277.7 13347.0 13390.8 13400.0 8321.9 8426.4 8443.2 8572.8 8701.2 8480.5 8482.4 8557.8 8821.0 8966.6 3652.3 4305.5 4381.3 4390.6 4400.7 1750.4 1813.5 1858.0 1860.3 1874.8 868.2 882.4 887.8 897.7 902.8 19666.9 20291.4 20561.2 20591.1 20718.3 826.9 873.4 891.0 914.6 918.9 8183.5 9138.3 10922.0 10992.4 11023.4 532179.0 606921.0 609323.9 629714.0 639805.0 109270.5 112966.0 118589.0 119599.4 121752.0 971.5 994.0 1001.3 1004.6 1012.3 15353.1 16704.6 17616.8 18101.6 18430.7 28127.7 49410.8 52233.0 52370.7 52980.0 69810.0 75211.6 80381.6 81801.0 83368.0 7506.9 7896.5 8147.8 8155.2 8399.7 11727.9 12289.2 12723.7 12975.8 13295.0 11003.6 11015.3 11116.6 11168.6 11233.8 10117.5 10426.6 11027.0 11136.9 11583.7 11255.3 11500.9 11616.9 11822.3 11887.0 8140.8 8162.8 8209.8 8242.7 8282.9 10778.1 11611.8 11751.1 11868.5 11915.2 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5949.77 Median:5434.58 stddev:3175.25 (58.4%) stddev-sans-first:3166.89 08:12:34 INFO - PROCESS | 1677 | Values: 1544.3 1555.3 1794.9 1903.3 1919.1 7769.1 8456.0 8504.9 8733.5 8750.6 8514.3 8614.2 8670.2 8687.5 8712.2 2425.2 2428.8 2435.4 2447.4 2451.8 2418.9 2433.4 2448.7 2451.6 2466.3 2362.6 2391.3 2397.8 2424.6 2431.3 2033.7 2283.3 2388.2 2395.4 2469.7 2359.6 2393.5 2393.7 2394.0 2396.9 7992.7 8732.7 8751.7 8786.8 8788.4 4960.5 5406.6 5407.3 5444.2 5454.3 2894.2 2932.8 2950.4 3460.8 3583.3 816.4 898.9 1024.4 1037.7 1043.8 11398.1 11567.8 11742.3 11755.4 11756.4 4754.1 4844.2 4925.4 4927.0 4938.7 9968.8 10021.8 10028.3 10041.4 10045.5 5424.9 5455.8 5468.2 5477.1 5479.3 4407.5 4802.5 4869.1 4894.9 4926.2 3454.7 3749.0 3908.4 3917.3 3928.1 1304.1 1318.5 1318.6 1320.6 1334.6 1186.0 1266.3 1303.8 1331.9 1341.9 7874.1 8071.7 8133.4 8134.5 8147.6 513.6 524.2 524.4 526.4 529.2 6067.5 6081.2 6101.1 6114.5 6153.0 10460.8 10693.6 10699.8 10710.2 10849.5 9484.1 10497.5 10532.2 10658.3 10684.3 8089.6 8152.0 8159.7 8231.3 8269.5 7919.6 7935.3 7961.6 8008.1 8065.5 9266.9 9333.5 9442.4 9464.2 9475.5 9479.2 9692.5 9707.8 9943.2 10108.2 6743.6 7155.2 7375.4 7397.1 7468.6 8059.7 8098.5 8148.0 8161.8 8174.8 7149.5 7246.7 7248.1 7383.6 7389.7 7109.6 7184.8 7221.0 7277.6 7319.6 7631.1 7655.3 7655.6 7678.4 7692.7 5624.4 5920.9 6966.1 6984.3 6987.7 6921.8 6977.5 7034.9 7038.4 7080.3 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5999.03 Median:6694.38 stddev:1947.45 (29.1%) stddev-sans-first:1905.69 08:12:34 INFO - PROCESS | 1677 | Values: 319.7 320.9 325.7 326.6 329.4 6820.5 6857.0 6882.3 6887.5 6923.4 6691.8 6783.8 6784.9 6848.8 6866.8 4492.6 4767.6 4884.8 4966.9 5024.6 4980.1 5021.7 5036.8 5041.0 5062.3 4015.5 4969.9 4976.7 5012.6 5016.8 4969.0 4993.5 4999.4 5010.8 5050.9 4240.8 4256.2 4261.0 4268.4 4272.7 6289.7 6505.4 6566.5 6566.6 6602.2 5819.1 5839.9 5872.5 5890.6 5896.3 7284.8 7351.2 7372.6 7383.5 7404.0 4774.3 4782.0 4792.7 4797.3 4817.4 7345.7 7724.9 7776.0 7786.4 7825.1 4709.9 4776.0 4848.8 4869.5 4872.4 4943.8 4957.4 4967.8 4971.1 4991.6 5841.7 5846.2 5849.4 5865.4 5888.0 7324.9 7346.2 7354.9 7369.0 7382.3 1403.8 1628.5 1683.9 1684.6 1718.9 1104.3 1105.1 1127.6 1130.1 1132.4 6108.6 6651.3 6661.9 6681.9 6693.8 7472.4 7475.9 7477.5 7483.1 7531.8 6632.7 6682.2 6694.9 6710.1 6739.1 3734.7 3990.4 4004.8 4007.2 4019.9 6479.4 7803.5 7868.3 7929.6 8124.3 7957.1 7957.5 7972.4 7974.5 7984.4 8025.0 8027.6 8030.8 8047.1 8060.5 7370.7 7691.9 7737.6 7741.8 7756.3 7541.8 7550.1 7577.6 7583.2 7601.4 8047.3 8053.7 8062.9 8093.4 8125.6 4670.3 4722.6 4738.5 4740.2 4770.5 7402.0 7693.8 7697.5 7735.7 7740.6 7400.1 7401.0 7406.5 7415.2 7422.9 7368.7 7378.5 7379.6 7392.9 7412.0 6899.4 7219.0 7244.0 7263.2 7264.1 6025.5 7377.3 7378.5 7395.5 7405.6 5892.8 7223.6 7246.6 7248.4 7297.1 08:12:34 INFO - PROCESS | 1677 | 08:12:34 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17637.96 Median:31045.79 stddev:24031.54 (77.4%) stddev-sans-first:24065.21 08:12:34 INFO - PROCESS | 1677 | Values: 678.3 713.3 733.9 740.3 750.4 16850.2 17075.0 17207.7 17231.8 17288.6 15783.6 15818.5 15928.2 15928.8 15947.4 712.6 855.9 873.6 893.5 899.7 862.9 879.5 879.5 882.4 886.9 911.2 927.7 931.8 932.6 935.6 878.7 921.4 923.3 930.1 932.3 651.9 652.4 652.8 689.0 694.1 14918.0 14932.0 14941.0 15040.9 15314.1 12094.5 12258.6 12297.8 12397.4 12492.9 10833.0 10891.7 10898.2 10905.2 11185.5 3022.9 3397.1 3434.3 3478.4 3483.9 71459.0 74537.6 75000.0 75144.9 75248.2 9330.9 9481.2 9511.2 9533.4 10079.2 19547.9 19797.0 20446.5 20457.0 20458.5 7277.1 7324.9 7325.7 7642.8 7675.0 3969.8 3969.8 3994.3 4015.3 4062.1 3512.5 3585.7 3598.4 3608.7 3616.5 659.5 661.4 663.1 664.1 664.8 497.1 568.7 595.4 596.7 610.3 7147.3 7928.5 7933.4 8080.0 8128.0 598.8 599.7 608.6 608.7 612.6 3729.4 3774.1 3780.0 3800.8 3870.1 81770.6 83701.0 84200.7 84790.6 85146.0 66283.7 66512.0 66807.0 68491.7 75694.6 61479.0 66109.0 75389.6 75839.0 76859.0 6920.8 7458.5 7469.0 7627.7 7640.2 42838.1 44345.9 49442.8 49758.8 51259.2 63464.4 65656.7 69124.0 69991.7 70251.2 10862.0 10930.3 10949.9 11033.2 11178.7 12003.9 12028.1 12185.1 12448.3 12504.6 11335.5 11392.0 11417.5 11474.5 11712.8 11109.9 11183.2 11436.4 11491.5 11622.4 11033.8 11035.3 11171.0 11176.4 11429.7 9438.0 9446.7 9506.6 9722.3 9869.9 9333.9 9403.9 9502.8 9690.8 9773.0 08:12:34 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:12:34 INFO - PROCESS | 1677 | 08:12:35 INFO - TEST-INFO | 1677: exit 0 08:12:35 INFO - TEST-OK | dromaeo_css | took 1110720ms 08:12:35 INFO - TEST-START | kraken 08:12:35 INFO - operating with platform_type : mac_ 08:12:35 INFO - Initialising browser for kraken test... 08:12:35 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp5fHu1G/profile http://localhost:49274/getInfo.html) 08:12:37 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 08:12:37 INFO - PROCESS | 1684 | colorDepth:24 08:12:37 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 08:12:37 INFO - PROCESS | 1684 | __metrics 08:12:37 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:12:38 INFO - TEST-INFO | 1684: exit 0 08:12:38 INFO - Browser initialized. 08:12:38 INFO - Running cycle 1/1 for kraken test... 08:12:38 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp5fHu1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:50 INFO - PROCESS | 1687 | RSS: Main: 255696896 08:12:50 INFO - PROCESS | 1687 | 08:12:53 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:53 INFO - PROCESS | 1687 | RSS: Main: 268664832 08:12:53 INFO - PROCESS | 1687 | 08:12:56 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 08:12:57 INFO - PROCESS | 1687 | RSS: Main: 276213760 08:12:57 INFO - PROCESS | 1687 | 08:13:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 08:13:00 INFO - PROCESS | 1687 | RSS: Main: 280596480 08:13:00 INFO - PROCESS | 1687 | 08:13:02 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 08:13:03 INFO - PROCESS | 1687 | RSS: Main: 282759168 08:13:03 INFO - PROCESS | 1687 | 08:13:05 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:06 INFO - PROCESS | 1687 | RSS: Main: 283992064 08:13:06 INFO - PROCESS | 1687 | 08:13:09 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:09 INFO - PROCESS | 1687 | RSS: Main: 282693632 08:13:09 INFO - PROCESS | 1687 | 08:13:12 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:13 INFO - PROCESS | 1687 | RSS: Main: 282836992 08:13:13 INFO - PROCESS | 1687 | 08:13:16 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 08:13:16 INFO - PROCESS | 1687 | RSS: Main: 283353088 08:13:16 INFO - PROCESS | 1687 | 08:13:18 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:19 INFO - PROCESS | 1687 | RSS: Main: 283832320 08:13:19 INFO - PROCESS | 1687 | 08:13:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:21 INFO - PROCESS | 1687 | RSS: Main: 284319744 08:13:21 INFO - PROCESS | 1687 | 08:13:23 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:24 INFO - PROCESS | 1687 | RSS: Main: 284594176 08:13:24 INFO - PROCESS | 1687 | 08:13:27 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:27 INFO - PROCESS | 1687 | RSS: Main: 284065792 08:13:27 INFO - PROCESS | 1687 | 08:13:30 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:30 INFO - PROCESS | 1687 | RSS: Main: 283885568 08:13:30 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 08:13:32 INFO - PROCESS | 1687 | RSS: Main: 284647424 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | __start_tp_report 08:13:32 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 08:13:32 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 08:13:32 INFO - PROCESS | 1687 | |i|pagename|runs| 08:13:32 INFO - PROCESS | 1687 | |0;ai-astar;116;108;114;114;115;126;121;111;115;112 08:13:32 INFO - PROCESS | 1687 | |1;audio-beat-detection;151;144;180;187;130;142;122;155;166;153 08:13:32 INFO - PROCESS | 1687 | |2;audio-dft;192;193;198;201;201;244;226;273;202;226 08:13:32 INFO - PROCESS | 1687 | |3;audio-fft;67;92;71;136;76;71;80;52;121;49 08:13:32 INFO - PROCESS | 1687 | |4;audio-oscillator;84;87;117;103;118;122;117;82;116;155 08:13:32 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;86;93;85;91;101;121;85;109;110;81 08:13:32 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;121;104;93;95;96;94;95;95;94 08:13:32 INFO - PROCESS | 1687 | |7;imaging-desaturate;134;145;142;114;90;148;76;81;77;82 08:13:32 INFO - PROCESS | 1687 | |8;json-parse-financial;54;59;56;58;56;58;58;63;56;56 08:13:32 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;68;61;64;69;76;74;70;88;99;88 08:13:32 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;83;93;104;111;89;86;100;70;108;110 08:13:32 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;145;163;133;138;132;136;131;129;110;112 08:13:32 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;183;185;153;139;142;143;143;145;183;174 08:13:32 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;65;69;69;67;68;85;92;85;63;58 08:13:32 INFO - PROCESS | 1687 | __end_tp_report 08:13:32 INFO - PROCESS | 1687 | __start_cc_report 08:13:32 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,878 08:13:32 INFO - PROCESS | 1687 | __end_cc_report 08:13:32 INFO - PROCESS | 1687 | __startTimestamp1456416812918__endTimestamp 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | ------- Summary: start ------- 08:13:32 INFO - PROCESS | 1687 | Number of tests: 14 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:5.09 (4.4%) stddev-sans-first:5.40 08:13:32 INFO - PROCESS | 1687 | Values: 116.0 108.0 114.0 114.0 115.0 126.0 121.0 111.0 115.0 112.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:154.00 stddev:20.42 (13.3%) stddev-sans-first:21.65 08:13:32 INFO - PROCESS | 1687 | Values: 151.0 144.0 180.0 187.0 130.0 142.0 122.0 155.0 166.0 153.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:215.60 Median:214.00 stddev:26.47 (12.4%) stddev-sans-first:26.66 08:13:32 INFO - PROCESS | 1687 | Values: 192.0 193.0 198.0 201.0 201.0 244.0 226.0 273.0 202.0 226.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:81.50 Median:71.00 stddev:27.95 (39.4%) stddev-sans-first:29.15 08:13:32 INFO - PROCESS | 1687 | Values: 67.0 92.0 71.0 136.0 76.0 71.0 80.0 52.0 121.0 49.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:138.50 stddev:22.12 (16.0%) stddev-sans-first:21.35 08:13:32 INFO - PROCESS | 1687 | Values: 84.0 87.0 117.0 103.0 118.0 122.0 117.0 82.0 116.0 155.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:85.00 stddev:13.40 (15.8%) stddev-sans-first:13.69 08:13:32 INFO - PROCESS | 1687 | Values: 86.0 93.0 85.0 91.0 101.0 121.0 85.0 109.0 110.0 81.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:95.00 stddev:8.57 (9.0%) stddev-sans-first:9.02 08:13:32 INFO - PROCESS | 1687 | Values: 95.0 121.0 104.0 93.0 95.0 96.0 94.0 95.0 95.0 94.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:108.90 Median:76.50 stddev:30.81 (40.3%) stddev-sans-first:31.31 08:13:32 INFO - PROCESS | 1687 | Values: 134.0 145.0 142.0 114.0 90.0 148.0 76.0 81.0 77.0 82.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:2.46 (4.2%) stddev-sans-first:2.28 08:13:32 INFO - PROCESS | 1687 | Values: 54.0 59.0 56.0 58.0 56.0 58.0 58.0 63.0 56.0 56.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:75.00 stddev:12.19 (16.3%) stddev-sans-first:12.61 08:13:32 INFO - PROCESS | 1687 | Values: 68.0 61.0 64.0 69.0 76.0 74.0 70.0 88.0 99.0 88.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:76.50 stddev:13.52 (17.7%) stddev-sans-first:13.57 08:13:32 INFO - PROCESS | 1687 | Values: 83.0 93.0 104.0 111.0 89.0 86.0 100.0 70.0 108.0 110.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:134.50 stddev:15.16 (11.3%) stddev-sans-first:15.44 08:13:32 INFO - PROCESS | 1687 | Values: 145.0 163.0 133.0 138.0 132.0 136.0 131.0 129.0 110.0 112.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:163.50 stddev:19.68 (12.0%) stddev-sans-first:18.86 08:13:32 INFO - PROCESS | 1687 | Values: 183.0 185.0 153.0 139.0 142.0 143.0 143.0 145.0 183.0 174.0 08:13:32 INFO - PROCESS | 1687 | 08:13:32 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.00 stddev:11.17 (16.2%) stddev-sans-first:11.55 08:13:32 INFO - PROCESS | 1687 | Values: 65.0 69.0 69.0 67.0 68.0 85.0 92.0 85.0 63.0 58.0 08:13:32 INFO - PROCESS | 1687 | -------- Summary: end -------- 08:13:32 INFO - PROCESS | 1687 | 08:13:33 INFO - TEST-INFO | 1687: exit 0 08:13:33 INFO - TEST-OK | kraken | took 58505ms 08:13:33 INFO - SUITE-END | took 1169s 08:13:34 INFO - Completed test suite (00:19:29) 08:13:34 INFO - Working with test: dromaeo_css 08:13:34 INFO - Generating results file: dromaeo_css 08:13:34 INFO - Working with test: kraken 08:13:34 INFO - Generating results file: kraken 08:13:34 INFO - javascript benchmark 08:13:34 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:13:34 INFO - process_Request line: dromaeo_css 7438.63 graph.html#tests=[[72,64,61]] 08:13:34 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:34 INFO - process_Request line: kraken 1571.20 graph.html#tests=[[232,64,61]] 08:13:34 INFO - RETURN: dromaeo_css: 7438.63 08:13:34 INFO - RETURN: kraken: 1571.20 08:13:34 INFO - javascript benchmark 08:13:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2998.7451066659337, 3571.3571557119726, 3599.694026007789, 3641.526601541799, 3642.726795490339, 5774.3936886626825, 5801.738921748521, 5880.088586269129, 5908.497777688896, 5939.287285525743, 5843.941560584393, 5921.674307913063, 5923.200367950325, 5974.671393073369, 6044.546659000582, 5261.526462618363, 5286.392064912527, 5299.390570084451, 5405.891882162355, 5415.593830462712, 5354.41101478837, 5371.973140134294, 5421.810236641718, 5477.260569823083, 5493.121100623901, 5187.559057480119, 5230.895382092356, 5324.467553244684, 5352.91970620441, 5361.276227709248, 5304.0, 5309.681419114865, 5323.920141197885, 5329.360476742777, 5339.0, 5199.714015729133, 5275.815346462856, 5329.094054010828, 5362.651427657229, 5389.757460914229, 5705.258316418881, 5782.624129431573, 5859.091840764689, 5859.355470898197, 5918.911216331759, 6246.750129994794, 6264.561480696353, 6270.749170033193, 6272.153259310026, 6281.309056003836, 6156.538259630501, 6216.0, 6231.906521402183, 6269.905951410732, 6286.402791734778, 5962.672053037081, 5996.0, 6044.214252147192, 6062.363451837494, 6081.847953801146, 6304.968475157595, 6366.013267943384, 6380.585261957958, 6384.265809431882, 6397.072424498515, 6107.206063211754, 6196.0705894116245, 6242.0, 6266.717997690115, 6301.369863013662, 6212.254529456403, 6212.409821066992, 6250.843728906813, 6265.248170219603, 6326.2724786649205, 4714.457837348748, 6094.085887116968, 6251.437370636664, 6283.120363149163, 6292.182016337847, 5426.728663566885, 6111.804454079419, 6219.098230756515, 6220.0, 6255.56211065221, 3931.8623848165175, 4919.655624106278, 4933.703977761274, 4965.255211718199, 5001.299818025479, 3726.9937116978263, 4386.868393948187, 4420.557944205618, 4441.333799929972, 4480.551944805558, 5707.71461426927, 5878.735456904449, 5883.794067207627, 5887.0, 5974.522038236931, 6259.968700156561, 6266.154069200691, 6298.937010629835, 6302.527310451735, 6319.368063193736, 5982.312034116046, 6008.188894499274, 6011.248593925759, 6018.127371531104, 6035.668038257938, 5411.215373770781, 5471.452854714496, 5539.390667026624, 5567.387587365387, 5601.0, 5444.455554444603, 5852.502537284378, 6030.0, 6508.446782023581, 6509.088727578238, 6260.436560709558, 6278.968605156945, 6281.434670879643, 6284.402981716729, 6298.275698294755, 6291.937080629135, 6366.554341196072, 6426.646534440651, 6479.125318081999, 6500.934990650033, 6198.473129783839, 6198.81403557894, 6250.062490626442, 6251.156093927261, 6258.967270400333, 6147.262328520427, 6216.347283535345, 6291.056341548804, 6306.4639505642535, 6319.873602527831, 4716.764161791828, 6014.2181516404335, 6201.503879689704, 6224.875502490016, 6285.74857005733, 5128.974355128201, 6178.505719542516, 6276.152719382825, 6292.244930608356, 6306.936930630635, 5057.291979122852, 6038.154658347923, 6102.359252278447, 6149.661768602591, 6158.969205154125, 6097.827165393427, 6156.199694039746, 6165.84585385369, 6183.474404675653, 6252.406021427957, 6099.698590276447, 6103.204357007117, 6114.816555503342, 6115.0, 6137.693115344304], "unit": "score", "name": "dojo.html", "value": 5754.85161616612}, {"lowerIsBetter": false, "replicates": [444.77983398217884, 459.4807867110165, 492.24440483857273, 562.9585267255576, 589.7080944932254, 37585.06037349061, 37884.863454096354, 38351.232975340514, 38451.23097538047, 38542.03644908879, 39724.60275397245, 40095.799521002424, 40205.77839326872, 40217.59782402175, 40232.59767402325, 9453.054694530561, 9598.992105828893, 9614.855777163348, 9684.322097453181, 9732.951335243313, 9539.0, 9706.805863882719, 9756.024397560259, 9775.657851975182, 9831.164351030171, 9718.951405242964, 9771.26715496337, 9799.265055120895, 9819.459929703864, 9845.310828242025, 9730.708078757612, 9807.0, 9810.068043535888, 9821.0, 9837.360571562825, 9526.285528585384, 9636.95181524095, 9674.22606191503, 9676.225901927828, 9695.563699633534, 38656.61343386587, 38809.417858732144, 38932.80533597342, 39067.21865562701, 39178.60821391778, 3102.7828052036366, 3127.29635831936, 3171.762117841171, 3598.586162591283, 3763.8306276217636, 29451.0, 29539.70460295391, 29558.408831823457, 30016.0, 30155.0, 2313.7339205991357, 2776.7362100600612, 2802.8178168418985, 2807.242044647954, 2865.111815337252, 464259.0, 466581.6670916658, 472673.0, 473709.0, 473729.99999999657, 36557.08607284786, 45514.77242613832, 46127.30809037867, 54440.72779636076, 65441.0, 41607.75176744702, 43660.345094823606, 44895.326570101475, 45014.774926125814, 45334.54665453369, 12590.307533085768, 12972.351382430841, 14812.333444995002, 15229.543113706606, 15398.692026159413, 10582.788344233073, 11765.705857353634, 12152.027837772957, 12318.322492262832, 12469.563565275172, 11799.292042477478, 14530.85469145295, 14824.555263342118, 14873.33070011852, 14939.402423903139, 6162.445379915829, 6300.558960872695, 6327.4938004959495, 6354.777582784581, 6364.236291645032, 886.8004698942815, 916.7937214126902, 931.6040682709821, 939.8355287824741, 1062.1608928946046, 25589.0, 29283.414331713248, 29331.413371732448, 29533.85233073821, 29636.555451668242, 875.2297977779641, 1060.2949038889053, 1064.3932958213743, 1152.4410660829492, 1234.6172686467044, 14494.0, 14984.951053426374, 14986.775198372034, 15288.770668439982, 15456.38174473031, 529943.0, 531230.0, 531237.0, 531302.0, 536265.0, 57829.710851445474, 58276.0, 58744.7062764692, 58860.70569647125, 58994.0, 1353.1001883747394, 1383.7509248335396, 1393.1780249652754, 1402.754517959353, 1404.2276747788676, 29154.0, 29328.41343173082, 29358.412831743673, 29912.0, 29935.0, 51029.489705102475, 51068.0, 51416.71458213575, 51475.48524514707, 51731.96536069182, 419413.0, 433517.0, 433574.0, 433950.9814705564, 440584.1883162255, 32649.510257345682, 32722.83638581792, 33533.49699754457, 33855.0, 34251.657483424846, 44328.0, 44806.55193448154, 45720.54279457163, 46316.768416157705, 46444.30333545067, 36028.09929751777, 37151.81424092862, 37411.812940935124, 37510.8124459376, 38143.80928095342, 35557.0, 35658.82170589131, 36002.45996310005, 36586.0, 36758.26483470262, 37282.254354912206, 37719.81140094282, 38784.03039924025, 38862.80568597139, 38927.026824329616, 30590.235244119074, 33136.0, 33315.0, 33351.49972750362, 33352.83323583366, 22547.0, 24674.0, 24933.625995610444, 25248.0, 25457.23628291154], "unit": "score", "name": "ext.html", "value": 18884.457781202094}, {"lowerIsBetter": false, "replicates": [303.8055644387592, 351.52017496117793, 355.67988810070943, 359.2581319575079, 361.8932414937593, 15473.0, 15933.44232951847, 19691.507712307182, 20062.0, 20124.0, 19206.711899321486, 19423.514412139702, 19625.607487850233, 19706.11322490488, 19717.0, 4616.607588354994, 5092.337996060516, 5399.649022813504, 5426.484483974016, 5438.782448702047, 5279.076161671711, 5358.785648574052, 5363.490468405495, 5379.8386048418415, 5395.325584301962, 5348.090824559815, 5391.946080539184, 5392.622516423852, 5516.338039435253, 5688.374278829326, 4817.566419022305, 4858.295547145662, 5550.944490555084, 5707.571932105067, 5749.108888122327, 4766.666333356667, 5343.786248550054, 5491.368492623359, 5702.885942281173, 5717.571182161355, 13197.802032969514, 13256.939444844389, 13272.601821945356, 13299.335033248299, 13385.66535836612, 1728.9827101729072, 2125.4792575819024, 2187.7155969723995, 2342.472943587696, 2781.235160330905, 9688.0, 9899.752506187331, 9947.0, 10035.247356448295, 10053.994600539962, 1662.476319959221, 1713.4602600180904, 1734.0722713348298, 1737.5134962210602, 1783.8751287409757, 89591.0, 96415.03584964131, 96707.9999999993, 100106.49946750293, 100529.99470005279, 10822.458877056115, 11123.443827808738, 11152.386618735885, 11206.943965280121, 11309.321440713584, 12409.813852792215, 13277.668058298426, 13347.0, 13390.799138012937, 13400.0, 8321.916780832235, 8426.410151289474, 8443.155684431507, 8572.828543429096, 8701.21689047976, 8480.53357065355, 8482.406231563855, 8557.828843423222, 8820.985586657489, 8966.596503157374, 3652.324320000755, 4305.48334199898, 4381.3427985801745, 4390.560943905648, 4400.669949753781, 1750.4048623468082, 1813.4650278167971, 1857.9966817918444, 1860.3488778927267, 1874.7562816833997, 868.2272777228272, 882.40725490489, 887.7958069644018, 897.6678628907215, 902.7562558109274, 19666.90166549158, 20291.391258262276, 20561.177552897716, 20591.07340169666, 20718.274860380116, 826.9208682669174, 873.3841894556541, 891.0421297105637, 914.6295750221171, 918.86676431917, 8183.508989460652, 9138.268938484905, 10921.962413570698, 10992.395418251914, 11023.393713345842, 532179.0, 606920.9653951701, 609323.9067609356, 629714.0, 639805.0, 109270.45364773125, 112966.0, 118589.0, 119599.40200298943, 121752.0, 971.4656938683696, 993.965211217604, 1001.3491230700104, 1004.5881188712593, 1012.336919317848, 15353.141161889142, 16704.582385440463, 17616.823831761518, 18101.637967240844, 18430.723539146657, 28127.71872281251, 49410.764730880575, 52233.0, 52370.73814631055, 52980.0, 69810.0, 75211.62394187994, 80381.59809200917, 81801.0, 83368.0, 7506.9249307506225, 7896.486728362638, 8147.79630509242, 8155.225253600898, 8399.664013439395, 11727.941360293486, 12289.201201921847, 12723.745525089631, 12975.805362919375, 13295.0, 11003.646900134821, 11015.284006539548, 11116.610918618133, 11168.609098681507, 11233.775324493628, 10117.544710487899, 10426.582936682751, 11027.0, 11136.888631113909, 11583.710407239887, 11255.268407553483, 11500.884991149982, 11616.94191529037, 11822.34977076269, 11886.989605883597, 8140.83718325642, 8162.755117346489, 8209.79475513117, 8242.670293188205, 8282.917170828214, 10778.083862871743, 11611.825822612498, 11751.059915206934, 11868.465919033837, 11915.16593838423], "unit": "score", "name": "jquery.html", "value": 8988.014859192363}, {"lowerIsBetter": false, "replicates": [1544.2741911301687, 1555.3078879898446, 1794.9012804295767, 1903.3433465454423, 1919.1076149590438, 7769.067711874569, 8456.0, 8504.872426913593, 8733.519656418894, 8750.606222719976, 8514.318854491641, 8614.181652742995, 8670.176333248332, 8687.478751274912, 8712.172343627346, 2425.1511970810207, 2428.781409673129, 2435.391152211947, 2447.449323902126, 2451.779339859412, 2418.8790560471994, 2433.3916520869784, 2448.669429626995, 2451.5832308507597, 2466.3094333586623, 2362.5511152880986, 2391.282615215437, 2397.7961873240797, 2424.5756992526326, 2431.2706188143575, 2033.6847788592793, 2283.315005498344, 2388.2118900762794, 2395.3532546212514, 2469.6665950096685, 2359.5516851798275, 2393.4854006388537, 2393.6529203265427, 2393.964090538626, 2396.8801559921935, 7992.680292788282, 8732.738017859474, 8751.737447876574, 8786.824263514694, 8788.384813063089, 4960.454350021495, 5406.567474602022, 5407.324084489439, 5444.237806707064, 5454.318210223722, 2894.1751600793673, 2932.765378769693, 2950.4246671898986, 3460.7750496217664, 3583.2654305867236, 816.3877092180865, 898.9437411042, 1024.4160828327856, 1037.725002874239, 1043.8121138195122, 11398.1451391146, 11567.826482602684, 11742.295462272206, 11755.412229388496, 11756.412179391082, 4754.120487709784, 4844.176489996709, 4925.4335751388335, 4926.975365123151, 4938.728369939688, 9968.800623987625, 10021.849672254923, 10028.298019138736, 10041.397516149054, 10045.547950342252, 5424.918626220609, 5455.754491047913, 5468.234447177399, 5477.123660214346, 5479.342478902558, 4407.493138289074, 4802.51974802517, 4869.123557759637, 4894.853154405374, 4926.236433352764, 3454.7063499602314, 3748.962510374916, 3908.3746600544346, 3917.334053210961, 3928.1161738609158, 1304.087139002683, 1318.5319211679907, 1318.6110097521062, 1320.5972178485463, 1334.6396472952442, 1185.9978318321005, 1266.2782214137853, 1303.7653222419865, 1331.9134256273505, 1341.8591047940022, 7874.133845277015, 8071.677132914735, 8133.430659853753, 8134.511929284262, 8147.551884646401, 513.5762995528704, 524.2162966365308, 524.4126578232327, 526.4104203292337, 529.20090663099, 6067.453929146398, 6081.239845019372, 6101.084837274444, 6114.463955408552, 6152.969235153795, 10460.790784184426, 10693.625723099654, 10699.786004280026, 10710.196735244888, 10849.511771970281, 9484.05159484046, 10497.475126243657, 10532.15742740579, 10658.253922225369, 10684.25210235276, 8089.635966381527, 8152.021757389151, 8159.714409995621, 8231.300339471092, 8269.503829770112, 7919.604019799102, 7935.285824275843, 7961.641726122222, 8008.11910689812, 8065.475744076616, 9266.860997084914, 9333.53332333367, 9442.38624489406, 9464.242860571276, 9475.52622368865, 9479.19426848698, 9692.46691431978, 9707.757306067404, 9943.204543636637, 10108.241881858743, 6743.561668491532, 7155.248698886542, 7375.446841486802, 7397.075365579302, 7468.626568671436, 8059.677612895419, 8098.51408915467, 8148.022237331558, 8161.79595510117, 8174.83650327002, 7149.463790215651, 7246.746363877239, 7248.0939882514685, 7383.593902335423, 7389.704411823682, 7109.573425594481, 7184.784456466315, 7220.974975981539, 7277.636118194175, 7319.597422141834, 7631.122420921443, 7655.272749088827, 7655.578943157957, 7678.385729141767, 7692.692292308245, 5624.381318054929, 5920.881582368243, 6966.094407726963, 6984.26665200167, 6987.650617469208, 6921.757738479129, 6977.546459480118, 7034.929650703428, 7038.40173585251, 7080.2919708028785], "unit": "score", "name": "mootools.html", "value": 4761.206352753435}, {"lowerIsBetter": false, "replicates": [319.6883039036939, 320.9470437377833, 325.6615311071494, 326.59339122792113, 329.43337459569545, 6820.488463365243, 6857.040014397989, 6882.277360877105, 6887.483438742096, 6923.446124310043, 6691.832704182398, 6783.796486105425, 6784.932150678492, 6848.828779280508, 6866.828329291758, 4492.573205545468, 4767.61859051275, 4884.755762211893, 4966.900661986758, 5024.623153263511, 4980.128477516439, 5021.6986980781085, 5036.798528058874, 5040.966601846631, 5062.341895553573, 4015.4980627421573, 4969.925451118236, 4976.651634385595, 5012.598992080643, 5016.774245158958, 4968.950310496885, 4993.500649935032, 4999.42506611737, 5010.849674509753, 5050.949490505103, 4240.766757828318, 4256.191323648497, 4260.978695106504, 4268.359746038088, 4272.658187345005, 6289.7169627366875, 6505.447037001861, 6566.5075119365765, 6566.63883486408, 6602.207735071822, 5819.079703697812, 5839.883202335929, 5872.500837428824, 5890.587658863881, 5896.262967129109, 7284.781456556312, 7351.2281210472665, 7372.631368431557, 7383.48315617907, 7404.0004599378935, 4774.331593576902, 4782.019685964369, 4792.7124372537755, 4797.328374027639, 4817.421909370898, 7345.706171753177, 7724.922750772476, 7776.0, 7786.377089832799, 7825.13923468418, 4709.905801883943, 4775.95224047762, 4848.806047758121, 4869.464358920516, 4872.366592342973, 4943.8022479101155, 4957.380327459067, 4967.801287948441, 4971.105201063843, 4991.575716064102, 5841.678707671034, 5846.239988801429, 5849.385814489502, 5865.384134665884, 5888.0, 7324.926750732531, 7346.228645992094, 7354.926450735424, 7369.0, 7382.2617738225745, 1403.7716997627076, 1628.51958672192, 1683.9494815155565, 1684.562013876401, 1718.931242750276, 1104.276698762312, 1105.132471010253, 1127.5997021057572, 1130.141092769501, 1132.3545579019878, 6108.602940808833, 6651.334866513407, 6661.9000714989315, 6681.899771503431, 6693.832654183684, 7472.393435411304, 7475.887861682079, 7477.476576639583, 7483.102027756595, 7531.849363012709, 6632.668366581748, 6682.164729408824, 6694.933050669529, 6710.0941372915, 6739.056532085512, 3734.6638802507905, 3990.4213888986515, 4004.799760011988, 4007.158496715664, 4019.93970090443, 6479.352064793483, 7803.531788092732, 7868.331191848642, 7929.603519823986, 8124.268815806606, 7957.124716281204, 7957.482763620346, 7972.441929064909, 7974.481658692166, 7984.361251099898, 8025.0, 8027.5584842834205, 8030.759077227693, 8047.114817370085, 8060.516369017761, 7370.705171793283, 7691.923080769121, 7737.5744334062165, 7741.7677469676, 7756.263155000266, 7541.849163016599, 7550.131734850563, 7577.621118944141, 7583.2416758323725, 7601.353884919844, 8047.275745182962, 8053.718119865776, 8062.919370806217, 8093.352531797324, 8125.553094579855, 4670.252759558454, 4722.622190224843, 4738.478767335521, 4740.217864052531, 4770.451398089264, 7401.962990185015, 7693.769186924401, 7697.496964275962, 7735.6518956648215, 7740.574268415291, 7400.111986561647, 7401.0, 7406.518576292524, 7415.184329723834, 7422.851542969219, 7368.668409921674, 7378.520396174232, 7379.557226566423, 7392.852142957218, 7411.99938008362, 6899.379055884994, 7218.963905180441, 7244.0, 7263.237360077327, 7264.055672762507, 6025.487833534199, 7377.299156580117, 7378.483506154517, 7395.482316237812, 7405.555666660018, 5892.823215303548, 7223.638818059181, 7246.565206087652, 7248.383887369422, 7297.124345078624], "unit": "score", "name": "prototype.html", "value": 5338.6490704355065}, {"lowerIsBetter": false, "replicates": [678.274246556185, 713.2653367031955, 733.9339459448648, 740.3263030642116, 750.4221749253079, 16850.24173912174, 17075.0, 17207.65584688307, 17231.827681723178, 17288.56778580536, 15783.605409864758, 15818.525444236662, 15928.203589820521, 15928.761068583952, 15947.362105515766, 712.583138863764, 855.8502262104138, 873.5675840458981, 893.4594570284982, 899.7120921305185, 862.8662557303628, 879.5118709116438, 879.5294517433175, 882.4308321132866, 886.8935727712684, 911.225458360395, 927.6614035876923, 931.8462453695132, 932.5896605493595, 935.6210734652443, 878.6704985630389, 921.4425272709981, 923.2521657457481, 930.0559931669361, 932.2774849491631, 651.8891788395985, 652.3965332067818, 652.8139480248154, 689.0387908867102, 694.1011390249639, 14918.030328028643, 14931.954763166583, 14941.0, 15040.924795376062, 15314.081155130727, 12094.455749491293, 12258.570950016796, 12297.754044919051, 12397.380130993415, 12492.937535312356, 10833.0, 10891.727706807314, 10898.182636302308, 10905.18211134168, 11185.48995885553, 3022.9395412091853, 3397.0827876473213, 3434.261633748731, 3478.3738926993133, 3483.9303213935577, 71459.0, 74537.62731186363, 75000.0, 75144.87282690764, 75248.24751752467, 9330.906690933003, 9481.24150067993, 9511.239100871913, 9533.427994320364, 10079.193664506822, 19547.902260488605, 19797.0, 20446.488837779176, 20457.0, 20458.488537786674, 7277.053982982285, 7324.853502930018, 7325.706971721178, 7642.770716878391, 7675.0, 3969.801509924492, 3969.8412063517135, 3994.3009973254566, 4015.297322968469, 4062.1266427718183, 3512.5433693619666, 3585.731070169748, 3598.4062629666337, 3608.7113030957985, 3616.4575313703153, 659.5416185750857, 661.3882159002903, 663.0617675988423, 664.1200409457392, 664.837114906851, 497.0580749479716, 568.6976823075195, 595.3599880128879, 596.7434003378502, 610.2798697536949, 7147.3210045045635, 7928.524288542706, 7933.404994625426, 8080.0, 8128.0, 598.7844376024627, 599.7001499250375, 608.564876113572, 608.6834845880118, 612.5712001598898, 3729.4219395993664, 3774.0753515388906, 3780.0, 3800.847966081381, 3870.1098747288283, 81770.59114704389, 83701.0, 84200.73698894521, 84790.57604711936, 85146.0, 66283.67432651417, 66512.00231996524, 66806.99789503161, 68491.65754171197, 75694.621526892, 61479.0, 66109.0, 75389.62305188549, 75838.9999999989, 76859.0, 6920.826979325356, 7458.5151965122095, 7468.962655186907, 7627.733029343946, 7640.159582445815, 42838.14323713571, 44345.89135271644, 49442.75278623584, 49758.75120624374, 51259.2311115341, 63464.36535634584, 65656.67171664111, 69124.0, 69991.65004174947, 70251.24371890744, 10862.0, 10930.289531180766, 10949.945250273699, 11033.172512061466, 11178.664640060812, 12003.939980300393, 12028.09789265791, 12185.086118541321, 12448.31534265624, 12504.562340318045, 11335.546578136782, 11392.0, 11417.486213120595, 11474.483648235682, 11712.81766971264, 11109.888901110886, 11183.161262905478, 11436.370999595103, 11491.482883270106, 11622.418879056182, 11033.842838328623, 11035.282706624044, 11171.0, 11176.441177941233, 11429.714257143305, 9438.0, 9446.669366572138, 9506.572204250688, 9722.319437639297, 9869.901300986898, 9333.906660933575, 9403.905960940303, 9502.762430939281, 9690.75773105678, 9772.951135244279], "unit": "score", "name": "yui.html", "value": 6822.991298574235}], "name": "dromaeo_css", "value": 7438.631633239656}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 114.0, 114.0, 115.0, 126.0, 121.0, 111.0, 115.0, 112.0], "unit": "score", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [151.0, 144.0, 180.0, 187.0, 130.0, 142.0, 122.0, 155.0, 166.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 198.0, 201.0, 201.0, 244.0, 226.0, 273.0, 202.0, 226.0], "unit": "score", "name": "audio-dft", "value": 215.6}, {"lowerIsBetter": true, "replicates": [67.0, 92.0, 71.0, 136.0, 76.0, 71.0, 80.0, 52.0, 121.0, 49.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 117.0, 103.0, 118.0, 122.0, 117.0, 82.0, 116.0, 155.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 85.0, 91.0, 101.0, 121.0, 85.0, 109.0, 110.0, 81.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.2}, {"lowerIsBetter": true, "replicates": [95.0, 121.0, 104.0, 93.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 98.2}, {"lowerIsBetter": true, "replicates": [134.0, 145.0, 142.0, 114.0, 90.0, 148.0, 76.0, 81.0, 77.0, 82.0], "unit": "score", "name": "imaging-desaturate", "value": 108.9}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 56.0, 58.0, 56.0, 58.0, 58.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [68.0, 61.0, 64.0, 69.0, 76.0, 74.0, 70.0, 88.0, 99.0, 88.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.7}, {"lowerIsBetter": true, "replicates": [83.0, 93.0, 104.0, 111.0, 89.0, 86.0, 100.0, 70.0, 108.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.4}, {"lowerIsBetter": true, "replicates": [145.0, 163.0, 133.0, 138.0, 132.0, 136.0, 131.0, 129.0, 110.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.9}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 153.0, 139.0, 142.0, 143.0, 143.0, 145.0, 183.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.0}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 69.0, 67.0, 68.0, 85.0, 92.0, 85.0, 63.0, 58.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1571.2000000000003}]} 08:13:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1571.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7438.63"}}} 08:13:34 INFO - Return code: 0 08:13:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:13:34 ERROR - # TBPL SUCCESS # 08:13:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:34 INFO - 2016-02-25 08:13:34.782 screenresolution[1692:10800] starting screenresolution argv=screenresolution get 08:13:34 INFO - 2016-02-25 08:13:34.785 screenresolution[1692:10800] Display 0: 1600x1200x32@60 08:13:34 INFO - 2016-02-25 08:13:34.790 screenresolution[1693:10803] starting screenresolution argv=screenresolution list 08:13:34 INFO - Available Modes on Display 0 08:13:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:35 INFO - Intel Iris: 08:13:35 INFO - Chipset Model: Intel Iris 08:13:35 INFO - Type: GPU 08:13:35 INFO - Bus: Built-In 08:13:35 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:35 INFO - Vendor: Intel (0x8086) 08:13:35 INFO - Device ID: 0x0a2e 08:13:35 INFO - Revision ID: 0x0009 08:13:35 INFO - Displays: 08:13:35 INFO - Display: 08:13:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:35 INFO - Display Serial Number: 1600x1200 60 08:13:35 INFO - Main Display: Yes 08:13:35 INFO - Mirror: Off 08:13:35 INFO - Online: Yes 08:13:35 INFO - Rotation: Supported 08:13:35 INFO - Return code: 0 08:13:35 INFO - Running post-action listener: _resource_record_post_action 08:13:35 INFO - Running post-run listener: _resource_record_post_run 08:13:36 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33914368; Write bytes: 712015872; Read time: 353; Write time: 2039 08:13:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385020416; Write bytes: 379058176; Read time: 28941; Write time: 677 08:13:36 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32988672; Write bytes: 305375232; Read time: 338; Write time: 1300 08:13:36 INFO - Running post-run listener: _upload_blobber_files 08:13:36 INFO - Blob upload gear active. 08:13:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:36 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:13:36 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:13:36 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:13:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:37 INFO - (blobuploader) - INFO - Done attempting. 08:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:38 INFO - (blobuploader) - INFO - Done attempting. 08:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:38 INFO - Return code: 0 08:13:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/109911a7eb2b3214ddc3d7d5a369a92fe2f815343226261b4506031004c75521625b76a6be2ece519cfb56653cd9c5bf79fbd0c5d8c2810973e44381c5180c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d1ac99ff560c370a2fff78559f7c932bfc1184e6e2a087a3235309769ebed996d281a58ccd2bf3247013ad86e04fdf9b2c066469585debdf888da3dbac2f64"} 08:13:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:38 INFO - Contents: 08:13:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/109911a7eb2b3214ddc3d7d5a369a92fe2f815343226261b4506031004c75521625b76a6be2ece519cfb56653cd9c5bf79fbd0c5d8c2810973e44381c5180c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d1ac99ff560c370a2fff78559f7c932bfc1184e6e2a087a3235309769ebed996d281a58ccd2bf3247013ad86e04fdf9b2c066469585debdf888da3dbac2f64"} 08:13:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:38 INFO - Copying logs to upload dir... 08:13:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.661651 ========= master_lag: 16.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-25 08:13:55.512292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 24 secs) (at 2016-02-25 08:13:55.516246) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/109911a7eb2b3214ddc3d7d5a369a92fe2f815343226261b4506031004c75521625b76a6be2ece519cfb56653cd9c5bf79fbd0c5d8c2810973e44381c5180c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d1ac99ff560c370a2fff78559f7c932bfc1184e6e2a087a3235309769ebed996d281a58ccd2bf3247013ad86e04fdf9b2c066469585debdf888da3dbac2f64"} build_url:https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011700 build_url: 'https://queue.taskcluster.net/v1/task/VOjbvxvMQDm50eDdv4_OaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/109911a7eb2b3214ddc3d7d5a369a92fe2f815343226261b4506031004c75521625b76a6be2ece519cfb56653cd9c5bf79fbd0c5d8c2810973e44381c5180c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d1ac99ff560c370a2fff78559f7c932bfc1184e6e2a087a3235309769ebed996d281a58ccd2bf3247013ad86e04fdf9b2c066469585debdf888da3dbac2f64"}' ========= master_lag: 24.69 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 24 secs) (at 2016-02-25 08:14:20.213145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-25 08:14:20.213436) ========= 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.K5fNc3WlzJ/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.abvv4SbznY/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005427 ========= master_lag: 3.78 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-25 08:14:23.996908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 08:14:23.997174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 08:14:24.189614) ========= ========= Total master_lag: 74.36 =========