builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1455724661.14 results: success (0) buildid: 20160217060406 builduid: bf1e543d78cd457fafdf0ab59e387e99 revision: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.138443) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.138938) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.139261) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005846 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.165694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.166489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.183165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.183783) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005195 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.236294) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.236838) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.237515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.238037) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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-17 07:57:41-- 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% 8.21M=0.001s 2016-02-17 07:57:41 (8.21 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.360561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.361352) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.019062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:41.414682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:57:41.415054) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 --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 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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-17 07:57:41,486 truncating revision to first 12 chars 2016-02-17 07:57:41,486 Setting DEBUG logging. 2016-02-17 07:57:41,486 attempt 1/10 2016-02-17 07:57:41,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b8c69102f12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 07:57:42,542 unpacking tar archive at: fx-team-3b8c69102f12/testing/mozharness/ program finished with exit code 0 elapsedTime=1.291374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:57:42.722666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:42.723091) ========= echo 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3b8c69102f125cfd6a6e870bfde4c08fb4cfe899'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 program finished with exit code 0 elapsedTime=0.005123 script_repo_revision: '3b8c69102f125cfd6a6e870bfde4c08fb4cfe899' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:42.773568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:42.773940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:57:42.786793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-17 07:57:42.787158) ========= /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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:57:42 INFO - MultiFileLogger online at 20160217 07:57:42 in /builds/slave/test 07:57:42 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:57:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:57:42 INFO - {'append_to_log': False, 07:57:42 INFO - 'base_work_dir': '/builds/slave/test', 07:57:42 INFO - 'blob_upload_branch': 'Fx-Team', 07:57:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:57:42 INFO - 'branch': 'Fx-Team', 07:57:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:57:42 INFO - 'config_files': ('talos/mac_config.py',), 07:57:42 INFO - 'default_actions': ('clobber', 07:57:42 INFO - 'read-buildbot-config', 07:57:42 INFO - 'download-and-extract', 07:57:42 INFO - 'populate-webroot', 07:57:42 INFO - 'create-virtualenv', 07:57:42 INFO - 'install', 07:57:42 INFO - 'run-tests'), 07:57:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:57:42 INFO - 'download_minidump_stackwalk': True, 07:57:42 INFO - 'download_symbols': 'ondemand', 07:57:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:57:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:57:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:57:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:57:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:57:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:57:42 INFO - 'installer_path': 'installer.exe', 07:57:42 INFO - 'log_level': 'info', 07:57:42 INFO - 'log_name': 'talos', 07:57:42 INFO - 'log_to_console': True, 07:57:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:57:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:57:42 INFO - 'opt_config_files': (), 07:57:42 INFO - 'pip_index': False, 07:57:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:57:42 INFO - 'cmd': ('bash', 07:57:42 INFO - '-c', 07:57:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:57:42 INFO - 'enabled': True, 07:57:42 INFO - 'halt_on_failure': False, 07:57:42 INFO - 'name': 'check_screen_resolution'},), 07:57:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:57:42 INFO - 'cmd': ('bash', 07:57:42 INFO - '-c', 07:57:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:57:42 INFO - 'enabled': True, 07:57:42 INFO - 'halt_on_failure': False, 07:57:42 INFO - 'name': 'check_screen_resolution'},), 07:57:42 INFO - 'run_cmd_checks_enabled': True, 07:57:42 INFO - 'sps_profile': False, 07:57:42 INFO - 'sps_profile_interval': 0, 07:57:42 INFO - 'suite': 'dromaeojs-e10s', 07:57:42 INFO - 'system_bits': '32', 07:57:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:57:42 INFO - 'title': 't-yosemite-r7-0132', 07:57:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:57:42 INFO - 'use_talos_json': True, 07:57:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:57:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:57:42 INFO - 'work_dir': 'build'} 07:57:42 INFO - ##### 07:57:42 INFO - ##### Running clobber step. 07:57:42 INFO - ##### 07:57:42 INFO - Running pre-action listener: _resource_record_pre_action 07:57:42 INFO - Running main action method: clobber 07:57:42 INFO - rmtree: /builds/slave/test/build 07:57:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:57:44 INFO - Running post-action listener: _resource_record_post_action 07:57:44 INFO - ##### 07:57:44 INFO - ##### Running read-buildbot-config step. 07:57:44 INFO - ##### 07:57:44 INFO - Running pre-action listener: _resource_record_pre_action 07:57:44 INFO - Running main action method: read_buildbot_config 07:57:44 INFO - Using buildbot properties: 07:57:44 INFO - { 07:57:44 INFO - "project": "", 07:57:44 INFO - "product": "firefox", 07:57:44 INFO - "script_repo_revision": "production", 07:57:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:57:44 INFO - "repository": "", 07:57:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:57:44 INFO - "buildid": "20160217060406", 07:57:44 INFO - "pgo_build": "False", 07:57:44 INFO - "basedir": "/builds/slave/test", 07:57:44 INFO - "buildnumber": 443, 07:57:44 INFO - "slavename": "t-yosemite-r7-0132", 07:57:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:57:44 INFO - "platform": "yosemite_r7", 07:57:44 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:57:44 INFO - "branch": "fx-team", 07:57:44 INFO - "repo_path": "integration/fx-team", 07:57:44 INFO - "revision": "3b8c69102f125cfd6a6e870bfde4c08fb4cfe899", 07:57:44 INFO - "stage_platform": "macosx64", 07:57:44 INFO - "builduid": "bf1e543d78cd457fafdf0ab59e387e99", 07:57:44 INFO - "slavebuilddir": "test" 07:57:44 INFO - } 07:57:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:57:44 INFO - Running post-action listener: _resource_record_post_action 07:57:44 INFO - ##### 07:57:44 INFO - ##### Running download-and-extract step. 07:57:44 INFO - ##### 07:57:44 INFO - Running pre-action listener: _resource_record_pre_action 07:57:44 INFO - Running main action method: download_and_extract 07:57:44 INFO - mkdir: /builds/slave/test/build/tests 07:57:44 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:57:44 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json 07:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json 07:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:57:46 INFO - Downloaded 1277 bytes. 07:57:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:57:46 INFO - Using the following test package requirements: 07:57:46 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:57:46 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:57:46 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:57:46 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'jsshell-mac.zip'], 07:57:46 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:57:46 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:57:46 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:57:46 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:57:46 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:57:46 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:57:46 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:57:46 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:57:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:46 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:47 INFO - Downloaded 17806601 bytes. 07:57:47 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:57:47 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:57:50 INFO - Return code: 0 07:57:50 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:57: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:57:50 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:51 INFO - Downloaded 17806601 bytes. 07:57:51 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:57:51 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:57:54 INFO - Return code: 0 07:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:54 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:57:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:57:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:57:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:55 INFO - Downloaded 10707071 bytes. 07:57:55 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:57:55 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:57:56 INFO - Return code: 0 07:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:56 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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:57:59 INFO - Downloaded 111229089 bytes. 07:57:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:59 INFO - mkdir: /builds/slave/test/properties 07:57:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:57:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:57:59 INFO - Contents: 07:57:59 INFO - build_url:https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:58:00 INFO - Running post-action listener: _resource_record_post_action 07:58:00 INFO - Running post-action listener: set_extra_try_arguments 07:58:00 INFO - ##### 07:58:00 INFO - ##### Running populate-webroot step. 07:58:00 INFO - ##### 07:58:00 INFO - Running pre-action listener: _resource_record_pre_action 07:58:00 INFO - Running main action method: populate_webroot 07:58:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:00 INFO - '--tppagecycles', 07:58:00 INFO - '7'], 07:58:00 INFO - 'tests': ['tsvgm']}}, 07:58:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:58:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:58:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'tests': ['damp', 'tps']}, 07:58:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['damp', 'tps']}, 07:58:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:58:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:00 INFO - 'other': {'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'other_l64': {'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'other_nol64': {'tests': ['a11yr', 07:58:00 INFO - 'ts_paint', 07:58:00 INFO - 'tpaint', 07:58:00 INFO - 'sessionrestore', 07:58:00 INFO - 'sessionrestore_no_auto_restore']}, 07:58:00 INFO - 'svgr': {'tests': ['tsvgx', 07:58:00 INFO - 'tsvgr_opacity', 07:58:00 INFO - 'tart', 07:58:00 INFO - 'tscrollx', 07:58:00 INFO - 'cart']}, 07:58:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['tsvgx', 07:58:00 INFO - 'tsvgr_opacity', 07:58:00 INFO - 'tart', 07:58:00 INFO - 'tscrollx', 07:58:00 INFO - 'cart']}, 07:58:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'tests': ['tp5o']}, 07:58:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'talos_options': ['--e10s'], 07:58:00 INFO - 'tests': ['tp5o']}, 07:58:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'talos_options': ['--xperf_path', 07:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:00 INFO - 'tests': ['tp5n']}, 07:58:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:00 INFO - 'talos_options': ['--e10s', 07:58:00 INFO - '--xperf_path', 07:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:00 INFO - 'tests': ['tp5n']}}, 07:58:00 INFO - 'talos.zip': {'path': '', 07:58:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:00 INFO - Running post-action listener: _resource_record_post_action 07:58:00 INFO - ##### 07:58:00 INFO - ##### Running create-virtualenv step. 07:58:00 INFO - ##### 07:58:00 INFO - Running pre-action listener: _resource_record_pre_action 07:58:00 INFO - Running main action method: create_virtualenv 07:58:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:00 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:58:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:00 INFO - Using real prefix '/tools/python27' 07:58:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:04 INFO - Installing pip.................done. 07:58:04 INFO - Return code: 0 07:58:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:04 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:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:04 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:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:04 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:04 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:58:04 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:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:04 INFO - 'HOME': '/Users/cltbld', 07:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:04 INFO - 'LOGNAME': 'cltbld', 07:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:04 INFO - 'MOZ_NO_REMOTE': '1', 07:58:04 INFO - 'NO_EM_RESTART': '1', 07:58:04 INFO - 'PAGER': '/bin/cat', 07:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:04 INFO - 'PWD': '/builds/slave/test', 07:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:04 INFO - 'SHELL': '/bin/bash', 07:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:04 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:04 INFO - 'USER': 'cltbld', 07:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:04 INFO - 'XPC_FLAGS': '0x0', 07:58:04 INFO - 'XPC_SERVICE_NAME': '0', 07:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:04 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:58:04 INFO - Cleaning up... 07:58:04 INFO - Return code: 0 07:58:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:58:04 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:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:04 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:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:04 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:04 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:58:04 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:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:04 INFO - 'HOME': '/Users/cltbld', 07:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:04 INFO - 'LOGNAME': 'cltbld', 07:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:04 INFO - 'MOZ_NO_REMOTE': '1', 07:58:04 INFO - 'NO_EM_RESTART': '1', 07:58:04 INFO - 'PAGER': '/bin/cat', 07:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:04 INFO - 'PWD': '/builds/slave/test', 07:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:04 INFO - 'SHELL': '/bin/bash', 07:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:04 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:04 INFO - 'USER': 'cltbld', 07:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:04 INFO - 'XPC_FLAGS': '0x0', 07:58:04 INFO - 'XPC_SERVICE_NAME': '0', 07:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:04 INFO - Downloading/unpacking psutil>=0.7.1 07:58:04 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:58:04 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:58:04 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:58:04 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:58:04 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:58:04 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:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:07 INFO - Installing collected packages: psutil 07:58:07 INFO - Running setup.py install for psutil 07:58:07 INFO - building 'psutil._psutil_osx' extension 07:58:07 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:58:07 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:58:07 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:58:08 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:58:08 INFO - building 'psutil._psutil_posix' extension 07:58:08 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:58:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:58:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:58:08 INFO - ^ 07:58:08 INFO - 1 warning generated. 07:58:08 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:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:08 INFO - Successfully installed psutil 07:58:08 INFO - Cleaning up... 07:58:08 INFO - Return code: 0 07:58:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:08 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:08 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:58:08 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:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:08 INFO - 'HOME': '/Users/cltbld', 07:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:08 INFO - 'LOGNAME': 'cltbld', 07:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:08 INFO - 'MOZ_NO_REMOTE': '1', 07:58:08 INFO - 'NO_EM_RESTART': '1', 07:58:08 INFO - 'PAGER': '/bin/cat', 07:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:08 INFO - 'PWD': '/builds/slave/test', 07:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:08 INFO - 'SHELL': '/bin/bash', 07:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:08 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:08 INFO - 'USER': 'cltbld', 07:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:08 INFO - 'XPC_FLAGS': '0x0', 07:58:08 INFO - 'XPC_SERVICE_NAME': '0', 07:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:58: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:58: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:58: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:58: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:58: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:58: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:58:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:11 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:58:11 INFO - Installing collected packages: mozsystemmonitor 07:58:11 INFO - Running setup.py install for mozsystemmonitor 07:58:11 INFO - Successfully installed mozsystemmonitor 07:58:11 INFO - Cleaning up... 07:58:11 INFO - Return code: 0 07:58:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:11 INFO - 'HOME': '/Users/cltbld', 07:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:11 INFO - 'LOGNAME': 'cltbld', 07:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:11 INFO - 'MOZ_NO_REMOTE': '1', 07:58:11 INFO - 'NO_EM_RESTART': '1', 07:58:11 INFO - 'PAGER': '/bin/cat', 07:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:11 INFO - 'PWD': '/builds/slave/test', 07:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:11 INFO - 'SHELL': '/bin/bash', 07:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:11 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:11 INFO - 'USER': 'cltbld', 07:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:11 INFO - 'XPC_FLAGS': '0x0', 07:58:11 INFO - 'XPC_SERVICE_NAME': '0', 07:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:14 INFO - Downloading docopt-0.6.1.tar.gz 07:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:15 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:15 INFO - Running setup.py install for blobuploader 07:58:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:15 INFO - Running setup.py install for requests 07:58:15 INFO - Running setup.py install for docopt 07:58:15 INFO - Successfully installed blobuploader requests docopt 07:58:15 INFO - Cleaning up... 07:58:15 INFO - Return code: 0 07:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:15 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:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 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:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:15 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:58:15 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:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:15 INFO - 'HOME': '/Users/cltbld', 07:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:15 INFO - 'LOGNAME': 'cltbld', 07:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:15 INFO - 'MOZ_NO_REMOTE': '1', 07:58:15 INFO - 'NO_EM_RESTART': '1', 07:58:15 INFO - 'PAGER': '/bin/cat', 07:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:15 INFO - 'PWD': '/builds/slave/test', 07:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:15 INFO - 'SHELL': '/bin/bash', 07:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:15 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:15 INFO - 'USER': 'cltbld', 07:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:15 INFO - 'XPC_FLAGS': '0x0', 07:58:15 INFO - 'XPC_SERVICE_NAME': '0', 07:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-pomFaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-JzVWON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-qAg6YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-BpgxEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-AiioTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-53uRiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-0D5Yk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:16 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-gBwQi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-uALshS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-6Cp_gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-MGcaCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-XZniG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-Pd2Ial-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-JCLixa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-qsB0bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-X83naG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:17 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-vW4vT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:58:17 INFO - Running setup.py install for manifestparser 07:58:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:58:18 INFO - Running setup.py install for mozcrash 07:58:18 INFO - Running setup.py install for mozdebug 07:58:18 INFO - Running setup.py install for mozdevice 07:58:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:58:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:58:18 INFO - Running setup.py install for mozfile 07:58:18 INFO - Running setup.py install for mozhttpd 07:58:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:58:18 INFO - Running setup.py install for mozinfo 07:58:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Running setup.py install for mozInstall 07:58:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Running setup.py install for mozleak 07:58:19 INFO - Running setup.py install for mozlog 07:58:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Running setup.py install for moznetwork 07:58:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Running setup.py install for mozprocess 07:58:19 INFO - Running setup.py install for mozprofile 07:58:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:58:19 INFO - Running setup.py install for mozrunner 07:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:58:20 INFO - Running setup.py install for mozscreenshot 07:58:20 INFO - Running setup.py install for moztest 07:58:20 INFO - Running setup.py install for mozversion 07:58:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:58:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:58:20 INFO - Cleaning up... 07:58:20 INFO - Return code: 0 07:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:20 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:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 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:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:20 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:58:20 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:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:20 INFO - 'HOME': '/Users/cltbld', 07:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:20 INFO - 'LOGNAME': 'cltbld', 07:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:20 INFO - 'MOZ_NO_REMOTE': '1', 07:58:20 INFO - 'NO_EM_RESTART': '1', 07:58:20 INFO - 'PAGER': '/bin/cat', 07:58:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:20 INFO - 'PWD': '/builds/slave/test', 07:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:20 INFO - 'SHELL': '/bin/bash', 07:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:20 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:20 INFO - 'USER': 'cltbld', 07:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:20 INFO - 'XPC_FLAGS': '0x0', 07:58:20 INFO - 'XPC_SERVICE_NAME': '0', 07:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:20 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-OBOVp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:20 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:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:20 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-Om80Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-nUaMsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-RKJbWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-Pai26J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-JkHHh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-I9U4fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-_obpFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-2KGaAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-evCWrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-2_uNNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:21 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:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-GWe93t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:22 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:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-MN4tQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:22 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:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-HQdb9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:22 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:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-EJec9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:22 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:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-Ru1VRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:22 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:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-rOhoB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:22 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:58:22 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:58:22 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:58:22 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:58:22 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:58:22 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:58:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58: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:58: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:58: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:58: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:58: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:58: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:58:24 INFO - Downloading blessings-1.6.tar.gz 07:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:58:25 INFO - Installing collected packages: blessings 07:58:25 INFO - Running setup.py install for blessings 07:58:25 INFO - Successfully installed blessings 07:58:25 INFO - Cleaning up... 07:58:25 INFO - Return code: 0 07:58:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:25 INFO - Reading from file tmpfile_stdout 07:58:25 INFO - Current package versions: 07:58:25 INFO - blessings == 1.6 07:58:25 INFO - blobuploader == 1.2.4 07:58:25 INFO - docopt == 0.6.1 07:58:25 INFO - manifestparser == 1.1 07:58:25 INFO - mozInstall == 1.12 07:58:25 INFO - mozcrash == 0.16 07:58:25 INFO - mozdebug == 0.1 07:58:25 INFO - mozdevice == 0.48 07:58:25 INFO - mozfile == 1.2 07:58:25 INFO - mozhttpd == 0.7 07:58:25 INFO - mozinfo == 0.9 07:58:25 INFO - mozleak == 0.1 07:58:25 INFO - mozlog == 3.1 07:58:25 INFO - moznetwork == 0.27 07:58:25 INFO - mozprocess == 0.22 07:58:25 INFO - mozprofile == 0.28 07:58:25 INFO - mozrunner == 6.11 07:58:25 INFO - mozscreenshot == 0.1 07:58:25 INFO - mozsystemmonitor == 0.0 07:58:25 INFO - moztest == 0.7 07:58:25 INFO - mozversion == 1.4 07:58:25 INFO - psutil == 3.1.1 07:58:25 INFO - requests == 1.2.3 07:58:25 INFO - wsgiref == 0.1.2 07:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:25 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:58:25 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:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:25 INFO - 'HOME': '/Users/cltbld', 07:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:25 INFO - 'LOGNAME': 'cltbld', 07:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:25 INFO - 'MOZ_NO_REMOTE': '1', 07:58:25 INFO - 'NO_EM_RESTART': '1', 07:58:25 INFO - 'PAGER': '/bin/cat', 07:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:25 INFO - 'PWD': '/builds/slave/test', 07:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:25 INFO - 'SHELL': '/bin/bash', 07:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:25 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:25 INFO - 'USER': 'cltbld', 07:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:25 INFO - 'XPC_FLAGS': '0x0', 07:58:25 INFO - 'XPC_SERVICE_NAME': '0', 07:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:25 INFO - Cleaning up... 07:58:25 INFO - Return code: 0 07:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 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 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:25 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:58:25 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:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:25 INFO - 'HOME': '/Users/cltbld', 07:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:25 INFO - 'LOGNAME': 'cltbld', 07:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:25 INFO - 'MOZ_NO_REMOTE': '1', 07:58:25 INFO - 'NO_EM_RESTART': '1', 07:58:25 INFO - 'PAGER': '/bin/cat', 07:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:25 INFO - 'PWD': '/builds/slave/test', 07:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:25 INFO - 'SHELL': '/bin/bash', 07:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:25 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:25 INFO - 'USER': 'cltbld', 07:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:25 INFO - 'XPC_FLAGS': '0x0', 07:58:25 INFO - 'XPC_SERVICE_NAME': '0', 07:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:26 INFO - Downloading/unpacking jsonschema 07:58: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:58: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:58: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:58: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:58: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:58: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:58:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:28 INFO - Downloading/unpacking functools32 (from jsonschema) 07:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:28 INFO - warning: no files found matching '*.txt' 07:58:28 INFO - no previously-included directories found matching 'build' 07:58:28 INFO - no previously-included directories found matching 'dist' 07:58:28 INFO - no previously-included directories found matching '.git*' 07:58:28 INFO - Installing collected packages: jsonschema, functools32 07:58:28 INFO - Running setup.py install for functools32 07:58:29 INFO - warning: no files found matching '*.txt' 07:58:29 INFO - no previously-included directories found matching 'build' 07:58:29 INFO - no previously-included directories found matching 'dist' 07:58:29 INFO - no previously-included directories found matching '.git*' 07:58:29 INFO - Successfully installed jsonschema functools32 07:58:29 INFO - Cleaning up... 07:58:29 INFO - Return code: 0 07:58:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cbaea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7b8496fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, '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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:29 INFO - 'HOME': '/Users/cltbld', 07:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:29 INFO - 'LOGNAME': 'cltbld', 07:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:29 INFO - 'MOZ_NO_REMOTE': '1', 07:58:29 INFO - 'NO_EM_RESTART': '1', 07:58:29 INFO - 'PAGER': '/bin/cat', 07:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:29 INFO - 'PWD': '/builds/slave/test', 07:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:29 INFO - 'SHELL': '/bin/bash', 07:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:58:29 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:29 INFO - 'USER': 'cltbld', 07:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:29 INFO - 'XPC_FLAGS': '0x0', 07:58:29 INFO - 'XPC_SERVICE_NAME': '0', 07:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:29 INFO - Downloading/unpacking flake8 07:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:58:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:58:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:32 INFO - no previously-included directories found matching 'docs/_build' 07:58:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:58:33 INFO - Running setup.py install for pep8 07:58:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:33 INFO - no previously-included directories found matching 'docs/_build' 07:58:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:58:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:58:33 INFO - Cleaning up... 07:58:33 INFO - Return code: 0 07:58:33 INFO - Running post-action listener: _resource_record_post_action 07:58:33 INFO - Running post-action listener: _start_resource_monitoring 07:58:33 INFO - Starting resource monitoring. 07:58:33 INFO - ##### 07:58:33 INFO - ##### Running install step. 07:58:33 INFO - ##### 07:58:33 INFO - Running pre-action listener: _resource_record_pre_action 07:58:33 INFO - Running main action method: install 07:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:33 INFO - Reading from file tmpfile_stdout 07:58:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:58:33 INFO - Reading from file tmpfile_stdout 07:58:33 INFO - Output received: 07:58:33 INFO - Usage: mozinstall [options] installer 07:58:33 INFO - Options: 07:58:33 INFO - -h, --help show this help message and exit 07:58:33 INFO - -d DEST, --destination=DEST 07:58:33 INFO - Directory to install application into. [default: 07:58:33 INFO - "/builds/slave/test"] 07:58:33 INFO - --app=APP Application being installed. [default: firefox] 07:58:33 INFO - mkdir: /builds/slave/test/build/application 07:58:33 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:58:33 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:59:07 INFO - Reading from file tmpfile_stdout 07:59:07 INFO - Output received: 07:59:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:59:07 INFO - Running post-action listener: _resource_record_post_action 07:59:07 INFO - ##### 07:59:07 INFO - ##### Running run-tests step. 07:59:07 INFO - ##### 07:59:07 INFO - Running pre-action listener: _resource_record_pre_action 07:59:07 INFO - Running main action method: run_tests 07:59:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:59:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:59:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:59:07 INFO - 2016-02-17 07:59:07.535 screenresolution[1962:18435] starting screenresolution argv=screenresolution get 07:59:07 INFO - 2016-02-17 07:59:07.537 screenresolution[1962:18435] Display 0: 1600x1200x32@60 07:59:07 INFO - 2016-02-17 07:59:07.543 screenresolution[1963:18437] starting screenresolution argv=screenresolution list 07:59:07 INFO - Available Modes on Display 0 07:59:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:59:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:59:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:59:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:59:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:59:07 INFO - Intel Iris: 07:59:07 INFO - Chipset Model: Intel Iris 07:59:07 INFO - Type: GPU 07:59:07 INFO - Bus: Built-In 07:59:07 INFO - VRAM (Dynamic, Max): 1536 MB 07:59:07 INFO - Vendor: Intel (0x8086) 07:59:07 INFO - Device ID: 0x0a2e 07:59:07 INFO - Revision ID: 0x0009 07:59:07 INFO - Displays: 07:59:07 INFO - Display: 07:59:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:59:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:59:07 INFO - Display Serial Number: 1600x1200 60 07:59:07 INFO - Main Display: Yes 07:59:07 INFO - Mirror: Off 07:59:07 INFO - Online: Yes 07:59:07 INFO - Rotation: Supported 07:59:07 INFO - Return code: 0 07:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:07 INFO - Python 2.7.3 07:59:07 INFO - Return code: 0 07:59:07 INFO - grabbing minidump binary from tooltool 07:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:07 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 0x10ca52d30>, '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 0x10c876db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:07 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:59:07 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:59:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:07 INFO - Return code: 0 07:59:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:59:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:59:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:59:09 INFO - Return code: 0 07:59:09 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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:59:09 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v1PSmbmFmi/Render', 07:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:09 INFO - 'HOME': '/Users/cltbld', 07:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:09 INFO - 'LOGNAME': 'cltbld', 07:59:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:09 INFO - 'MOZ_NO_REMOTE': '1', 07:59:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:09 INFO - 'NO_EM_RESTART': '1', 07:59:09 INFO - 'PAGER': '/bin/cat', 07:59:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:09 INFO - 'PWD': '/builds/slave/test', 07:59:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:09 INFO - 'SHELL': '/bin/bash', 07:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BvUXxdnOOQ/Listeners', 07:59:09 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 07:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:09 INFO - 'USER': 'cltbld', 07:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:09 INFO - 'XPC_FLAGS': '0x0', 07:59:09 INFO - 'XPC_SERVICE_NAME': '0', 07:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:09 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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:59:09 INFO - mozversion application_buildid: 20160217060406 07:59:09 INFO - mozversion application_changeset: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 07:59:09 INFO - mozversion application_display_name: Nightly 07:59:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:09 INFO - mozversion application_name: Firefox 07:59:09 INFO - mozversion application_remotingname: firefox 07:59:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:59:09 INFO - mozversion application_vendor: Mozilla 07:59:09 INFO - mozversion application_version: 47.0a1 07:59:09 INFO - mozversion platform_buildid: 20160217060406 07:59:09 INFO - mozversion platform_changeset: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 07:59:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:59:09 INFO - mozversion platform_version: 47.0a1 07:59:09 INFO - using testdate: 1455724749 07:59:09 INFO - actual date: 1455724749 07:59:09 INFO - starting webserver on 'localhost:57168' 07:59:09 INFO - SUITE-START | Running 2 tests 07:59:09 INFO - TEST-START | dromaeo_css 07:59:09 INFO - operating with platform_type : mac_ 07:59:09 INFO - Initialising browser for dromaeo_css test... 07:59:09 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpsLdrS6/profile http://localhost:57168/getInfo.html) 07:59:12 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 07:59:12 INFO - PROCESS | 1981 | colorDepth:24 07:59:12 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 07:59:12 INFO - PROCESS | 1981 | __metrics 07:59:12 ERROR - PROCESS | 1981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 07:59:13 INFO - TEST-INFO | 1981: exit 0 07:59:13 INFO - Browser initialized. 07:59:13 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:13 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpsLdrS6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:25 INFO - PROCESS | 1985 | RSS: Main: 255672320 07:59:25 INFO - PROCESS | 1985 | 08:00:14 INFO - PROCESS | 1985 | 1455724814759 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:02:25 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57168/tests/dromaeo/cssquery-ext.html) 08:02:26 INFO - PROCESS | 1985 | RSS: Main: 269135872 08:02:26 INFO - PROCESS | 1985 | 08:05:28 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-ext.html (next: http://localhost:57168/tests/dromaeo/cssquery-jquery.html) 08:05:29 INFO - PROCESS | 1985 | RSS: Main: 281272320 08:05:29 INFO - PROCESS | 1985 | 08:08:30 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57168/tests/dromaeo/cssquery-mootools.html) 08:08:31 INFO - PROCESS | 1985 | RSS: Main: 281759744 08:08:31 INFO - PROCESS | 1985 | 08:11:33 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57168/tests/dromaeo/cssquery-prototype.html) 08:11:33 INFO - PROCESS | 1985 | RSS: Main: 284803072 08:11:33 INFO - PROCESS | 1985 | 08:14:36 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57168/tests/dromaeo/cssquery-yui.html) 08:14:36 INFO - PROCESS | 1985 | RSS: Main: 286072832 08:14:36 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-yui.html (next: http://localhost:57168/tests/dromaeo/cssquery-dojo.html) 08:17:39 INFO - PROCESS | 1985 | RSS: Main: 289566720 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | __start_tp_report 08:17:39 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 08:17:39 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 08:17:39 INFO - PROCESS | 1985 | |i|pagename|runs| 08:17:39 INFO - PROCESS | 1985 | |0;dojo.html;3467.1158854492105;3540.345036168309;3559.5016697662318;3605.5853576838663;3609.657082577154;4719.882002949919;5716.942830571693;5719.513841323487;5777.59556831022;5794.884102317957;5219.6950762309425;5458.181272809081;5758.395368486312;5838.153467747175;5902.586818922677;4780.733105726985;5091.745412729368;5215.243789650498;5281.15501519755;5284.867878303035;4374.825006999717;5286.497782710637;5327.547158491533;5349.973250133744;5364.061289274381;5120.769565369567;5166;5257.237700533439;5276.287701160332;5301.390340110898;5233.031889100528;5271.604629652753;5283.841484755463;5285.735713214324;5365.3293338332705;5105.795768169269;5222.138347172712;5244.81643142492;5253.7635806388425;5272.657277276965;4712.64655150865;5586.91619625706;5633.718314084321;5709.314882214119;5722.37053924068;6233.532485063593;6267.561270711052;6271.278802937675;6274.937250627527;6302.55882088254;6180.165677633507;6202.503799696058;6251.562390632612;6271.184745982993;6291.465225455841;5939.287285525721;5967.37342579023;5968.224130863046;5994.700264986734;6016.639001659871;6218.067289906459;6383.96808015957;6417.2299324081405;6420.807375778734;6425.839354016093;6174.783882564178;6225.00399936008;6233.563650544418;6242.157308763259;6263.154474146023;6293.1504246927;6305.558610897285;6307.400796924285;6313.273973493107;6317.305096439388;6099.939000610026;6171.043488259327;6236.064590311399;6256.7810126645345;6278.748850045947;6154.5384096192965;6218.5647004709235;6242.500599951993;6255.437010669061;6262.5616206866;4953.529414705597;4993.425756038029;4997.100521906019;5004.724740139327;5017.322661440732;4401.185780630593;4422.668299877522;4423.137488189836;4461.196984542748;4516.751578663139;4853.80584776605;5907.202527658797;5921.6743079131065;5948.375420580864;5964.493018093423;4976.875578110504;6206.844828879314;6234.314225435199;6255.218097737783;6263.843403914939;5969.492593129546;5996.4603185713495;6009.248843894513;6026.638401695912;6036.758529658764;5471.179323101566;5478.753456094485;5484.2596249506605;5507.394186639466;5515.944840551623;6322.810315690536;6380.234371875312;6491.740330386731;6513.869722605521;6520.836979075466;5216.295800067094;6222.533310001678;6276.623402595676;6287.811365659038;6297.433231009231;6303.086052522267;6429.164208652845;6477.611343319416;6501.674916254263;6513.250976137615;5371.194320851903;6147.354527774519;6208;6234.0025595904435;6261.9373806263175;6151.384861513813;6241.032639940817;6266.154069200782;6279.183706118175;6281;5331.466853314792;6086.391360863879;6146.016637338004;6226.844328891814;6248.4688801452385;6196.721147548281;6227.034809604518;6229.937700622936;6248.0940263660605;6254.655993920378;5996.610220335664;6088.482478989158;6097.237845269341;6137.60105593135;6145.354737752472;6090.208272924491;6117.492485019787;6210.161628180138;6233.345498722751;6243.594166379171;6042.75828966854;6100.969495152496;6130.233720784902;6135.53983451234;6146.5390095742105 08:17:39 INFO - PROCESS | 1985 | |1;ext.html;456.1128604863542;494.87628092976746;517.0047658257853;556.6687820746656;564.9745711533566;30711.385772284597;37510.43734343987;39288.21423571527;39950.99999999996;40131.99670008251;41528.16943661125;42013;42093.78953105238;42104.789476052574;42109.157816843646;9518.095780900803;9578.090081442251;9683.854742178837;9704.514774261293;9728.124468797807;9644;9666.371685840399;9711.854322185172;9793.020697930222;9800.754981125458;9638.518074096302;9707.95146024269;9771;9798.608055677765;9828.262880283972;9651.276154288422;9666.130048295687;9704.61181552737;9743.610255589803;9746.31775775696;9534.141927226583;9582.712518624452;9655.806883862284;9660.468674222915;9691.07934746198;32076.518852217236;39174;39323.60676393257;39520.60479395227;39611.80194099011;2974.3992324131004;3740.345439548068;3855.9614403855885;3950.6246906543834;4087.6116768906904;20754.896225518925;26967.73032269672;27766.722332776615;27853.721462785314;27874.16377508678;2871.3970066286106;2879.640044994376;2879.7696184305414;2893.8119022263486;2894.20409387418;322064;384541;385749.9999999972;386290;387802;55852.720736396055;63138.0529292061;64621.67689161524;66141.00788488176;66356.33643663501;55346;61822.69088654528;64138.67930660317;64217.678911605144;64688;13484.865151348557;15707.4502392418;16057.919710401608;16073.35706571724;16110.838891610934;11846.3415121883;12309.138360314691;12373.010159187243;12452.750944981231;12747.980161587051;17697.823021769877;20869.37391878246;20977.580448390945;21381.144754209658;21458.356249312546;7185.712571497186;8529.185368828272;8648.481091134427;8686.843484118815;8696.304295656333;925.879635647375;960.279790157382;968.5496244246459;974.2928158357518;1083.4745148602922;29787.40425191484;30035.037211418112;30072.24819379533;30376;30515.08454746361;1072.1690689715376;1083.501589268945;1104.6575561575937;1147.8335641332128;1236.4621389695512;15107;15150.545483635287;15393.153376564173;15468.458603948808;15515.146666933428;540062;543428;549317;549418;550610;58868;59018.40981590215;59079.81840363169;59184.857060005386;59303.11045334324;1370.390176371525;1406.2546850169426;1408.499982506216;1420.857914208571;1427.978580321296;29544.409111817215;29920.370869925348;29948.802047917838;30070.541480377546;30106.24734381658;51485.48514514807;52027;52260.21609675782;52553.68615784636;52595;520530;521242;524506;525572;527734;32663.67336326606;33638.83180584081;33653.663463365054;33768.81809136669;33862;42515.14969700527;42525;42802.57197427986;42834.78582607067;43383.69848904538;35279.29441411209;35522.64477355193;35596.64403356037;35999.92000239997;36105;35248.647513524535;35329.64670353366;35543.93368198958;35815.64184358227;35937.46093808647;36095.27809443744;36743.63256367402;36944.81527592345;37097.629023709414;37135.44296835495;31131.68868311288;31975.520367194975;32857;33191.66808331886;33593.32813343768;24121.276361708475;24328.78356082224;24508;24734.628980564947;25237.369065772767 08:17:39 INFO - PROCESS | 1985 | |2;jquery.html;310.9564660947467;363.94358874374467;364.1914948813634;367.39930214099957;370.753448956444;14988.250587470637;15840.920795396007;16089;18869.339573114925;20645.070971806268;18345.54136146597;18428.907855460704;18432;18639.25442982279;18817.52956176093;5651.378348381675;5829.825105246829;5975.372585878486;5978.790742324019;5991.940080599204;5601.159826026088;5965.926133296005;5998.340182579913;6015.75936962521;6019.548533859978;4154.210699967011;5693.971530142344;5951.88096238075;5956.076808094752;6195.6902154892305;6216.067589861557;6337.746490140389;6344.904826427607;6397.520185986046;6402.583832050948;5556.027695153372;5611.7474713637985;5613.775448982035;5618.073017952033;5632.9436705632825;23699.341046126778;24147.275581732578;24392.878035609887;24455.877720611283;24496.63255051158;2116.354511873878;2467.4448249143798;2514.3839759258917;2892.464893994618;2893.8842446302124;14421.567352979428;14550.417983280657;14633.268336583129;15002.24988750569;15273.694526109526;1752.649470105984;1758.1560850791564;1777.644471105784;1781.910904454772;1782.8951627763352;95502.52248738782;97756.53365199457;99165;100478;101876.49061754718;8704.738857834274;10131.645392411378;10529.631462898762;10651.360918344924;10695.679129626124;12504.687382815502;12564.183328083645;12580.622581322576;12671.239725616493;12694.873051269555;6944.965275173693;8464.238218560236;8470.872936905951;8480.15198480147;8559.443636163629;6990.650467476606;8740.169683880022;8768.167024132697;8859.025507194203;8863.556822158866;6073.939260607426;6200;6213.96893015532;6214.782482613177;6252.9370007098905;1794.2553840156188;1835.908204589765;1839.2918726290475;1866.3840932492244;1867.4771064102074;797.4656979823532;899.3839220134229;958.5015791788231;1000.1848493477793;1015.355249416611;17686.29254829818;20638.555301128778;20674.483137921674;20850.687239691415;21110.577788444145;732.8314487667759;796.7729197178776;963.1572374172599;1012.86832711747;1048.130052056791;9767.902320976842;10480.580776768997;10492.108170805566;10505.579776808841;10686.625968091079;755303;779752.1012394902;783473;805946;809181.6786412448;120744.18883716752;121704.78295217111;124613;125077;125962;1087.798757229915;1183.4970137691446;1197.712548988254;1199.9820002699967;1212.87871212878;16868;17552;17689.734653979944;17813.554661133057;17833.821661783215;40241.390344385894;46701.76649116733;50240.748796255786;51410;51583.48416515787;61788.38211617826;79213;79744;80297;80651.59674201826;7704.229577042251;7829.373650107864;7838.137804841577;7912.643931023233;7924.286814186751;11162.609308674157;12321.630351089481;12565.371731413576;12652.746945060862;12770;8437.704680336159;10593.2584719072;10654.307470014424;10776.946115269373;10962.342259464458;10563.366198028143;10839.132869370274;10882.61910833117;10910.448875942748;10985.83521247166;11084.224104312621;11122.388268645302;11191.944040279746;11317.320960742381;11404.030657393883;7439.256074392518;7769.184235655175;7816.84366312682;7822.530648161129;7932.682692692228;8556.529390883561;10916.945415272872;10968.725781855517;10990.340579565252;11083.445827708421 08:17:39 INFO - PROCESS | 1985 | |3;mootools.html;1315.5726037249583;1465.245398619711;1679.4373884748609;1848.0482551485986;1884.152131540807;7775.339096176817;8386.91613083869;8512.489250644958;8673.826523469526;8698.130186981307;8397.622107005183;8485.193906578881;8579.656813727459;8580.270676992448;8588.184122508368;2422.81828862836;2428.0409238350885;2456.361346050031;2459.8770061496944;2466.48203877186;2419.6305158806854;2476.5913624251975;2477.0587176872764;2483.639872218527;2491.6511688363644;2153.827693784501;2404.2546810488716;2452.9877350613224;2486.7264600893977;2499.800015998725;2403.07481619576;2408.590539608271;2413.046846495642;2439.512097580491;2440.0361857066537;2382.559226543095;2440.3411079008747;2441.108995216751;2445.8899349529315;2453.2640207937548;8646.351523635689;8663;8666.480011199348;8667.4366166199;8696.826063478758;5262.500062494057;5319.707416092114;5333.2000199969925;5418.9458105418835;5457.754401051922;3591.425371940477;3631.382664946939;3664;3684.5578530576236;3722.1625134344554;1036.7459972306758;1051.0488008352454;1062.7290041039485;1062.9946850265776;1077.2028698762938;11543.480543375568;11616.709582260426;11618.825717614243;11627.53489860413;11633.36016519091;4748.430188377348;4822;4830.830920917751;4852.2479015752615;4892.241702536113;9764.218862490983;9815.950920245496;9844.950775246221;9859.950700246452;9876.555555000043;5289.338832645919;5364.544013758796;5365.302510673588;5371.979323928441;5400.540954018874;4750.501197374295;4880.926786098212;4890.144224760653;4919.114559379346;4939.876503087452;3085.8457077146504;3466.445368740989;3926.9986153530667;3944.8619298324993;3961.7226794124713;1301.531448678475;1312.3372696788251;1323.7617228898891;1331.800229965513;1332.6401871494836;953.880764904387;1073.8281874899978;1100.0319718647538;1208.6615747590688;1291.3994992328612;5908.3205431375945;7813.218678132255;7813.570253636105;7973;7989.440739148204;995.437577768573;1139.700741155084;1171.625079974417;1190.9940450297693;1196.7068068323317;5244.344456942882;6332.430081292706;6336.873262534724;6357.300696923335;6358.395952384516;8844.823103537894;10091.545880435398;10359.96400359973;10523.631672891412;10593.788124237471;10435.895641043493;10439.895601044043;10441.895581044093;10536.789264214673;10537.473126343652;7771.8834217485655;7904.4071694623135;8045.557494337868;8074.919250807417;8076.596170191585;7782.416318776001;7807.492512986638;7826.452148349561;7872.37021038327;7941.00737407824;9108.681196158102;9232.353735238468;9266.721998340061;9338.533073346442;9399.201067909304;9422;9568.521573921136;9645.324827262024;9749.415035097916;9908.009199080323;6227.221597300338;7251.782446526613;7292.41660667156;7377.8155546111775;7393.741219057307;7909.7231596893835;7995.880061799194;8028.518288902685;8054.718084867001;8070.314023307849;6073.726682299395;6765.492588056014;7151.964240178766;7442.851142977219;7675.808104797201;6128.50971922254;6663.300353462817;7372.557646541225;7493.700251990077;7528.698852046076;7046.612436315847;7613.923860761543;7614.428917831074;7622.428317876293;7634.541927484369;6782.796516104525;6790.25307216196;6830.351116643911;6850.828729281808;6905.930940690529;6873.725050998104;6987.475939304674;6998.370146686619;7006.124234470692;7022.754203603054 08:17:39 INFO - PROCESS | 1985 | |4;prototype.html;258.6495298870031;317.370020509289;326.6733266733267;329.9868005279789;331.11261818326875;6469.514786391016;6511.544191906569;6528.608283502993;6641.734330626769;6646.767363142291;5313.760880760366;6638.1370421845095;6643.800685979416;6677.131972843524;6699.866002679943;3903.4925459690344;4132.173565286939;4961.702297862122;4973.5772459340815;5001.44984051754;4540.250858608326;4783.851875549878;4949.133901567229;5000.374953130859;5009.198528235483;4793.568578827905;4934.25986102084;4941.827036053739;4973.726445045521;4981.5516603505675;4241.915161696779;4923.138450771118;4926.975365123188;4944.035912996967;4958.652894297401;4050.25070361984;4141.482314710661;4235.237657221699;4260.70175087744;4262.339337402707;5290.55030322423;6214.285357183937;6350.80947571569;6386.680665966683;6407.647579383132;5860.384659610722;5868.325142608612;5877.235959325303;5884.029135192688;5893.705314734246;7153.92846071543;7166.462515311373;7170.964145179293;7184.640767961581;7215.927840721631;4736.005438857844;4739.928901066487;4755.881102972453;4757;4792.065547218293;7410.777676669709;7654.0815102187535;7666.8849967250535;7679.424043196838;7698.384129269645;4607.193741095295;4666.973265881501;4669.556392142741;4669.579737823612;4674.392328997209;4725.456572494207;4744.928826067612;4750.311204875274;4759.904801904012;4765.11845308619;5527.281453411031;5672.971635141798;5690.4025077367105;5697.316322041299;5704.286964129484;7226.494145409771;7229.4095299034125;7242.529235599669;7247.275272472711;7280.96359518199;1549.8915075944801;1602.5833283346415;1615.111688571281;1644.5477493689332;1644.958876028085;1031.6440827914357;1039.210200247817;1042.2495803021811;1043.1446214104512;1049.3022140276782;6623.304553021863;6629.834254143685;6698.4306333961185;6711.463082953352;6717.294684058202;7387.556746595114;7390.630468476555;7392.815179620445;7412.85174296511;7440.144383395978;6474.223093228843;6694.230163531159;6701.396874281338;6724.428423583952;6745.190577130677;3928.3518219493462;3934.626210509997;3943.3296339622334;3950.4271880577157;3968.146848427602;7799.610019499002;7814.4529882907655;7824.374050076094;7837.686492540234;7852.528848269122;7387.409007279405;7626.847463050819;7654.249417785357;7740.109887362913;7818.491798033109;7856.7250146244605;7877.251661092187;7879.606019699107;7880.408969327438;7905.762827115196;7233.31283528064;7423;7433.888491672521;7434.107907051189;7446.8510629786015;7371.262873712586;7392.852142957218;7406.925930740624;7407.407407407287;7413.962930185315;7851.293383595504;7866.646000930086;7873.724419645285;7888.3689304856625;7894.565798881116;4576.336431217388;4647.790849411717;4651.976740116278;4683.555062269079;4684.367610372556;5663.405342438985;6959.956006599051;7296.1974182838785;7503.699852006077;7519;5257.132573125392;5451.37309209446;5766.509846663081;6653.367930046637;7266.927330726625;6317.936820631735;7188.4968052235845;7198.856022879618;7222.9277707224355;7234.421246300178;6605.339466053356;6855.4172895304455;7080.645967701491;7130.500864939404;7159.928400715926;5956.583039187215;7242.818929526804;7294.379977701955;7302.525335853153;7306.853862922605;7146.928530714834;7151.499395042297;7156.355927966508;7168.103987001625;7174.641267936478 08:17:39 INFO - PROCESS | 1985 | |5;yui.html;620.4385031546451;621.133518741356;654.2247436787404;686.7115811359229;711.6726305899286;14912.478063267788;15173;15262.160581168031;15262.618434539128;15301.770473442879;13260.475045369785;14234.359453824576;14402.279886005685;14414.639634009129;14415.918806089532;702.143385070216;743.2418932688654;844.7296865003201;884.1114679746878;885.5970533407284;860.4364141487335;866.4411454611771;875.6234819027848;875.9167879051512;878.6704985630389;914.9771255718593;917.6971599372191;919.8666193401987;921.3044151665483;924.6624981881632;901.9684311049115;909.1590278991939;917.3761841947473;918.9172974432266;919.4161707315869;652.2336254900521;676.0771546838579;677.7085853083172;678.3826717686882;680.4386381235452;12492.500299987989;14655.926720366437;15305.464308749251;15328;15361.846381536265;10075.445850478221;13153.342332883318;13455;13619.591412257549;13751.518696845562;10080.092791648713;11056.557737690482;11366.318020918772;11511.30932144074;11992.700182495508;3526.0655926179584;3526.2947410518;3568.3398571264397;3618.963810361889;3626.8549258029648;84717.45847624581;91109;91413;92231.53884230604;92282;8852.557372131496;9774.924758276584;9880.65417710391;10027.097561219525;10035.949820250851;21939.67090493644;22117.778822211894;22364.440888977904;22373.776262237494;22381;7366.558006519626;7587.279208475186;7619.9332093506955;7779.4943328684585;7939.6030198491;3682.429223470366;3920.745151565139;3974.0410175683205;4037.37420699792;4139;3617;3625.984724277154;3629;3672.320620685182;3683.465897444909;644.0693198328464;652.3085529338916;660.9239937407164;684.0594182998377;685.8353995041253;499.787590274132;519.4493836533287;597.5100417657566;600.717662698531;634.6002018728171;8676.913230867736;8698;8711.695090671923;8814.294856411472;8953.194212520773;507.7562769870483;529.7986765029265;587.9882402351928;623.4638211138417;627.1877918096077;3918.275119102975;4066.777829920227;4074.3277359235985;4129.628333450004;4184.205001049791;79042;80263.19736802674;80623.19376806275;95313.0468695318;96547.03452965521;79110.60444697854;83408.16591834003;83768;83871;85530.57234713787;74550.62724686341;74883.87674184892;75210.61552230162;75764.62117689376;76047;8505.872411913702;8930.821383572162;8973.28213742886;9142.542872856198;9344.719658410258;50031.49968500269;52332.9533409322;54673.45326546684;55987.44012559822;56333;76752;76959.23040769521;77608.61195694211;77659.22340776747;77671.83492247507;10493.898140695117;10735.89264107349;11263.549458021587;11389.601363952223;11633.825492617449;8933.687320943736;12123.878761212274;12132.454039568418;12171.39143042862;12644.810327845275;11600.767984640428;11724.355160466257;11807.704807379541;12180.390980450764;12388.62834114978;11776.70558236051;11997.460114294703;12118.636440906786;12136;12161.635150945485;10824.621138260123;11939.223950443193;11950.402479876146;11951.282923024299;12169.087318450975;8575.356848236283;9765.267604929517;9772;9777.560009799434;10228.846567301645;7878.921210787818;9281.211097056555;9995.250356223167;10072.244581656258;10241.385516868713 08:17:39 INFO - PROCESS | 1985 | __end_tp_report 08:17:39 INFO - PROCESS | 1985 | __start_cc_report 08:17:39 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,355 08:17:39 INFO - PROCESS | 1985 | __end_cc_report 08:17:39 INFO - PROCESS | 1985 | __startTimestamp1455725859491__endTimestamp 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | ------- Summary: start ------- 08:17:39 INFO - PROCESS | 1985 | Number of tests: 6 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#0] dojo.html Cycles:165 Average:5774.23 Median:6088.48 stddev:663.59 (10.9%) stddev-sans-first:640.46 08:17:39 INFO - PROCESS | 1985 | Values: 3467.1 3540.3 3559.5 3605.6 3609.7 4719.9 5716.9 5719.5 5777.6 5794.9 5219.7 5458.2 5758.4 5838.2 5902.6 4780.7 5091.7 5215.2 5281.2 5284.9 4374.8 5286.5 5327.5 5350.0 5364.1 5120.8 5166.0 5257.2 5276.3 5301.4 5233.0 5271.6 5283.8 5285.7 5365.3 5105.8 5222.1 5244.8 5253.8 5272.7 4712.6 5586.9 5633.7 5709.3 5722.4 6233.5 6267.6 6271.3 6274.9 6302.6 6180.2 6202.5 6251.6 6271.2 6291.5 5939.3 5967.4 5968.2 5994.7 6016.6 6218.1 6384.0 6417.2 6420.8 6425.8 6174.8 6225.0 6233.6 6242.2 6263.2 6293.2 6305.6 6307.4 6313.3 6317.3 6099.9 6171.0 6236.1 6256.8 6278.7 6154.5 6218.6 6242.5 6255.4 6262.6 4953.5 4993.4 4997.1 5004.7 5017.3 4401.2 4422.7 4423.1 4461.2 4516.8 4853.8 5907.2 5921.7 5948.4 5964.5 4976.9 6206.8 6234.3 6255.2 6263.8 5969.5 5996.5 6009.2 6026.6 6036.8 5471.2 5478.8 5484.3 5507.4 5515.9 6322.8 6380.2 6491.7 6513.9 6520.8 5216.3 6222.5 6276.6 6287.8 6297.4 6303.1 6429.2 6477.6 6501.7 6513.3 5371.2 6147.4 6208.0 6234.0 6261.9 6151.4 6241.0 6266.2 6279.2 6281.0 5331.5 6086.4 6146.0 6226.8 6248.5 6196.7 6227.0 6229.9 6248.1 6254.7 5996.6 6088.5 6097.2 6137.6 6145.4 6090.2 6117.5 6210.2 6233.3 6243.6 6042.8 6101.0 6130.2 6135.5 6146.5 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#1] ext.html Cycles:180 Average:62685.42 Median:387046.00 stddev:129798.02 (33.5%) stddev-sans-first:130078.04 08:17:39 INFO - PROCESS | 1985 | Values: 456.1 494.9 517.0 556.7 565.0 30711.4 37510.4 39288.2 39951.0 40132.0 41528.2 42013.0 42093.8 42104.8 42109.2 9518.1 9578.1 9683.9 9704.5 9728.1 9644.0 9666.4 9711.9 9793.0 9800.8 9638.5 9708.0 9771.0 9798.6 9828.3 9651.3 9666.1 9704.6 9743.6 9746.3 9534.1 9582.7 9655.8 9660.5 9691.1 32076.5 39174.0 39323.6 39520.6 39611.8 2974.4 3740.3 3856.0 3950.6 4087.6 20754.9 26967.7 27766.7 27853.7 27874.2 2871.4 2879.6 2879.8 2893.8 2894.2 322064.0 384541.0 385750.0 386290.0 387802.0 55852.7 63138.1 64621.7 66141.0 66356.3 55346.0 61822.7 64138.7 64217.7 64688.0 13484.9 15707.5 16057.9 16073.4 16110.8 11846.3 12309.1 12373.0 12452.8 12748.0 17697.8 20869.4 20977.6 21381.1 21458.4 7185.7 8529.2 8648.5 8686.8 8696.3 925.9 960.3 968.5 974.3 1083.5 29787.4 30035.0 30072.2 30376.0 30515.1 1072.2 1083.5 1104.7 1147.8 1236.5 15107.0 15150.5 15393.2 15468.5 15515.1 540062.0 543428.0 549317.0 549418.0 550610.0 58868.0 59018.4 59079.8 59184.9 59303.1 1370.4 1406.3 1408.5 1420.9 1428.0 29544.4 29920.4 29948.8 30070.5 30106.2 51485.5 52027.0 52260.2 52553.7 52595.0 520530.0 521242.0 524506.0 525572.0 527734.0 32663.7 33638.8 33653.7 33768.8 33862.0 42515.1 42525.0 42802.6 42834.8 43383.7 35279.3 35522.6 35596.6 35999.9 36105.0 35248.6 35329.6 35543.9 35815.6 35937.5 36095.3 36743.6 36944.8 37097.6 37135.4 31131.7 31975.5 32857.0 33191.7 33593.3 24121.3 24328.8 24508.0 24734.6 25237.4 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#2] jquery.html Cycles:180 Average:39218.28 Median:24424.38 stddev:129555.67 (530.4%) stddev-sans-first:129886.16 08:17:39 INFO - PROCESS | 1985 | Values: 311.0 363.9 364.2 367.4 370.8 14988.3 15840.9 16089.0 18869.3 20645.1 18345.5 18428.9 18432.0 18639.3 18817.5 5651.4 5829.8 5975.4 5978.8 5991.9 5601.2 5965.9 5998.3 6015.8 6019.5 4154.2 5694.0 5951.9 5956.1 6195.7 6216.1 6337.7 6344.9 6397.5 6402.6 5556.0 5611.7 5613.8 5618.1 5632.9 23699.3 24147.3 24392.9 24455.9 24496.6 2116.4 2467.4 2514.4 2892.5 2893.9 14421.6 14550.4 14633.3 15002.2 15273.7 1752.6 1758.2 1777.6 1781.9 1782.9 95502.5 97756.5 99165.0 100478.0 101876.5 8704.7 10131.6 10529.6 10651.4 10695.7 12504.7 12564.2 12580.6 12671.2 12694.9 6945.0 8464.2 8470.9 8480.2 8559.4 6990.7 8740.2 8768.2 8859.0 8863.6 6073.9 6200.0 6214.0 6214.8 6252.9 1794.3 1835.9 1839.3 1866.4 1867.5 797.5 899.4 958.5 1000.2 1015.4 17686.3 20638.6 20674.5 20850.7 21110.6 732.8 796.8 963.2 1012.9 1048.1 9767.9 10480.6 10492.1 10505.6 10686.6 755303.0 779752.1 783473.0 805946.0 809181.7 120744.2 121704.8 124613.0 125077.0 125962.0 1087.8 1183.5 1197.7 1200.0 1212.9 16868.0 17552.0 17689.7 17813.6 17833.8 40241.4 46701.8 50240.7 51410.0 51583.5 61788.4 79213.0 79744.0 80297.0 80651.6 7704.2 7829.4 7838.1 7912.6 7924.3 11162.6 12321.6 12565.4 12652.7 12770.0 8437.7 10593.3 10654.3 10776.9 10962.3 10563.4 10839.1 10882.6 10910.4 10985.8 11084.2 11122.4 11191.9 11317.3 11404.0 7439.3 7769.2 7816.8 7822.5 7932.7 8556.5 10916.9 10968.7 10990.3 11083.4 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#3] mootools.html Cycles:180 Average:5907.87 Median:5409.74 stddev:3081.77 (57.0%) stddev-sans-first:3071.07 08:17:39 INFO - PROCESS | 1985 | Values: 1315.6 1465.2 1679.4 1848.0 1884.2 7775.3 8386.9 8512.5 8673.8 8698.1 8397.6 8485.2 8579.7 8580.3 8588.2 2422.8 2428.0 2456.4 2459.9 2466.5 2419.6 2476.6 2477.1 2483.6 2491.7 2153.8 2404.3 2453.0 2486.7 2499.8 2403.1 2408.6 2413.0 2439.5 2440.0 2382.6 2440.3 2441.1 2445.9 2453.3 8646.4 8663.0 8666.5 8667.4 8696.8 5262.5 5319.7 5333.2 5418.9 5457.8 3591.4 3631.4 3664.0 3684.6 3722.2 1036.7 1051.0 1062.7 1063.0 1077.2 11543.5 11616.7 11618.8 11627.5 11633.4 4748.4 4822.0 4830.8 4852.2 4892.2 9764.2 9816.0 9845.0 9860.0 9876.6 5289.3 5364.5 5365.3 5372.0 5400.5 4750.5 4880.9 4890.1 4919.1 4939.9 3085.8 3466.4 3927.0 3944.9 3961.7 1301.5 1312.3 1323.8 1331.8 1332.6 953.9 1073.8 1100.0 1208.7 1291.4 5908.3 7813.2 7813.6 7973.0 7989.4 995.4 1139.7 1171.6 1191.0 1196.7 5244.3 6332.4 6336.9 6357.3 6358.4 8844.8 10091.5 10360.0 10523.6 10593.8 10435.9 10439.9 10441.9 10536.8 10537.5 7771.9 7904.4 8045.6 8074.9 8076.6 7782.4 7807.5 7826.5 7872.4 7941.0 9108.7 9232.4 9266.7 9338.5 9399.2 9422.0 9568.5 9645.3 9749.4 9908.0 6227.2 7251.8 7292.4 7377.8 7393.7 7909.7 7995.9 8028.5 8054.7 8070.3 6073.7 6765.5 7152.0 7442.9 7675.8 6128.5 6663.3 7372.6 7493.7 7528.7 7046.6 7613.9 7614.4 7622.4 7634.5 6782.8 6790.3 6830.4 6850.8 6905.9 6873.7 6987.5 6998.4 7006.1 7022.8 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#4] prototype.html Cycles:180 Average:5826.83 Median:6566.97 stddev:1898.72 (28.9%) stddev-sans-first:1857.48 08:17:39 INFO - PROCESS | 1985 | Values: 258.6 317.4 326.7 330.0 331.1 6469.5 6511.5 6528.6 6641.7 6646.8 5313.8 6638.1 6643.8 6677.1 6699.9 3903.5 4132.2 4961.7 4973.6 5001.4 4540.3 4783.9 4949.1 5000.4 5009.2 4793.6 4934.3 4941.8 4973.7 4981.6 4241.9 4923.1 4927.0 4944.0 4958.7 4050.3 4141.5 4235.2 4260.7 4262.3 5290.6 6214.3 6350.8 6386.7 6407.6 5860.4 5868.3 5877.2 5884.0 5893.7 7153.9 7166.5 7171.0 7184.6 7215.9 4736.0 4739.9 4755.9 4757.0 4792.1 7410.8 7654.1 7666.9 7679.4 7698.4 4607.2 4667.0 4669.6 4669.6 4674.4 4725.5 4744.9 4750.3 4759.9 4765.1 5527.3 5673.0 5690.4 5697.3 5704.3 7226.5 7229.4 7242.5 7247.3 7281.0 1549.9 1602.6 1615.1 1644.5 1645.0 1031.6 1039.2 1042.2 1043.1 1049.3 6623.3 6629.8 6698.4 6711.5 6717.3 7387.6 7390.6 7392.8 7412.9 7440.1 6474.2 6694.2 6701.4 6724.4 6745.2 3928.4 3934.6 3943.3 3950.4 3968.1 7799.6 7814.5 7824.4 7837.7 7852.5 7387.4 7626.8 7654.2 7740.1 7818.5 7856.7 7877.3 7879.6 7880.4 7905.8 7233.3 7423.0 7433.9 7434.1 7446.9 7371.3 7392.9 7406.9 7407.4 7414.0 7851.3 7866.6 7873.7 7888.4 7894.6 4576.3 4647.8 4652.0 4683.6 4684.4 5663.4 6960.0 7296.2 7503.7 7519.0 5257.1 5451.4 5766.5 6653.4 7266.9 6317.9 7188.5 7198.9 7222.9 7234.4 6605.3 6855.4 7080.6 7130.5 7159.9 5956.6 7242.8 7294.4 7302.5 7306.9 7146.9 7151.5 7156.4 7168.1 7174.6 08:17:39 INFO - PROCESS | 1985 | 08:17:39 INFO - PROCESS | 1985 | [#5] yui.html Cycles:180 Average:19198.27 Median:610.58 stddev:27243.99 (4462.0%) stddev-sans-first:27284.71 08:17:39 INFO - PROCESS | 1985 | Values: 620.4 621.1 654.2 686.7 711.7 14912.5 15173.0 15262.2 15262.6 15301.8 13260.5 14234.4 14402.3 14414.6 14415.9 702.1 743.2 844.7 884.1 885.6 860.4 866.4 875.6 875.9 878.7 915.0 917.7 919.9 921.3 924.7 902.0 909.2 917.4 918.9 919.4 652.2 676.1 677.7 678.4 680.4 12492.5 14655.9 15305.5 15328.0 15361.8 10075.4 13153.3 13455.0 13619.6 13751.5 10080.1 11056.6 11366.3 11511.3 11992.7 3526.1 3526.3 3568.3 3619.0 3626.9 84717.5 91109.0 91413.0 92231.5 92282.0 8852.6 9774.9 9880.7 10027.1 10035.9 21939.7 22117.8 22364.4 22373.8 22381.0 7366.6 7587.3 7619.9 7779.5 7939.6 3682.4 3920.7 3974.0 4037.4 4139.0 3617.0 3626.0 3629.0 3672.3 3683.5 644.1 652.3 660.9 684.1 685.8 499.8 519.4 597.5 600.7 634.6 8676.9 8698.0 8711.7 8814.3 8953.2 507.8 529.8 588.0 623.5 627.2 3918.3 4066.8 4074.3 4129.6 4184.2 79042.0 80263.2 80623.2 95313.0 96547.0 79110.6 83408.2 83768.0 83871.0 85530.6 74550.6 74883.9 75210.6 75764.6 76047.0 8505.9 8930.8 8973.3 9142.5 9344.7 50031.5 52333.0 54673.5 55987.4 56333.0 76752.0 76959.2 77608.6 77659.2 77671.8 10493.9 10735.9 11263.5 11389.6 11633.8 8933.7 12123.9 12132.5 12171.4 12644.8 11600.8 11724.4 11807.7 12180.4 12388.6 11776.7 11997.5 12118.6 12136.0 12161.6 10824.6 11939.2 11950.4 11951.3 12169.1 8575.4 9765.3 9772.0 9777.6 10228.8 7878.9 9281.2 9995.3 10072.2 10241.4 08:17:39 INFO - PROCESS | 1985 | -------- Summary: end -------- 08:17:39 INFO - PROCESS | 1985 | 08:17:40 INFO - TEST-INFO | 1985: exit 0 08:17:40 INFO - TEST-OK | dromaeo_css | took 1110697ms 08:17:40 INFO - TEST-START | kraken 08:17:40 INFO - operating with platform_type : mac_ 08:17:40 INFO - Initialising browser for kraken test... 08:17:40 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpOVovZx/profile http://localhost:57168/getInfo.html) 08:17:42 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 08:17:42 INFO - PROCESS | 1991 | colorDepth:24 08:17:42 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 08:17:42 INFO - PROCESS | 1991 | __metrics 08:17:43 ERROR - PROCESS | 1991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 08:17:43 INFO - TEST-INFO | 1991: exit 0 08:17:43 INFO - Browser initialized. 08:17:43 INFO - Running cycle 1/1 for kraken test... 08:17:43 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpOVovZx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:55 INFO - PROCESS | 1994 | RSS: Main: 257318912 08:17:55 INFO - PROCESS | 1994 | 08:17:58 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:59 INFO - PROCESS | 1994 | RSS: Main: 269811712 08:17:59 INFO - PROCESS | 1994 | 08:18:01 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-dft) 08:18:02 INFO - PROCESS | 1994 | RSS: Main: 277229568 08:18:02 INFO - PROCESS | 1994 | 08:18:05 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-fft) 08:18:06 INFO - PROCESS | 1994 | RSS: Main: 281780224 08:18:06 INFO - PROCESS | 1994 | 08:18:08 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-oscillator) 08:18:09 INFO - PROCESS | 1994 | RSS: Main: 282574848 08:18:09 INFO - PROCESS | 1994 | 08:18:11 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:11 INFO - PROCESS | 1994 | RSS: Main: 281305088 08:18:11 INFO - PROCESS | 1994 | 08:18:14 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:15 INFO - PROCESS | 1994 | RSS: Main: 282849280 08:18:15 INFO - PROCESS | 1994 | 08:18:18 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:18 INFO - PROCESS | 1994 | RSS: Main: 284418048 08:18:18 INFO - PROCESS | 1994 | 08:18:21 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57168/tests/kraken/driver.html?testName=json-parse-financial) 08:18:22 INFO - PROCESS | 1994 | RSS: Main: 284033024 08:18:22 INFO - PROCESS | 1994 | 08:18:23 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:24 INFO - PROCESS | 1994 | RSS: Main: 284430336 08:18:24 INFO - PROCESS | 1994 | 08:18:26 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:26 INFO - PROCESS | 1994 | RSS: Main: 282873856 08:18:26 INFO - PROCESS | 1994 | 08:18:29 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:29 INFO - PROCESS | 1994 | RSS: Main: 283156480 08:18:29 INFO - PROCESS | 1994 | 08:18:32 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:32 INFO - PROCESS | 1994 | RSS: Main: 285196288 08:18:32 INFO - PROCESS | 1994 | 08:18:35 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:18:35 INFO - PROCESS | 1994 | RSS: Main: 283279360 08:18:35 INFO - PROCESS | 1994 | 08:18:37 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57168/tests/kraken/driver.html?testName=ai-astar) 08:18:38 INFO - PROCESS | 1994 | RSS: Main: 285454336 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | __start_tp_report 08:18:38 INFO - PROCESS | 1994 | _x_x_mozilla_page_load 08:18:38 INFO - PROCESS | 1994 | _x_x_mozilla_page_load_details 08:18:38 INFO - PROCESS | 1994 | |i|pagename|runs| 08:18:38 INFO - PROCESS | 1994 | |0;ai-astar;154;156;143;115;114;124;113;119;162;132 08:18:38 INFO - PROCESS | 1994 | |1;audio-beat-detection;186;110;185;182;157;140;143;122;155;106 08:18:38 INFO - PROCESS | 1994 | |2;audio-dft;204;227;203;230;196;227;259;205;236;277 08:18:38 INFO - PROCESS | 1994 | |3;audio-fft;73;65;74;108;60;65;82;91;148;58 08:18:38 INFO - PROCESS | 1994 | |4;audio-oscillator;83;88;118;79;81;81;108;81;81;111 08:18:38 INFO - PROCESS | 1994 | |5;imaging-gaussian-blur;86;92;87;94;87;91;86;93;87;92 08:18:38 INFO - PROCESS | 1994 | |6;imaging-darkroom;97;135;96;128;115;141;153;116;96;95 08:18:38 INFO - PROCESS | 1994 | |7;imaging-desaturate;146;144;91;91;90;95;91;92;91;91 08:18:38 INFO - PROCESS | 1994 | |8;json-parse-financial;55;56;55;56;56;55;57;67;56;54 08:18:38 INFO - PROCESS | 1994 | |9;json-stringify-tinderbox;64;64;73;63;72;70;66;68;82;65 08:18:38 INFO - PROCESS | 1994 | |10;stanford-crypto-aes;101;109;114;83;91;114;116;112;86;84 08:18:38 INFO - PROCESS | 1994 | |11;stanford-crypto-ccm;129;141;132;140;133;136;132;118;132;140 08:18:38 INFO - PROCESS | 1994 | |12;stanford-crypto-pbkdf2;131;142;144;140;139;155;128;124;123;132 08:18:38 INFO - PROCESS | 1994 | |13;stanford-crypto-sha256-iterative;69;69;90;58;60;91;58;80;99;96 08:18:38 INFO - PROCESS | 1994 | __end_tp_report 08:18:38 INFO - PROCESS | 1994 | __start_cc_report 08:18:38 INFO - PROCESS | 1994 | _x_x_mozilla_cycle_collect,887 08:18:38 INFO - PROCESS | 1994 | __end_cc_report 08:18:38 INFO - PROCESS | 1994 | __startTimestamp1455725918003__endTimestamp 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | ------- Summary: start ------- 08:18:38 INFO - PROCESS | 1994 | Number of tests: 14 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#0] ai-astar Cycles:10 Average:133.20 Median:137.50 stddev:19.07 (13.9%) stddev-sans-first:18.68 08:18:38 INFO - PROCESS | 1994 | Values: 154.0 156.0 143.0 115.0 114.0 124.0 113.0 119.0 162.0 132.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.00 stddev:29.94 (19.2%) stddev-sans-first:28.54 08:18:38 INFO - PROCESS | 1994 | Values: 186.0 110.0 185.0 182.0 157.0 140.0 143.0 122.0 155.0 106.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#2] audio-dft Cycles:10 Average:226.40 Median:228.50 stddev:26.16 (11.4%) stddev-sans-first:26.46 08:18:38 INFO - PROCESS | 1994 | Values: 204.0 227.0 203.0 230.0 196.0 227.0 259.0 205.0 236.0 277.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#3] audio-fft Cycles:10 Average:82.40 Median:69.00 stddev:27.68 (40.1%) stddev-sans-first:29.15 08:18:38 INFO - PROCESS | 1994 | Values: 73.0 65.0 74.0 108.0 60.0 65.0 82.0 91.0 148.0 58.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.00 stddev:15.04 (18.6%) stddev-sans-first:15.66 08:18:38 INFO - PROCESS | 1994 | Values: 83.0 88.0 118.0 79.0 81.0 81.0 108.0 81.0 81.0 111.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:91.50 stddev:3.17 (3.5%) stddev-sans-first:3.10 08:18:38 INFO - PROCESS | 1994 | Values: 86.0 92.0 87.0 94.0 87.0 91.0 86.0 93.0 87.0 92.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#6] imaging-darkroom Cycles:10 Average:117.20 Median:124.00 stddev:21.31 (17.2%) stddev-sans-first:21.31 08:18:38 INFO - PROCESS | 1994 | Values: 97.0 135.0 96.0 128.0 115.0 141.0 153.0 116.0 96.0 95.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:91.00 stddev:22.60 (24.8%) stddev-sans-first:17.56 08:18:38 INFO - PROCESS | 1994 | Values: 146.0 144.0 91.0 91.0 90.0 95.0 91.0 92.0 91.0 91.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.71 (6.6%) stddev-sans-first:3.89 08:18:38 INFO - PROCESS | 1994 | Values: 55.0 56.0 55.0 56.0 56.0 55.0 57.0 67.0 56.0 54.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:5.83 (8.5%) stddev-sans-first:5.93 08:18:38 INFO - PROCESS | 1994 | Values: 64.0 64.0 73.0 63.0 72.0 70.0 66.0 68.0 82.0 65.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#10] stanford-crypto-aes Cycles:10 Average:101.00 Median:99.50 stddev:13.69 (13.8%) stddev-sans-first:14.52 08:18:38 INFO - PROCESS | 1994 | Values: 101.0 109.0 114.0 83.0 91.0 114.0 116.0 112.0 86.0 84.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:134.50 stddev:6.78 (5.0%) stddev-sans-first:7.01 08:18:38 INFO - PROCESS | 1994 | Values: 129.0 141.0 132.0 140.0 133.0 136.0 132.0 118.0 132.0 140.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:139.50 stddev:10.02 (7.2%) stddev-sans-first:10.48 08:18:38 INFO - PROCESS | 1994 | Values: 131.0 142.0 144.0 140.0 139.0 155.0 128.0 124.0 123.0 132.0 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - PROCESS | 1994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:85.00 stddev:16.19 (19.0%) stddev-sans-first:16.91 08:18:38 INFO - PROCESS | 1994 | Values: 69.0 69.0 90.0 58.0 60.0 91.0 58.0 80.0 99.0 96.0 08:18:38 INFO - PROCESS | 1994 | -------- Summary: end -------- 08:18:38 INFO - PROCESS | 1994 | 08:18:38 INFO - TEST-INFO | 1994: exit 0 08:18:38 INFO - TEST-OK | kraken | took 58750ms 08:18:38 INFO - SUITE-END | took 1169s 08:18:39 INFO - Completed test suite (00:19:29) 08:18:39 INFO - Working with test: dromaeo_css 08:18:39 INFO - Generating results file: dromaeo_css 08:18:39 INFO - Working with test: kraken 08:18:39 INFO - Generating results file: kraken 08:18:39 INFO - javascript benchmark 08:18:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:18:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:18:39 INFO - process_Request line: dromaeo_css 7573.60 graph.html#tests=[[72,64,61]] 08:18:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:18:39 INFO - process_Request line: kraken 1563.10 graph.html#tests=[[232,64,61]] 08:18:39 INFO - RETURN: dromaeo_css: 7573.60 08:18:39 INFO - RETURN: kraken: 1563.10 08:18:39 INFO - javascript benchmark 08:18:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3467.1158854492105, 3540.345036168309, 3559.5016697662318, 3605.5853576838663, 3609.657082577154, 4719.882002949919, 5716.942830571693, 5719.513841323487, 5777.59556831022, 5794.884102317957, 5219.6950762309425, 5458.181272809081, 5758.395368486312, 5838.153467747175, 5902.586818922677, 4780.733105726985, 5091.745412729368, 5215.243789650498, 5281.15501519755, 5284.867878303035, 4374.825006999717, 5286.497782710637, 5327.547158491533, 5349.973250133744, 5364.061289274381, 5120.769565369567, 5166.0, 5257.237700533439, 5276.287701160332, 5301.390340110898, 5233.031889100528, 5271.604629652753, 5283.841484755463, 5285.735713214324, 5365.3293338332705, 5105.795768169269, 5222.138347172712, 5244.81643142492, 5253.7635806388425, 5272.657277276965, 4712.64655150865, 5586.91619625706, 5633.718314084321, 5709.314882214119, 5722.37053924068, 6233.532485063593, 6267.561270711052, 6271.278802937675, 6274.937250627527, 6302.55882088254, 6180.165677633507, 6202.503799696058, 6251.562390632612, 6271.184745982993, 6291.465225455841, 5939.287285525721, 5967.37342579023, 5968.224130863046, 5994.700264986734, 6016.639001659871, 6218.067289906459, 6383.96808015957, 6417.2299324081405, 6420.807375778734, 6425.839354016093, 6174.783882564178, 6225.00399936008, 6233.563650544418, 6242.157308763259, 6263.154474146023, 6293.1504246927, 6305.558610897285, 6307.400796924285, 6313.273973493107, 6317.305096439388, 6099.939000610026, 6171.043488259327, 6236.064590311399, 6256.7810126645345, 6278.748850045947, 6154.5384096192965, 6218.5647004709235, 6242.500599951993, 6255.437010669061, 6262.5616206866, 4953.529414705597, 4993.425756038029, 4997.100521906019, 5004.724740139327, 5017.322661440732, 4401.185780630593, 4422.668299877522, 4423.137488189836, 4461.196984542748, 4516.751578663139, 4853.80584776605, 5907.202527658797, 5921.6743079131065, 5948.375420580864, 5964.493018093423, 4976.875578110504, 6206.844828879314, 6234.314225435199, 6255.218097737783, 6263.843403914939, 5969.492593129546, 5996.4603185713495, 6009.248843894513, 6026.638401695912, 6036.758529658764, 5471.179323101566, 5478.753456094485, 5484.2596249506605, 5507.394186639466, 5515.944840551623, 6322.810315690536, 6380.234371875312, 6491.740330386731, 6513.869722605521, 6520.836979075466, 5216.295800067094, 6222.533310001678, 6276.623402595676, 6287.811365659038, 6297.433231009231, 6303.086052522267, 6429.164208652845, 6477.611343319416, 6501.674916254263, 6513.250976137615, 5371.194320851903, 6147.354527774519, 6208.0, 6234.0025595904435, 6261.9373806263175, 6151.384861513813, 6241.032639940817, 6266.154069200782, 6279.183706118175, 6281.0, 5331.466853314792, 6086.391360863879, 6146.016637338004, 6226.844328891814, 6248.4688801452385, 6196.721147548281, 6227.034809604518, 6229.937700622936, 6248.0940263660605, 6254.655993920378, 5996.610220335664, 6088.482478989158, 6097.237845269341, 6137.60105593135, 6145.354737752472, 6090.208272924491, 6117.492485019787, 6210.161628180138, 6233.345498722751, 6243.594166379171, 6042.75828966854, 6100.969495152496, 6130.233720784902, 6135.53983451234, 6146.5390095742105], "unit": "score", "name": "dojo.html", "value": 5734.833068941683}, {"lowerIsBetter": false, "replicates": [456.1128604863542, 494.87628092976746, 517.0047658257853, 556.6687820746656, 564.9745711533566, 30711.385772284597, 37510.43734343987, 39288.21423571527, 39950.99999999996, 40131.99670008251, 41528.16943661125, 42013.0, 42093.78953105238, 42104.789476052574, 42109.157816843646, 9518.095780900803, 9578.090081442251, 9683.854742178837, 9704.514774261293, 9728.124468797807, 9644.0, 9666.371685840399, 9711.854322185172, 9793.020697930222, 9800.754981125458, 9638.518074096302, 9707.95146024269, 9771.0, 9798.608055677765, 9828.262880283972, 9651.276154288422, 9666.130048295687, 9704.61181552737, 9743.610255589803, 9746.31775775696, 9534.141927226583, 9582.712518624452, 9655.806883862284, 9660.468674222915, 9691.07934746198, 32076.518852217236, 39174.0, 39323.60676393257, 39520.60479395227, 39611.80194099011, 2974.3992324131004, 3740.345439548068, 3855.9614403855885, 3950.6246906543834, 4087.6116768906904, 20754.896225518925, 26967.73032269672, 27766.722332776615, 27853.721462785314, 27874.16377508678, 2871.3970066286106, 2879.640044994376, 2879.7696184305414, 2893.8119022263486, 2894.20409387418, 322064.0, 384541.0, 385749.9999999972, 386290.0, 387802.0, 55852.720736396055, 63138.0529292061, 64621.67689161524, 66141.00788488176, 66356.33643663501, 55346.0, 61822.69088654528, 64138.67930660317, 64217.678911605144, 64688.0, 13484.865151348557, 15707.4502392418, 16057.919710401608, 16073.35706571724, 16110.838891610934, 11846.3415121883, 12309.138360314691, 12373.010159187243, 12452.750944981231, 12747.980161587051, 17697.823021769877, 20869.37391878246, 20977.580448390945, 21381.144754209658, 21458.356249312546, 7185.712571497186, 8529.185368828272, 8648.481091134427, 8686.843484118815, 8696.304295656333, 925.879635647375, 960.279790157382, 968.5496244246459, 974.2928158357518, 1083.4745148602922, 29787.40425191484, 30035.037211418112, 30072.24819379533, 30376.0, 30515.08454746361, 1072.1690689715376, 1083.501589268945, 1104.6575561575937, 1147.8335641332128, 1236.4621389695512, 15107.0, 15150.545483635287, 15393.153376564173, 15468.458603948808, 15515.146666933428, 540062.0, 543428.0, 549317.0, 549418.0, 550610.0, 58868.0, 59018.40981590215, 59079.81840363169, 59184.857060005386, 59303.11045334324, 1370.390176371525, 1406.2546850169426, 1408.499982506216, 1420.857914208571, 1427.978580321296, 29544.409111817215, 29920.370869925348, 29948.802047917838, 30070.541480377546, 30106.24734381658, 51485.48514514807, 52027.0, 52260.21609675782, 52553.68615784636, 52595.0, 520530.0, 521242.0, 524506.0, 525572.0, 527734.0, 32663.67336326606, 33638.83180584081, 33653.663463365054, 33768.81809136669, 33862.0, 42515.14969700527, 42525.0, 42802.57197427986, 42834.78582607067, 43383.69848904538, 35279.29441411209, 35522.64477355193, 35596.64403356037, 35999.92000239997, 36105.0, 35248.647513524535, 35329.64670353366, 35543.93368198958, 35815.64184358227, 35937.46093808647, 36095.27809443744, 36743.63256367402, 36944.81527592345, 37097.629023709414, 37135.44296835495, 31131.68868311288, 31975.520367194975, 32857.0, 33191.66808331886, 33593.32813343768, 24121.276361708475, 24328.78356082224, 24508.0, 24734.628980564947, 25237.369065772767], "unit": "score", "name": "ext.html", "value": 19652.84502848177}, {"lowerIsBetter": false, "replicates": [310.9564660947467, 363.94358874374467, 364.1914948813634, 367.39930214099957, 370.753448956444, 14988.250587470637, 15840.920795396007, 16089.0, 18869.339573114925, 20645.070971806268, 18345.54136146597, 18428.907855460704, 18432.0, 18639.25442982279, 18817.52956176093, 5651.378348381675, 5829.825105246829, 5975.372585878486, 5978.790742324019, 5991.940080599204, 5601.159826026088, 5965.926133296005, 5998.340182579913, 6015.75936962521, 6019.548533859978, 4154.210699967011, 5693.971530142344, 5951.88096238075, 5956.076808094752, 6195.6902154892305, 6216.067589861557, 6337.746490140389, 6344.904826427607, 6397.520185986046, 6402.583832050948, 5556.027695153372, 5611.7474713637985, 5613.775448982035, 5618.073017952033, 5632.9436705632825, 23699.341046126778, 24147.275581732578, 24392.878035609887, 24455.877720611283, 24496.63255051158, 2116.354511873878, 2467.4448249143798, 2514.3839759258917, 2892.464893994618, 2893.8842446302124, 14421.567352979428, 14550.417983280657, 14633.268336583129, 15002.24988750569, 15273.694526109526, 1752.649470105984, 1758.1560850791564, 1777.644471105784, 1781.910904454772, 1782.8951627763352, 95502.52248738782, 97756.53365199457, 99165.0, 100478.0, 101876.49061754718, 8704.738857834274, 10131.645392411378, 10529.631462898762, 10651.360918344924, 10695.679129626124, 12504.687382815502, 12564.183328083645, 12580.622581322576, 12671.239725616493, 12694.873051269555, 6944.965275173693, 8464.238218560236, 8470.872936905951, 8480.15198480147, 8559.443636163629, 6990.650467476606, 8740.169683880022, 8768.167024132697, 8859.025507194203, 8863.556822158866, 6073.939260607426, 6200.0, 6213.96893015532, 6214.782482613177, 6252.9370007098905, 1794.2553840156188, 1835.908204589765, 1839.2918726290475, 1866.3840932492244, 1867.4771064102074, 797.4656979823532, 899.3839220134229, 958.5015791788231, 1000.1848493477793, 1015.355249416611, 17686.29254829818, 20638.555301128778, 20674.483137921674, 20850.687239691415, 21110.577788444145, 732.8314487667759, 796.7729197178776, 963.1572374172599, 1012.86832711747, 1048.130052056791, 9767.902320976842, 10480.580776768997, 10492.108170805566, 10505.579776808841, 10686.625968091079, 755303.0, 779752.1012394902, 783473.0, 805946.0, 809181.6786412448, 120744.18883716752, 121704.78295217111, 124613.0, 125077.0, 125962.0, 1087.798757229915, 1183.4970137691446, 1197.712548988254, 1199.9820002699967, 1212.87871212878, 16868.0, 17552.0, 17689.734653979944, 17813.554661133057, 17833.821661783215, 40241.390344385894, 46701.76649116733, 50240.748796255786, 51410.0, 51583.48416515787, 61788.38211617826, 79213.0, 79744.0, 80297.0, 80651.59674201826, 7704.229577042251, 7829.373650107864, 7838.137804841577, 7912.643931023233, 7924.286814186751, 11162.609308674157, 12321.630351089481, 12565.371731413576, 12652.746945060862, 12770.0, 8437.704680336159, 10593.2584719072, 10654.307470014424, 10776.946115269373, 10962.342259464458, 10563.366198028143, 10839.132869370274, 10882.61910833117, 10910.448875942748, 10985.83521247166, 11084.224104312621, 11122.388268645302, 11191.944040279746, 11317.320960742381, 11404.030657393883, 7439.256074392518, 7769.184235655175, 7816.84366312682, 7822.530648161129, 7932.682692692228, 8556.529390883561, 10916.945415272872, 10968.725781855517, 10990.340579565252, 11083.445827708421], "unit": "score", "name": "jquery.html", "value": 9514.524202990255}, {"lowerIsBetter": false, "replicates": [1315.5726037249583, 1465.245398619711, 1679.4373884748609, 1848.0482551485986, 1884.152131540807, 7775.339096176817, 8386.91613083869, 8512.489250644958, 8673.826523469526, 8698.130186981307, 8397.622107005183, 8485.193906578881, 8579.656813727459, 8580.270676992448, 8588.184122508368, 2422.81828862836, 2428.0409238350885, 2456.361346050031, 2459.8770061496944, 2466.48203877186, 2419.6305158806854, 2476.5913624251975, 2477.0587176872764, 2483.639872218527, 2491.6511688363644, 2153.827693784501, 2404.2546810488716, 2452.9877350613224, 2486.7264600893977, 2499.800015998725, 2403.07481619576, 2408.590539608271, 2413.046846495642, 2439.512097580491, 2440.0361857066537, 2382.559226543095, 2440.3411079008747, 2441.108995216751, 2445.8899349529315, 2453.2640207937548, 8646.351523635689, 8663.0, 8666.480011199348, 8667.4366166199, 8696.826063478758, 5262.500062494057, 5319.707416092114, 5333.2000199969925, 5418.9458105418835, 5457.754401051922, 3591.425371940477, 3631.382664946939, 3664.0, 3684.5578530576236, 3722.1625134344554, 1036.7459972306758, 1051.0488008352454, 1062.7290041039485, 1062.9946850265776, 1077.2028698762938, 11543.480543375568, 11616.709582260426, 11618.825717614243, 11627.53489860413, 11633.36016519091, 4748.430188377348, 4822.0, 4830.830920917751, 4852.2479015752615, 4892.241702536113, 9764.218862490983, 9815.950920245496, 9844.950775246221, 9859.950700246452, 9876.555555000043, 5289.338832645919, 5364.544013758796, 5365.302510673588, 5371.979323928441, 5400.540954018874, 4750.501197374295, 4880.926786098212, 4890.144224760653, 4919.114559379346, 4939.876503087452, 3085.8457077146504, 3466.445368740989, 3926.9986153530667, 3944.8619298324993, 3961.7226794124713, 1301.531448678475, 1312.3372696788251, 1323.7617228898891, 1331.800229965513, 1332.6401871494836, 953.880764904387, 1073.8281874899978, 1100.0319718647538, 1208.6615747590688, 1291.3994992328612, 5908.3205431375945, 7813.218678132255, 7813.570253636105, 7973.0, 7989.440739148204, 995.437577768573, 1139.700741155084, 1171.625079974417, 1190.9940450297693, 1196.7068068323317, 5244.344456942882, 6332.430081292706, 6336.873262534724, 6357.300696923335, 6358.395952384516, 8844.823103537894, 10091.545880435398, 10359.96400359973, 10523.631672891412, 10593.788124237471, 10435.895641043493, 10439.895601044043, 10441.895581044093, 10536.789264214673, 10537.473126343652, 7771.8834217485655, 7904.4071694623135, 8045.557494337868, 8074.919250807417, 8076.596170191585, 7782.416318776001, 7807.492512986638, 7826.452148349561, 7872.37021038327, 7941.00737407824, 9108.681196158102, 9232.353735238468, 9266.721998340061, 9338.533073346442, 9399.201067909304, 9422.0, 9568.521573921136, 9645.324827262024, 9749.415035097916, 9908.009199080323, 6227.221597300338, 7251.782446526613, 7292.41660667156, 7377.8155546111775, 7393.741219057307, 7909.7231596893835, 7995.880061799194, 8028.518288902685, 8054.718084867001, 8070.314023307849, 6073.726682299395, 6765.492588056014, 7151.964240178766, 7442.851142977219, 7675.808104797201, 6128.50971922254, 6663.300353462817, 7372.557646541225, 7493.700251990077, 7528.698852046076, 7046.612436315847, 7613.923860761543, 7614.428917831074, 7622.428317876293, 7634.541927484369, 6782.796516104525, 6790.25307216196, 6830.351116643911, 6850.828729281808, 6905.930940690529, 6873.725050998104, 6987.475939304674, 6998.370146686619, 7006.124234470692, 7022.754203603054], "unit": "score", "name": "mootools.html", "value": 4837.760449563519}, {"lowerIsBetter": false, "replicates": [258.6495298870031, 317.370020509289, 326.6733266733267, 329.9868005279789, 331.11261818326875, 6469.514786391016, 6511.544191906569, 6528.608283502993, 6641.734330626769, 6646.767363142291, 5313.760880760366, 6638.1370421845095, 6643.800685979416, 6677.131972843524, 6699.866002679943, 3903.4925459690344, 4132.173565286939, 4961.702297862122, 4973.5772459340815, 5001.44984051754, 4540.250858608326, 4783.851875549878, 4949.133901567229, 5000.374953130859, 5009.198528235483, 4793.568578827905, 4934.25986102084, 4941.827036053739, 4973.726445045521, 4981.5516603505675, 4241.915161696779, 4923.138450771118, 4926.975365123188, 4944.035912996967, 4958.652894297401, 4050.25070361984, 4141.482314710661, 4235.237657221699, 4260.70175087744, 4262.339337402707, 5290.55030322423, 6214.285357183937, 6350.80947571569, 6386.680665966683, 6407.647579383132, 5860.384659610722, 5868.325142608612, 5877.235959325303, 5884.029135192688, 5893.705314734246, 7153.92846071543, 7166.462515311373, 7170.964145179293, 7184.640767961581, 7215.927840721631, 4736.005438857844, 4739.928901066487, 4755.881102972453, 4757.0, 4792.065547218293, 7410.777676669709, 7654.0815102187535, 7666.8849967250535, 7679.424043196838, 7698.384129269645, 4607.193741095295, 4666.973265881501, 4669.556392142741, 4669.579737823612, 4674.392328997209, 4725.456572494207, 4744.928826067612, 4750.311204875274, 4759.904801904012, 4765.11845308619, 5527.281453411031, 5672.971635141798, 5690.4025077367105, 5697.316322041299, 5704.286964129484, 7226.494145409771, 7229.4095299034125, 7242.529235599669, 7247.275272472711, 7280.96359518199, 1549.8915075944801, 1602.5833283346415, 1615.111688571281, 1644.5477493689332, 1644.958876028085, 1031.6440827914357, 1039.210200247817, 1042.2495803021811, 1043.1446214104512, 1049.3022140276782, 6623.304553021863, 6629.834254143685, 6698.4306333961185, 6711.463082953352, 6717.294684058202, 7387.556746595114, 7390.630468476555, 7392.815179620445, 7412.85174296511, 7440.144383395978, 6474.223093228843, 6694.230163531159, 6701.396874281338, 6724.428423583952, 6745.190577130677, 3928.3518219493462, 3934.626210509997, 3943.3296339622334, 3950.4271880577157, 3968.146848427602, 7799.610019499002, 7814.4529882907655, 7824.374050076094, 7837.686492540234, 7852.528848269122, 7387.409007279405, 7626.847463050819, 7654.249417785357, 7740.109887362913, 7818.491798033109, 7856.7250146244605, 7877.251661092187, 7879.606019699107, 7880.408969327438, 7905.762827115196, 7233.31283528064, 7423.0, 7433.888491672521, 7434.107907051189, 7446.8510629786015, 7371.262873712586, 7392.852142957218, 7406.925930740624, 7407.407407407287, 7413.962930185315, 7851.293383595504, 7866.646000930086, 7873.724419645285, 7888.3689304856625, 7894.565798881116, 4576.336431217388, 4647.790849411717, 4651.976740116278, 4683.555062269079, 4684.367610372556, 5663.405342438985, 6959.956006599051, 7296.1974182838785, 7503.699852006077, 7519.0, 5257.132573125392, 5451.37309209446, 5766.509846663081, 6653.367930046637, 7266.927330726625, 6317.936820631735, 7188.4968052235845, 7198.856022879618, 7222.9277707224355, 7234.421246300178, 6605.339466053356, 6855.4172895304455, 7080.645967701491, 7130.500864939404, 7159.928400715926, 5956.583039187215, 7242.818929526804, 7294.379977701955, 7302.525335853153, 7306.853862922605, 7146.928530714834, 7151.499395042297, 7156.355927966508, 7168.103987001625, 7174.641267936478], "unit": "score", "name": "prototype.html", "value": 5183.550816473698}, {"lowerIsBetter": false, "replicates": [620.4385031546451, 621.133518741356, 654.2247436787404, 686.7115811359229, 711.6726305899286, 14912.478063267788, 15173.0, 15262.160581168031, 15262.618434539128, 15301.770473442879, 13260.475045369785, 14234.359453824576, 14402.279886005685, 14414.639634009129, 14415.918806089532, 702.143385070216, 743.2418932688654, 844.7296865003201, 884.1114679746878, 885.5970533407284, 860.4364141487335, 866.4411454611771, 875.6234819027848, 875.9167879051512, 878.6704985630389, 914.9771255718593, 917.6971599372191, 919.8666193401987, 921.3044151665483, 924.6624981881632, 901.9684311049115, 909.1590278991939, 917.3761841947473, 918.9172974432266, 919.4161707315869, 652.2336254900521, 676.0771546838579, 677.7085853083172, 678.3826717686882, 680.4386381235452, 12492.500299987989, 14655.926720366437, 15305.464308749251, 15328.0, 15361.846381536265, 10075.445850478221, 13153.342332883318, 13455.0, 13619.591412257549, 13751.518696845562, 10080.092791648713, 11056.557737690482, 11366.318020918772, 11511.30932144074, 11992.700182495508, 3526.0655926179584, 3526.2947410518, 3568.3398571264397, 3618.963810361889, 3626.8549258029648, 84717.45847624581, 91109.0, 91413.0, 92231.53884230604, 92282.0, 8852.557372131496, 9774.924758276584, 9880.65417710391, 10027.097561219525, 10035.949820250851, 21939.67090493644, 22117.778822211894, 22364.440888977904, 22373.776262237494, 22381.0, 7366.558006519626, 7587.279208475186, 7619.9332093506955, 7779.4943328684585, 7939.6030198491, 3682.429223470366, 3920.745151565139, 3974.0410175683205, 4037.37420699792, 4139.0, 3617.0, 3625.984724277154, 3629.0, 3672.320620685182, 3683.465897444909, 644.0693198328464, 652.3085529338916, 660.9239937407164, 684.0594182998377, 685.8353995041253, 499.787590274132, 519.4493836533287, 597.5100417657566, 600.717662698531, 634.6002018728171, 8676.913230867736, 8698.0, 8711.695090671923, 8814.294856411472, 8953.194212520773, 507.7562769870483, 529.7986765029265, 587.9882402351928, 623.4638211138417, 627.1877918096077, 3918.275119102975, 4066.777829920227, 4074.3277359235985, 4129.628333450004, 4184.205001049791, 79042.0, 80263.19736802674, 80623.19376806275, 95313.0468695318, 96547.03452965521, 79110.60444697854, 83408.16591834003, 83768.0, 83871.0, 85530.57234713787, 74550.62724686341, 74883.87674184892, 75210.61552230162, 75764.62117689376, 76047.0, 8505.872411913702, 8930.821383572162, 8973.28213742886, 9142.542872856198, 9344.719658410258, 50031.49968500269, 52332.9533409322, 54673.45326546684, 55987.44012559822, 56333.0, 76752.0, 76959.23040769521, 77608.61195694211, 77659.22340776747, 77671.83492247507, 10493.898140695117, 10735.89264107349, 11263.549458021587, 11389.601363952223, 11633.825492617449, 8933.687320943736, 12123.878761212274, 12132.454039568418, 12171.39143042862, 12644.810327845275, 11600.767984640428, 11724.355160466257, 11807.704807379541, 12180.390980450764, 12388.62834114978, 11776.70558236051, 11997.460114294703, 12118.636440906786, 12136.0, 12161.635150945485, 10824.621138260123, 11939.223950443193, 11950.402479876146, 11951.282923024299, 12169.087318450975, 8575.356848236283, 9765.267604929517, 9772.0, 9777.560009799434, 10228.846567301645, 7878.921210787818, 9281.211097056555, 9995.250356223167, 10072.244581656258, 10241.385516868713], "unit": "score", "name": "yui.html", "value": 7017.391192490291}], "name": "dromaeo_css", "value": 7573.60394459375}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [154.0, 156.0, 143.0, 115.0, 114.0, 124.0, 113.0, 119.0, 162.0, 132.0], "unit": "score", "name": "ai-astar", "value": 133.2}, {"lowerIsBetter": true, "replicates": [186.0, 110.0, 185.0, 182.0, 157.0, 140.0, 143.0, 122.0, 155.0, 106.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [204.0, 227.0, 203.0, 230.0, 196.0, 227.0, 259.0, 205.0, 236.0, 277.0], "unit": "score", "name": "audio-dft", "value": 226.4}, {"lowerIsBetter": true, "replicates": [73.0, 65.0, 74.0, 108.0, 60.0, 65.0, 82.0, 91.0, 148.0, 58.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 118.0, 79.0, 81.0, 81.0, 108.0, 81.0, 81.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 91.1}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 87.0, 94.0, 87.0, 91.0, 86.0, 93.0, 87.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.5}, {"lowerIsBetter": true, "replicates": [97.0, 135.0, 96.0, 128.0, 115.0, 141.0, 153.0, 116.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 91.0, 91.0, 90.0, 95.0, 91.0, 92.0, 91.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 102.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 57.0, 67.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 73.0, 63.0, 72.0, 70.0, 66.0, 68.0, 82.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [101.0, 109.0, 114.0, 83.0, 91.0, 114.0, 116.0, 112.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 101.0}, {"lowerIsBetter": true, "replicates": [129.0, 141.0, 132.0, 140.0, 133.0, 136.0, 132.0, 118.0, 132.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.3}, {"lowerIsBetter": true, "replicates": [131.0, 142.0, 144.0, 140.0, 139.0, 155.0, 128.0, 124.0, 123.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 90.0, 58.0, 60.0, 91.0, 58.0, 80.0, 99.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.0}], "name": "kraken", "value": 1563.1}]} 08:18:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1563.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7573.60"}}} 08:18:39 INFO - Return code: 0 08:18:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:18:39 ERROR - # TBPL SUCCESS # 08:18:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:18:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:18:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:18:39 INFO - 2016-02-17 08:18:39.721 screenresolution[1999:21224] starting screenresolution argv=screenresolution get 08:18:39 INFO - 2016-02-17 08:18:39.723 screenresolution[1999:21224] Display 0: 1600x1200x32@60 08:18:39 INFO - 2016-02-17 08:18:39.729 screenresolution[2000:21227] starting screenresolution argv=screenresolution list 08:18:39 INFO - Available Modes on Display 0 08:18:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:18:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:18:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:18:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:18:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:18:39 INFO - Intel Iris: 08:18:39 INFO - Chipset Model: Intel Iris 08:18:39 INFO - Type: GPU 08:18:39 INFO - Bus: Built-In 08:18:39 INFO - VRAM (Dynamic, Max): 1536 MB 08:18:39 INFO - Vendor: Intel (0x8086) 08:18:39 INFO - Device ID: 0x0a2e 08:18:39 INFO - Revision ID: 0x0009 08:18:39 INFO - Displays: 08:18:39 INFO - Display: 08:18:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:18:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:18:39 INFO - Display Serial Number: 1600x1200 60 08:18:39 INFO - Main Display: Yes 08:18:39 INFO - Mirror: Off 08:18:39 INFO - Online: Yes 08:18:39 INFO - Rotation: Supported 08:18:39 INFO - Return code: 0 08:18:39 INFO - Running post-action listener: _resource_record_post_action 08:18:39 INFO - Running post-run listener: _resource_record_post_run 08:18:41 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 139264; Write bytes: 709946880; Read time: 5; Write time: 1948 08:18:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403507712; Write bytes: 398455808; Read time: 30205; Write time: 770 08:18:41 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 139264; Write bytes: 302025216; Read time: 5; Write time: 1144 08:18:41 INFO - Running post-run listener: _upload_blobber_files 08:18:41 INFO - Blob upload gear active. 08:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:41 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:18:41 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:18:41 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:18:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:42 INFO - (blobuploader) - INFO - Done attempting. 08:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:43 INFO - (blobuploader) - INFO - Done attempting. 08:18:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:43 INFO - Return code: 0 08:18:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a821b88691f117ca111c1bdf81885d8b4027f275ad8b2bf3897b290fdb69840b6897530521665af62d35bcf3de301f8e19f0ff7a5221d74a192d7fa4cce65b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af658a9849595bf24c39b654e5f7f6f10757c59098bb768ece99bc822d2552d94b47a550a475ceb32aef01ffe6f816afdaa99eaf821fbd06860b1bcf5d7a7a3"} 08:18:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:43 INFO - Contents: 08:18:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a821b88691f117ca111c1bdf81885d8b4027f275ad8b2bf3897b290fdb69840b6897530521665af62d35bcf3de301f8e19f0ff7a5221d74a192d7fa4cce65b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af658a9849595bf24c39b654e5f7f6f10757c59098bb768ece99bc822d2552d94b47a550a475ceb32aef01ffe6f816afdaa99eaf821fbd06860b1bcf5d7a7a3"} 08:18:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:43 INFO - Copying logs to upload dir... 08:18:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.977347 ========= master_lag: 1.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-17 08:18:45.589833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 08:18:45.594692) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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/04a821b88691f117ca111c1bdf81885d8b4027f275ad8b2bf3897b290fdb69840b6897530521665af62d35bcf3de301f8e19f0ff7a5221d74a192d7fa4cce65b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af658a9849595bf24c39b654e5f7f6f10757c59098bb768ece99bc822d2552d94b47a550a475ceb32aef01ffe6f816afdaa99eaf821fbd06860b1bcf5d7a7a3"} build_url:https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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/04a821b88691f117ca111c1bdf81885d8b4027f275ad8b2bf3897b290fdb69840b6897530521665af62d35bcf3de301f8e19f0ff7a5221d74a192d7fa4cce65b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af658a9849595bf24c39b654e5f7f6f10757c59098bb768ece99bc822d2552d94b47a550a475ceb32aef01ffe6f816afdaa99eaf821fbd06860b1bcf5d7a7a3"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 08:18:45.770940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 08:18:45.771412) ========= 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.v1PSmbmFmi/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.BvUXxdnOOQ/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 08:18:45.817271) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-17 08:18:45.817555) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-17 08:18:48.635531) ========= ========= Total master_lag: 2.21 =========