builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1457087886.35 results: success (0) buildid: 20160304014526 builduid: 832f206eb44342ac85de1e940e33eae3 revision: 20d8879ac256a9c7ff81edc69748c37c3b310865 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.348788) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.349459) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.349844) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005674 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.373043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.373381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.389991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.390382) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005328 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.439386) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.439693) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.440043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.440509) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-04 02:38:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 65.4M=0s 2016-03-04 02:38:06 (65.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.560803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.561364) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.026938 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.611098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:06.611439) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20d8879ac256a9c7ff81edc69748c37c3b310865 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 20d8879ac256a9c7ff81edc69748c37c3b310865 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-04 02:38:06,685 truncating revision to first 12 chars 2016-03-04 02:38:06,685 Setting DEBUG logging. 2016-03-04 02:38:06,685 attempt 1/10 2016-03-04 02:38:06,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20d8879ac256?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 02:38:07,287 unpacking tar archive at: mozilla-central-20d8879ac256/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:07.480581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:07.480933) ========= echo 20d8879ac256a9c7ff81edc69748c37c3b310865 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'20d8879ac256a9c7ff81edc69748c37c3b310865'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 20d8879ac256a9c7ff81edc69748c37c3b310865 program finished with exit code 0 elapsedTime=0.006058 script_repo_revision: '20d8879ac256a9c7ff81edc69748c37c3b310865' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:07.531048) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:07.531345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 02:38:07.544729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-04 02:38:07.545608) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:07 INFO - MultiFileLogger online at 20160304 02:38:07 in /builds/slave/test 02:38:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:38:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:07 INFO - {'append_to_log': False, 02:38:07 INFO - 'base_work_dir': '/builds/slave/test', 02:38:07 INFO - 'blob_upload_branch': 'Firefox', 02:38:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:07 INFO - 'branch': 'Firefox', 02:38:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:07 INFO - 'config_files': ('talos/mac_config.py',), 02:38:07 INFO - 'default_actions': ('clobber', 02:38:07 INFO - 'read-buildbot-config', 02:38:07 INFO - 'download-and-extract', 02:38:07 INFO - 'populate-webroot', 02:38:07 INFO - 'create-virtualenv', 02:38:07 INFO - 'install', 02:38:07 INFO - 'run-tests'), 02:38:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:07 INFO - 'download_minidump_stackwalk': True, 02:38:07 INFO - 'download_symbols': 'ondemand', 02:38:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:07 INFO - 'installer_path': 'installer.exe', 02:38:07 INFO - 'log_level': 'info', 02:38:07 INFO - 'log_name': 'talos', 02:38:07 INFO - 'log_to_console': True, 02:38:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:38:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:38:07 INFO - 'opt_config_files': (), 02:38:07 INFO - 'pip_index': False, 02:38:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:07 INFO - 'cmd': ('bash', 02:38:07 INFO - '-c', 02:38:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:07 INFO - 'enabled': True, 02:38:07 INFO - 'halt_on_failure': False, 02:38:07 INFO - 'name': 'check_screen_resolution'},), 02:38:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:07 INFO - 'cmd': ('bash', 02:38:07 INFO - '-c', 02:38:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:07 INFO - 'enabled': True, 02:38:07 INFO - 'halt_on_failure': False, 02:38:07 INFO - 'name': 'check_screen_resolution'},), 02:38:07 INFO - 'run_cmd_checks_enabled': True, 02:38:07 INFO - 'sps_profile': False, 02:38:07 INFO - 'sps_profile_interval': 0, 02:38:07 INFO - 'suite': 'dromaeojs-e10s', 02:38:07 INFO - 'system_bits': '32', 02:38:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:07 INFO - 'title': 't-yosemite-r7-0052', 02:38:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:07 INFO - 'use_talos_json': True, 02:38:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:07 INFO - 'work_dir': 'build'} 02:38:07 INFO - ##### 02:38:07 INFO - ##### Running clobber step. 02:38:07 INFO - ##### 02:38:07 INFO - Running pre-action listener: _resource_record_pre_action 02:38:07 INFO - Running main action method: clobber 02:38:07 INFO - rmtree: /builds/slave/test/build 02:38:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:09 INFO - Running post-action listener: _resource_record_post_action 02:38:09 INFO - ##### 02:38:09 INFO - ##### Running read-buildbot-config step. 02:38:09 INFO - ##### 02:38:09 INFO - Running pre-action listener: _resource_record_pre_action 02:38:09 INFO - Running main action method: read_buildbot_config 02:38:09 INFO - Using buildbot properties: 02:38:09 INFO - { 02:38:09 INFO - "project": "", 02:38:09 INFO - "product": "firefox", 02:38:09 INFO - "script_repo_revision": "production", 02:38:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:38:09 INFO - "repository": "", 02:38:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:38:09 INFO - "buildid": "20160304014526", 02:38:09 INFO - "pgo_build": "False", 02:38:09 INFO - "basedir": "/builds/slave/test", 02:38:09 INFO - "buildnumber": 165, 02:38:09 INFO - "slavename": "t-yosemite-r7-0052", 02:38:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:38:09 INFO - "platform": "yosemite_r7", 02:38:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:38:09 INFO - "branch": "mozilla-central", 02:38:09 INFO - "repo_path": "mozilla-central", 02:38:09 INFO - "revision": "20d8879ac256a9c7ff81edc69748c37c3b310865", 02:38:09 INFO - "stage_platform": "macosx64", 02:38:09 INFO - "builduid": "832f206eb44342ac85de1e940e33eae3", 02:38:09 INFO - "slavebuilddir": "test" 02:38:09 INFO - } 02:38:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:38:09 INFO - Running post-action listener: _resource_record_post_action 02:38:09 INFO - ##### 02:38:09 INFO - ##### Running download-and-extract step. 02:38:09 INFO - ##### 02:38:09 INFO - Running pre-action listener: _resource_record_pre_action 02:38:09 INFO - Running main action method: download_and_extract 02:38:09 INFO - mkdir: /builds/slave/test/build/tests 02:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:09 INFO - https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:38:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 02:38:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 02:38:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 02:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 02:38:10 INFO - Downloaded 1277 bytes. 02:38:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 02:38:10 INFO - Using the following test package requirements: 02:38:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:38:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:38:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:38:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'jsshell-mac.zip'], 02:38:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:38:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:38:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:38:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:38:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:38:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:38:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:38:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:38:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:10 INFO - https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:11 INFO - Downloaded 17854995 bytes. 02:38:11 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'] 02:38:11 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 02:38:14 INFO - Return code: 0 02:38:14 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 02:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:14 INFO - https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:15 INFO - Downloaded 17854995 bytes. 02:38:15 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'] 02:38:15 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 02:38:19 INFO - Return code: 0 02:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:19 INFO - https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:20 INFO - Downloaded 10808282 bytes. 02:38:20 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'] 02:38:20 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 02:38:20 INFO - Return code: 0 02:38: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')]} 02:38:20 INFO - https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DCF7tAZ9RcCazxE4hw_V4A/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 02:38:23 INFO - Downloaded 110967930 bytes. 02:38:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:38:23 INFO - mkdir: /builds/slave/test/properties 02:38:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:23 INFO - Contents: 02:38:23 INFO - build_url:https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:38:24 INFO - Running post-action listener: _resource_record_post_action 02:38:24 INFO - Running post-action listener: set_extra_try_arguments 02:38:24 INFO - ##### 02:38:24 INFO - ##### Running populate-webroot step. 02:38:24 INFO - ##### 02:38:24 INFO - Running pre-action listener: _resource_record_pre_action 02:38:24 INFO - Running main action method: populate_webroot 02:38:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:24 INFO - '--tppagecycles', 02:38:24 INFO - '7'], 02:38:24 INFO - 'tests': ['tsvgm']}}, 02:38:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:38:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:38:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'tests': ['damp', 'tps']}, 02:38:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['damp', 'tps']}, 02:38:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:38:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:24 INFO - 'other': {'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'other_l64': {'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'other_nol64': {'tests': ['a11yr', 02:38:24 INFO - 'ts_paint', 02:38:24 INFO - 'tpaint', 02:38:24 INFO - 'sessionrestore', 02:38:24 INFO - 'sessionrestore_no_auto_restore']}, 02:38:24 INFO - 'svgr': {'tests': ['tsvgx', 02:38:24 INFO - 'tsvgr_opacity', 02:38:24 INFO - 'tart', 02:38:24 INFO - 'tscrollx', 02:38:24 INFO - 'cart']}, 02:38:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['tsvgx', 02:38:24 INFO - 'tsvgr_opacity', 02:38:24 INFO - 'tart', 02:38:24 INFO - 'tscrollx', 02:38:24 INFO - 'cart']}, 02:38:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'tests': ['tp5o']}, 02:38:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'talos_options': ['--e10s'], 02:38:24 INFO - 'tests': ['tp5o']}, 02:38:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'talos_options': ['--xperf_path', 02:38:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:24 INFO - 'tests': ['tp5n']}, 02:38:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:24 INFO - 'talos_options': ['--e10s', 02:38:24 INFO - '--xperf_path', 02:38:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:24 INFO - 'tests': ['tp5n']}}, 02:38:24 INFO - 'talos.zip': {'path': '', 02:38:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:24 INFO - Running post-action listener: _resource_record_post_action 02:38:24 INFO - ##### 02:38:24 INFO - ##### Running create-virtualenv step. 02:38:24 INFO - ##### 02:38:24 INFO - Running pre-action listener: _resource_record_pre_action 02:38:24 INFO - Running main action method: create_virtualenv 02:38:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:24 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 02:38:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:24 INFO - Using real prefix '/tools/python27' 02:38:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:28 INFO - Installing pip.................done. 02:38:28 INFO - Return code: 0 02:38:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:28 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')]} 02:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:28 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')]} 02:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:28 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:28 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 02:38:28 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 02:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:28 INFO - 'HOME': '/Users/cltbld', 02:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:28 INFO - 'LOGNAME': 'cltbld', 02:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:28 INFO - 'MOZ_NO_REMOTE': '1', 02:38:28 INFO - 'NO_EM_RESTART': '1', 02:38:28 INFO - 'PAGER': '/bin/cat', 02:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:28 INFO - 'PWD': '/builds/slave/test', 02:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:28 INFO - 'SHELL': '/bin/bash', 02:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:28 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:28 INFO - 'USER': 'cltbld', 02:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:28 INFO - 'XPC_FLAGS': '0x0', 02:38:28 INFO - 'XPC_SERVICE_NAME': '0', 02:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:28 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 02:38:28 INFO - Cleaning up... 02:38:28 INFO - Return code: 0 02:38:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:38:28 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')]} 02:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:28 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')]} 02:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:28 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:28 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 02:38:28 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 02:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:28 INFO - 'HOME': '/Users/cltbld', 02:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:28 INFO - 'LOGNAME': 'cltbld', 02:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:28 INFO - 'MOZ_NO_REMOTE': '1', 02:38:28 INFO - 'NO_EM_RESTART': '1', 02:38:28 INFO - 'PAGER': '/bin/cat', 02:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:28 INFO - 'PWD': '/builds/slave/test', 02:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:28 INFO - 'SHELL': '/bin/bash', 02:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:28 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:28 INFO - 'USER': 'cltbld', 02:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:28 INFO - 'XPC_FLAGS': '0x0', 02:38:28 INFO - 'XPC_SERVICE_NAME': '0', 02:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:29 INFO - Downloading/unpacking psutil>=0.7.1 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:31 INFO - Installing collected packages: psutil 02:38:31 INFO - Running setup.py install for psutil 02:38:32 INFO - building 'psutil._psutil_osx' extension 02:38:32 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 02:38:32 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 02:38:32 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 02:38:32 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 02:38:32 INFO - building 'psutil._psutil_posix' extension 02:38:32 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 02:38:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:38:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:38:32 INFO - ^ 02:38:33 INFO - 1 warning generated. 02:38:33 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 02:38:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:33 INFO - Successfully installed psutil 02:38:33 INFO - Cleaning up... 02:38:33 INFO - Return code: 0 02:38:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:38:33 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')]} 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:33 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')]} 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:33 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:33 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 02:38:33 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 02:38:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:33 INFO - 'HOME': '/Users/cltbld', 02:38:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:33 INFO - 'LOGNAME': 'cltbld', 02:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:33 INFO - 'MOZ_NO_REMOTE': '1', 02:38:33 INFO - 'NO_EM_RESTART': '1', 02:38:33 INFO - 'PAGER': '/bin/cat', 02:38:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:33 INFO - 'PWD': '/builds/slave/test', 02:38:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:33 INFO - 'SHELL': '/bin/bash', 02:38:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:33 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:33 INFO - 'USER': 'cltbld', 02:38:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:33 INFO - 'XPC_FLAGS': '0x0', 02:38:33 INFO - 'XPC_SERVICE_NAME': '0', 02:38:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:38:36 INFO - Installing collected packages: mozsystemmonitor 02:38:36 INFO - Running setup.py install for mozsystemmonitor 02:38:36 INFO - Successfully installed mozsystemmonitor 02:38:36 INFO - Cleaning up... 02:38:36 INFO - Return code: 0 02:38:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:36 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:36 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 02:38:36 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 02:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:36 INFO - 'HOME': '/Users/cltbld', 02:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:36 INFO - 'LOGNAME': 'cltbld', 02:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:36 INFO - 'MOZ_NO_REMOTE': '1', 02:38:36 INFO - 'NO_EM_RESTART': '1', 02:38:36 INFO - 'PAGER': '/bin/cat', 02:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:36 INFO - 'PWD': '/builds/slave/test', 02:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:36 INFO - 'SHELL': '/bin/bash', 02:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:36 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:36 INFO - 'USER': 'cltbld', 02:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:36 INFO - 'XPC_FLAGS': '0x0', 02:38:36 INFO - 'XPC_SERVICE_NAME': '0', 02:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:40 INFO - Downloading docopt-0.6.1.tar.gz 02:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:40 INFO - Running setup.py install for blobuploader 02:38:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:40 INFO - Running setup.py install for requests 02:38:40 INFO - Running setup.py install for docopt 02:38:41 INFO - Successfully installed blobuploader requests docopt 02:38:41 INFO - Cleaning up... 02:38:41 INFO - Return code: 0 02:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:41 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')]} 02:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:41 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')]} 02:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:41 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:41 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 02:38:41 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 02:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:41 INFO - 'HOME': '/Users/cltbld', 02:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:41 INFO - 'LOGNAME': 'cltbld', 02:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:41 INFO - 'MOZ_NO_REMOTE': '1', 02:38:41 INFO - 'NO_EM_RESTART': '1', 02:38:41 INFO - 'PAGER': '/bin/cat', 02:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:41 INFO - 'PWD': '/builds/slave/test', 02:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:41 INFO - 'SHELL': '/bin/bash', 02:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:41 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:41 INFO - 'USER': 'cltbld', 02:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:41 INFO - 'XPC_FLAGS': '0x0', 02:38:41 INFO - 'XPC_SERVICE_NAME': '0', 02:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-sdG_2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-OocMQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-D0Yt_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-nnfi3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-5Br_qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zXTGeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-maBLt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-uiWyiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-iGM06A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-d6CT3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-3Rad4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-RnJYq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-0yF78I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-uoQ3ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-kdB4gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:43 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ya3Lnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:43 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tcc2BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:43 INFO - Running setup.py install for manifestparser 02:38:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozcrash 02:38:43 INFO - Running setup.py install for mozdebug 02:38:43 INFO - Running setup.py install for mozdevice 02:38:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozfile 02:38:43 INFO - Running setup.py install for mozhttpd 02:38:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozinfo 02:38:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozInstall 02:38:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozleak 02:38:44 INFO - Running setup.py install for mozlog 02:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for moznetwork 02:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozprocess 02:38:44 INFO - Running setup.py install for mozprofile 02:38:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Running setup.py install for mozrunner 02:38:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Running setup.py install for mozscreenshot 02:38:45 INFO - Running setup.py install for moztest 02:38:45 INFO - Running setup.py install for mozversion 02:38:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:45 INFO - Cleaning up... 02:38:45 INFO - Return code: 0 02:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:45 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')]} 02:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:45 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')]} 02:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:45 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:45 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 02:38:45 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 02:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:45 INFO - 'HOME': '/Users/cltbld', 02:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:45 INFO - 'LOGNAME': 'cltbld', 02:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:45 INFO - 'MOZ_NO_REMOTE': '1', 02:38:45 INFO - 'NO_EM_RESTART': '1', 02:38:45 INFO - 'PAGER': '/bin/cat', 02:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:45 INFO - 'PWD': '/builds/slave/test', 02:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:45 INFO - 'SHELL': '/bin/bash', 02:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:45 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:45 INFO - 'USER': 'cltbld', 02:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:45 INFO - 'XPC_FLAGS': '0x0', 02:38:45 INFO - 'XPC_SERVICE_NAME': '0', 02:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-SDjuhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4J1EXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-WwWvbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tMDMcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-D9JxaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-TjooiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Aag2Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-oIAJSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Fydj8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-WonHYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-UvsOIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-sos4DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-KK2YWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-1AYrR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-0EAsSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-s28BUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-oOi1r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:50 INFO - Downloading blessings-1.6.tar.gz 02:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:50 INFO - Installing collected packages: blessings 02:38:50 INFO - Running setup.py install for blessings 02:38:50 INFO - Successfully installed blessings 02:38:50 INFO - Cleaning up... 02:38:50 INFO - Return code: 0 02:38:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:50 INFO - Reading from file tmpfile_stdout 02:38:50 INFO - Current package versions: 02:38:50 INFO - blessings == 1.6 02:38:50 INFO - blobuploader == 1.2.4 02:38:50 INFO - docopt == 0.6.1 02:38:50 INFO - manifestparser == 1.1 02:38:50 INFO - mozInstall == 1.12 02:38:50 INFO - mozcrash == 0.16 02:38:50 INFO - mozdebug == 0.1 02:38:50 INFO - mozdevice == 0.48 02:38:50 INFO - mozfile == 1.2 02:38:50 INFO - mozhttpd == 0.7 02:38:50 INFO - mozinfo == 0.9 02:38:50 INFO - mozleak == 0.1 02:38:50 INFO - mozlog == 3.1 02:38:50 INFO - moznetwork == 0.27 02:38:50 INFO - mozprocess == 0.22 02:38:50 INFO - mozprofile == 0.28 02:38:50 INFO - mozrunner == 6.11 02:38:50 INFO - mozscreenshot == 0.1 02:38:50 INFO - mozsystemmonitor == 0.0 02:38:50 INFO - moztest == 0.7 02:38:50 INFO - mozversion == 1.4 02:38:50 INFO - psutil == 3.1.1 02:38:50 INFO - requests == 1.2.3 02:38:50 INFO - wsgiref == 0.1.2 02:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:50 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 02:38:50 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 02:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:50 INFO - 'HOME': '/Users/cltbld', 02:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:50 INFO - 'LOGNAME': 'cltbld', 02:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:50 INFO - 'MOZ_NO_REMOTE': '1', 02:38:50 INFO - 'NO_EM_RESTART': '1', 02:38:50 INFO - 'PAGER': '/bin/cat', 02:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:50 INFO - 'PWD': '/builds/slave/test', 02:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:50 INFO - 'SHELL': '/bin/bash', 02:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:50 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:50 INFO - 'USER': 'cltbld', 02:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:50 INFO - 'XPC_FLAGS': '0x0', 02:38:50 INFO - 'XPC_SERVICE_NAME': '0', 02:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 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)) 02:38:51 INFO - Cleaning up... 02:38:51 INFO - Return code: 0 02:38:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:51 INFO - 'HOME': '/Users/cltbld', 02:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:51 INFO - 'LOGNAME': 'cltbld', 02:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:51 INFO - 'MOZ_NO_REMOTE': '1', 02:38:51 INFO - 'NO_EM_RESTART': '1', 02:38:51 INFO - 'PAGER': '/bin/cat', 02:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:51 INFO - 'PWD': '/builds/slave/test', 02:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:51 INFO - 'SHELL': '/bin/bash', 02:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:51 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:51 INFO - 'USER': 'cltbld', 02:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:51 INFO - 'XPC_FLAGS': '0x0', 02:38:51 INFO - 'XPC_SERVICE_NAME': '0', 02:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:51 INFO - Downloading/unpacking jsonschema 02:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:53 INFO - Downloading/unpacking functools32 (from jsonschema) 02:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:54 INFO - warning: no files found matching '*.txt' 02:38:54 INFO - no previously-included directories found matching 'build' 02:38:54 INFO - no previously-included directories found matching 'dist' 02:38:54 INFO - no previously-included directories found matching '.git*' 02:38:54 INFO - Installing collected packages: jsonschema, functools32 02:38:54 INFO - Running setup.py install for functools32 02:38:54 INFO - warning: no files found matching '*.txt' 02:38:54 INFO - no previously-included directories found matching 'build' 02:38:54 INFO - no previously-included directories found matching 'dist' 02:38:54 INFO - no previously-included directories found matching '.git*' 02:38:54 INFO - Successfully installed jsonschema functools32 02:38:54 INFO - Cleaning up... 02:38:54 INFO - Return code: 0 02:38:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105094a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10509b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc94ac8a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, '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.j5LIX6wsFu/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.yTxsESXzIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 02:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:38:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:38:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:54 INFO - 'HOME': '/Users/cltbld', 02:38:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:54 INFO - 'LOGNAME': 'cltbld', 02:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:54 INFO - 'MOZ_NO_REMOTE': '1', 02:38:54 INFO - 'NO_EM_RESTART': '1', 02:38:54 INFO - 'PAGER': '/bin/cat', 02:38:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:54 INFO - 'PWD': '/builds/slave/test', 02:38:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:54 INFO - 'SHELL': '/bin/bash', 02:38:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:38:54 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:38:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:54 INFO - 'USER': 'cltbld', 02:38:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:54 INFO - 'XPC_FLAGS': '0x0', 02:38:54 INFO - 'XPC_SERVICE_NAME': '0', 02:38:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:54 INFO - Downloading/unpacking flake8 02:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:38:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:38:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:58 INFO - no previously-included directories found matching 'docs/_build' 02:38:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:38:58 INFO - Running setup.py install for pep8 02:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:58 INFO - no previously-included directories found matching 'docs/_build' 02:38:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:38:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:38:58 INFO - Cleaning up... 02:38:58 INFO - Return code: 0 02:38:58 INFO - Running post-action listener: _resource_record_post_action 02:38:58 INFO - Running post-action listener: _start_resource_monitoring 02:38:58 INFO - Starting resource monitoring. 02:38:58 INFO - ##### 02:38:58 INFO - ##### Running install step. 02:38:58 INFO - ##### 02:38:58 INFO - Running pre-action listener: _resource_record_pre_action 02:38:58 INFO - Running main action method: install 02:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:58 INFO - Reading from file tmpfile_stdout 02:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:58 INFO - Reading from file tmpfile_stdout 02:38:58 INFO - Output received: 02:38:58 INFO - Usage: mozinstall [options] installer 02:38:58 INFO - Options: 02:38:58 INFO - -h, --help show this help message and exit 02:38:58 INFO - -d DEST, --destination=DEST 02:38:58 INFO - Directory to install application into. [default: 02:38:58 INFO - "/builds/slave/test"] 02:38:58 INFO - --app=APP Application being installed. [default: firefox] 02:38:58 INFO - mkdir: /builds/slave/test/build/application 02:38:58 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'] 02:38:58 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 02:39:32 INFO - Reading from file tmpfile_stdout 02:39:32 INFO - Output received: 02:39:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:39:32 INFO - Running post-action listener: _resource_record_post_action 02:39:32 INFO - ##### 02:39:32 INFO - ##### Running run-tests step. 02:39:32 INFO - ##### 02:39:32 INFO - Running pre-action listener: _resource_record_pre_action 02:39:32 INFO - Running main action method: run_tests 02:39:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:39:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:39:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:39:32 INFO - 2016-03-04 02:39:32.647 screenresolution[1643:7343] starting screenresolution argv=screenresolution get 02:39:32 INFO - 2016-03-04 02:39:32.650 screenresolution[1643:7343] Display 0: 1600x1200x32@60 02:39:32 INFO - 2016-03-04 02:39:32.656 screenresolution[1644:7345] starting screenresolution argv=screenresolution list 02:39:32 INFO - Available Modes on Display 0 02:39:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:39:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:39:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:39:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:39:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:39:32 INFO - Intel Iris: 02:39:32 INFO - Chipset Model: Intel Iris 02:39:32 INFO - Type: GPU 02:39:32 INFO - Bus: Built-In 02:39:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:39:32 INFO - Vendor: Intel (0x8086) 02:39:32 INFO - Device ID: 0x0a2e 02:39:32 INFO - Revision ID: 0x0009 02:39:32 INFO - Displays: 02:39:32 INFO - Display: 02:39:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:39:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:39:32 INFO - Display Serial Number: 1600x1200 60 02:39:32 INFO - Main Display: Yes 02:39:32 INFO - Mirror: Off 02:39:32 INFO - Online: Yes 02:39:32 INFO - Rotation: Supported 02:39:32 INFO - Return code: 0 02:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:32 INFO - Python 2.7.3 02:39:32 INFO - Return code: 0 02:39:32 INFO - grabbing minidump binary from tooltool 02:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:32 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 0x104f38d30>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f2fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:32 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 02:39:32 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 02:39:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:32 INFO - Return code: 0 02:39:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:39:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:39:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:39:34 INFO - Return code: 0 02:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 02:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 02:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j5LIX6wsFu/Render', 02:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:34 INFO - 'HOME': '/Users/cltbld', 02:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:34 INFO - 'LOGNAME': 'cltbld', 02:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:34 INFO - 'MOZ_NO_REMOTE': '1', 02:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:34 INFO - 'NO_EM_RESTART': '1', 02:39:34 INFO - 'PAGER': '/bin/cat', 02:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:34 INFO - 'PWD': '/builds/slave/test', 02:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:34 INFO - 'SHELL': '/bin/bash', 02:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yTxsESXzIE/Listeners', 02:39:34 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 02:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:34 INFO - 'USER': 'cltbld', 02:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:34 INFO - 'XPC_FLAGS': '0x0', 02:39:34 INFO - 'XPC_SERVICE_NAME': '0', 02:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 02:39:34 INFO - mozversion application_buildid: 20160304014526 02:39:34 INFO - mozversion application_changeset: 20d8879ac256a9c7ff81edc69748c37c3b310865 02:39:34 INFO - mozversion application_display_name: Nightly 02:39:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:34 INFO - mozversion application_name: Firefox 02:39:34 INFO - mozversion application_remotingname: firefox 02:39:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:39:34 INFO - mozversion application_vendor: Mozilla 02:39:34 INFO - mozversion application_version: 47.0a1 02:39:34 INFO - mozversion platform_buildid: 20160304014526 02:39:34 INFO - mozversion platform_changeset: 20d8879ac256a9c7ff81edc69748c37c3b310865 02:39:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:39:34 INFO - mozversion platform_version: 47.0a1 02:39:34 INFO - using testdate: 1457087974 02:39:34 INFO - actual date: 1457087974 02:39:34 INFO - starting webserver on 'localhost:49270' 02:39:34 INFO - SUITE-START | Running 2 tests 02:39:34 INFO - TEST-START | dromaeo_css 02:39:34 INFO - operating with platform_type : mac_ 02:39:34 INFO - Initialising browser for dromaeo_css test... 02:39:34 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpQguvCc/profile http://localhost:49270/getInfo.html) 02:39:37 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 02:39:37 INFO - PROCESS | 1662 | colorDepth:24 02:39:37 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 02:39:37 INFO - PROCESS | 1662 | __metrics 02:39:37 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:39:38 INFO - TEST-INFO | 1662: exit 0 02:39:38 INFO - Browser initialized. 02:39:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:38 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpQguvCc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:50 INFO - PROCESS | 1666 | RSS: Main: 254832640 02:39:50 INFO - PROCESS | 1666 | 02:40:40 INFO - PROCESS | 1666 | 1457088040380 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] 02:42:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 02:42:52 INFO - PROCESS | 1666 | RSS: Main: 268214272 02:42:52 INFO - PROCESS | 1666 | 02:45:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 02:45:55 INFO - PROCESS | 1666 | RSS: Main: 280207360 02:45:55 INFO - PROCESS | 1666 | 02:48:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 02:48:57 INFO - PROCESS | 1666 | RSS: Main: 282451968 02:48:57 INFO - PROCESS | 1666 | 02:51:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 02:52:00 INFO - PROCESS | 1666 | RSS: Main: 284147712 02:52:00 INFO - PROCESS | 1666 | 02:55:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 02:55:03 INFO - PROCESS | 1666 | RSS: Main: 285286400 02:55:03 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 02:58:05 INFO - PROCESS | 1666 | RSS: Main: 288694272 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | __start_tp_report 02:58:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 02:58:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 02:58:05 INFO - PROCESS | 1666 | |i|pagename|runs| 02:58:05 INFO - PROCESS | 1666 | |0;dojo.html;3370.8146051967133;3504.8598056077753;3525.788452692837;3595.047312462197;3596.0829988352966;5686.943130568693;5720.856978575538;5758.827235182946;5765.308163020438;5791.768329266824;5631.267935168433;5781.479666829984;5790.623609465392;5822.4177582241755;5839.065749480084;5163.974180129113;5195.402528709209;5210.583153347742;5284.762185701653;5311.1502159654465;5256.290400795901;5269.209618557209;5284.735763211843;5285.233641122035;5292.761825717852;5087.440381558025;5090.1855703087695;5117.283580298761;5203.19350500673;5212.400573933989;4231.344141658048;4249.766262855542;4344.608985191317;5188.429272779991;5261.158214685632;4339.305711086211;5061.5950723942;5153.201253805666;5167.560757335631;5183.45573714762;5338.092524270884;5437;5438.320209973754;5477.014137455257;5490.670559766387;6174.9073763893575;6200;6202.534809889276;6241.87516249677;6246.3441338659695;5742.3396309424115;6127.494965205055;6133.9774042876015;6208.472279856218;6211.3167551569295;4926.975365123151;5751.734618383991;5779.508741756998;5783.508401785811;5798.710064496842;6206.937930620636;6232.470240029557;6248.4376406123665;6258.499320054385;6262.2172228471445;5584.944150558524;6078.726457309432;6081.209442772411;6085.421884920926;6112.837854638568;6085.421884920926;6109.192117492145;6115.088229002436;6144.433169541828;6192.442680158807;6035.8792824143275;6066.3630318815885;6108.267007959073;6108.5418593605655;6119;6099.664518451439;6104.572679912452;6125.111858780452;6128.142060111588;6131.785387511416;4282.828686852553;4951.8266860659705;4954.133026720309;4962.429320628102;4973.850784476472;4223.68322375823;4406.162829062468;4419.204543182258;4421.7789110544345;4479.126570318822;4840.927386089212;5666.17840413146;5820.156077368758;5861;5889.941100589025;5428.565714742811;6139.938600614026;6209.875802483925;6212.565120441616;6224.128621992924;5830.854228644318;5878.265216847894;5879.265091863517;5884.6469211847425;5917.792877249276;5318.095923692981;5360.276362690986;5448.972755136199;5467.234587157801;5491.533219676372;6272.498200143978;6285.402886725754;6285.96857015712;6291.811245662638;6298.1812364392335;6135.324535308442;6164.352742961924;6186.412290832363;6190.628562286277;6192.752289908353;5773.451522105393;6089.391060893875;6319.399657032574;6344.651044192429;6384.840378990562;5630.408807075198;5802.83943211351;6151.5386346025125;6161.44546990773;6179.721912514037;6043.939560604514;6116.731440059295;6188.876222475616;6192.411720886508;6196.318404975539;5314.468553144809;6017.819465416044;6101.368489499475;6119.510439164767;6197.566170368031;6166.136740856194;6184.196054512884;6204.5967012144065;6205.069239613914;6206.751729930752;4846.982133751952;5904.3210030847;5918.348981611933;5992.610480318765;6049.455549000611;6074.939250607437;6126.000349031473;6127.647695153045;6135.906433916094;6207.441330280297;6032.426919442646;6032.577719559588;6033.487153591994;6062.939370606237;6066 02:58:05 INFO - PROCESS | 1666 | |1;ext.html;522.8862522826379;574.7413165168281;577.4831525784423;591.3820058039348;647.5984889368592;30454;31171;36473;37196.8840934772;37334.62665373349;38486.230275394475;38884.805575972154;38895.611043889556;38948.80525597375;39096.413553796716;9308.58111384986;9442.244620430383;9546.331756776994;9551.85672214914;9562.330636855422;9395.154436100749;9634.421934683907;9647.131758141766;9657.95171024144;9666.323357364987;9500;9607.4715890626;9638.710838674851;9660.75848103796;9686.903130968705;9431.151196392357;9435.433873967584;9540.904590954106;9624.422534647943;9625.374350667184;9428.622855085858;9470.52647367629;9513.191378732816;9597.184239339664;9599.4720290384;32075.6792432075;38484.80757596222;38812.41781373282;38832.80583597064;38961.02597435058;3064.9540256896166;3114.377124575094;3151.5115157150676;3158.2262345725217;3345.46472564391;28811.56782648262;29034.854825725946;29117.126486205238;29524.557131643043;29559.408811823858;2730.3720144366907;2773.778097752195;2774.3981490715496;2788.9860550697117;3005.6393232811984;672815;708352;718790.4060479717;721565;727627;70797.2920270801;71552;72355;72418.63790681119;72474.63762681259;76428;76613;77107.22892771;77572.56992010504;77969.22030779732;16696.666066678597;16822.158892055348;17029.063401512787;17036.744448833277;17057.829421705872;12346.75306493883;12403.077522983953;12717.55488557896;12727;12856.292903890377;22182.88908555479;22448.765317907673;22716.545669086856;22879.31362059141;23196.956136973877;10001.899981000097;10260;10260.076593106656;10263.794724105475;10314.948425257975;906.3323484788021;934.5654270764128;984.522506584306;1092.3609688332256;1152.8213126965334;29194;29248.853755731085;29449.55825662617;29708.69932013334;29908.55137172944;896.614455784006;1035.9378437293788;1059.369675043348;1059.8516207730925;1107.5514416661265;11143.2199746017;13103.541376051793;14064.85935140656;14774.113553186844;15145.469908553368;527860.360698194;535816.6418335767;537474;539341;541063.294683524;56582.43417565772;57268.71365643145;58096.547586310684;58201.70899145477;58454;1272.6754677557165;1375.6835927736677;1418.865207805257;1422.679897023182;1430.7281616492833;26169.345766355993;28949.855250723613;29259.41481170407;29442.558361624164;29643.40713185767;50284.49715502798;50851.72870678115;50920.49079509157;51306;51472.74263628658;417624;418825;419641;511248;511421;33399;33791.831040845624;33828.66171338255;34252.828735856165;34292.65707342895;44613.33080003737;44716.55283447124;44873.32690009718;45324.54675453335;46043.539564603925;37082.443763343035;37176.07059823526;37214.44178337273;37709.4343584841;37741;36144.243278942384;36155.553777849644;36251.637483625884;36656.81671591732;37162.62837371592;36194.81902590575;36809;36864.44703329506;36898.44652330164;36990.89027329184;31905.361892762478;32665.673343267215;32718.672813272515;32767.344653106327;32769.50845737268;24441.51116977615;25096.24711258665;25205.369865753502;25260.989560417376;25542 02:58:05 INFO - PROCESS | 1666 | |2;jquery.html;348.8674303764569;355.94660800879865;356.6362310443348;363.4022033754474;365.2439450337798;18838.71741923872;18865.05674716264;19830.40508784735;19869.907155106463;20225.292114775984;18925.810741892576;19444;19776.505587360323;19780.01099945004;19790.10944507497;5727.42725727427;5989.700514974255;6055.636661800284;6066.848328791772;6089.756409743605;4261.488621365425;5948.940510594882;6326.715297811586;6586.506012049115;6612.966935165317;6523.641199734013;6525.119108920282;6530.869382612369;6531.183602049744;6543.411093001629;5370.570354371661;5593.105103183491;5603.803866864681;5647.29408823897;5650.124230744221;5267.26258323835;5300.602454815904;5302.655327403706;5404.83785486436;5421.72589441481;12924.806127908088;13069.215847049112;13093.86906130936;14550.563483095524;23437.593744375223;1790.970192139512;2030.127045370505;2282.7460619147596;2689.843367352038;2755.6968733439307;9539.236861051098;9553.379030363005;9693.22454203662;9887.752806179904;9935;1647.9176041198011;1730.4289584437106;1771.4774141628122;1779.7063484525038;1948.3570421760785;104235;106915;108654;110011.34982975342;114287;9957.004299569984;10483.580656773644;10891.18316126278;11297.096232301396;11397.544098236143;13419.329033548283;13583.864161358457;13619.250941198132;13645.727085458235;13680.179189248676;8371.916280837235;8512.74461766148;8565.48607083577;8579.656813727506;8633.870491942625;8535.445196062235;8648.135186481302;8687.131286871263;8752.081031491602;8773.912260877309;4406.361077643724;4446.510883802779;4483.991102002089;4507.940633951019;4513;1776.0764402510622;1830.7387095330746;1863.4782260966952;1920.7118932160288;1922.3656193456407;846.399056669759;916.9403988740711;920.0431551186824;943.8253923024263;970.9854352184723;17202.1398930053;17443.476695699148;19435.805641943683;19563.119659615353;20408.510042829857;906.1165363770272;925.5973651461636;960.2174228004154;966.2608104799833;993.4337427666161;10374.93939287912;10654.680359589225;10703.250772445854;10772.892271077346;10948.288361256493;543616;544199;561641;591102;678906.2109378942;108453;123482;126519.36740316423;127279.3636031814;131292;1029.1869423155624;1040.958361665525;1061;1062.5218651606654;1063.6649455421518;17077.829221707623;18011.459656210336;18011.72982405239;18269.17788699485;18562.628747424707;51731.224031638805;52351.69120772011;52574.15990440316;53005.46994530159;53213;67755.66122169358;70112.64943675249;70936.29063709504;71516.5696686053;72392;6843;7281.526700764433;7892.763217103496;8263.173682631688;8280.58597070156;10785.86748391439;12805.87194128084;12983;13109.951203903856;13244.139130956457;9985.201183905125;10462.21533384984;11563.36401497892;11760.941195293968;11914.285142891455;8997.730068097968;10097.242706797166;11258.774824503627;11310.4910279036;11587.942060289983;11632.302061876315;11639.6508104757;11764.35296058725;11861.822072668745;11992.700182495508;8073;8104.878426823484;8197.672093116209;8216.21945915137;8382.449246889346;8539.871901921351;10033.44816035125;10694.679159625224;11818.881811182122;11844.585439509576 02:58:05 INFO - PROCESS | 1666 | |3;mootools.html;1519.0657745486526;1521.8325984141745;1751.4220307298585;1874.2409324223686;1890.09275547737;7737.690492380298;8382;8460.407771456;8645.221930026288;8674.739757807269;7349.595772232525;8432.578371081438;8453.281471074966;8517.659293628263;8540.231379175873;2348.8825558722124;2377.108584280895;2384.618461046233;2385.0817435287454;2388.713354397466;2109.9344830860396;2350.118705485443;2426.7573242675767;2427.66012758214;2431.489387228684;2407.085307583116;2439.487707581401;2449.938751531217;2465.457599328145;2468.4445999650115;2024.8177664010163;2276.998120826831;2291.2667946257206;2307.3539408965435;2360.8111351092043;2401.7238017627847;2425.4300239443714;2427.041318679112;2441.035790862617;2444.767747064026;7353.816154596125;8580.570971451403;8590.398672092955;8638.265747411477;8672.306215502807;5256.605754568384;5348.652337598082;5376.865578360533;5401.378841433247;5442.020436321461;3505.5968563615256;3576.159602493412;3604.7656902301264;3620.6560376764164;3643.8178091095338;1006.9345492542961;1023.744063984004;1028.2647906746713;1029.6499190275342;1045.1429827541342;11017;11176.050035746972;11191.216614836965;11241.718957026058;11590.420478976017;4479.686421950498;4539.773011349419;4597.3333866589155;4597.862064138081;4629.421322334708;8922.955385223162;8925;8942.955285223532;8957.283417326598;8972.775680607907;5158.509941555546;5169.25045868347;5203;5205.6356055075785;5213.45258747826;4375.299952007664;4706.505816889246;4829.95170048295;4845.394325709286;4913.361263035854;3278.3115545735664;3595.658412450813;3636.6908812750685;3677.154254521475;3717.7769333840056;1176.670532250971;1177.1112809828526;1180.7874582575048;1181.220394539617;1189.756099999498;1319.4854006937303;1325.1982550556968;1336.6791969927147;1348.2247707567992;1353.0190611806559;7929.20707929214;7965.56189409588;8122.472039317426;8133.75598732039;8140.75577732669;1179.4574495732058;1192.612400969671;1193.2661413230974;1197.9401029948467;1201.6695408762484;5948.910766338508;6178.320384757673;6241.563090583706;6244.937550624527;6248.250209974741;10220.744481387876;10402.375857448576;10428.687139385831;10466.947665261778;10488.160947124212;8883.689070882489;10136.0877521022;10466.267361284788;10499.370037797604;10518.421486818299;6939.271376505495;8064.314533264738;8204.876926845982;8272.958635206785;8279;7545.622718864144;7592.468527203043;7620.542767433972;7636.08366995964;7676.769696909102;9154.130357616015;9322.906770932204;9462.810743785223;9566.521673916415;9589.280803939871;9643.710688679352;9695.418274903528;9834.01659834011;9898.356606820533;9910.752231194278;6296.150019747275;6616.172978377703;6839.794806155824;6863.245043045161;6935.3411425914455;7878.803029924297;7976.880346794686;7987.121416644049;8008.039035315566;8059;7096.645167741489;7198.172210195895;7234.987101805857;7330.853382932418;7332.853342933218;7096.858062838611;7099.183593886769;7181.569105853666;7244.565326080452;7247.528910620793;7310.086239220098;7440.888386674096;7491.587962662106;7522.511036782592;7526;6794.422474089758;6814.965925170342;6826.93173068263;6828.795136145924;6834.658267086526;6779.118714567075;6798.694058767268;6849.623270720158;6857.965710171417;6861.073755043005 02:58:05 INFO - PROCESS | 1666 | |4;prototype.html;326.10972046313566;327.22611024926044;329.2821648805603;333.19200937726026;334.94640857462804;5466.207399927008;5770.682612456313;6840.076589660388;6870.519063665539;7082.185548661905;6898.793036208909;6945.097137372135;6971.965140174305;6975.302469753022;6998.790036298907;4104.897377565555;4425.579569940851;4520.615747661453;4613.815447382118;5053.747312634354;5012.248162775594;5028.7485625718755;5030.622703297249;5038.345015148044;5044.621653376012;3620.4207326827714;4432.11357728454;4599.8390056348035;4976.328195693589;4998.77505512251;4094.549599544048;4977.776000079987;4978.178600530926;4989.326440930482;5037.974810125926;4326.6538676905775;4332.895111746516;4334.674899382559;4338.891527711801;4343.9348409773875;6423.389777971085;6624.403803657694;6667.19993600771;6680.1983761948395;6697.196336439659;4676.579107880273;5984.581079324449;6008.879822403527;6017.699115044274;6020.729067191943;5737.483626473596;6545.574537655038;6901.378875901143;7414.518056326321;7434;4870.269459581055;4879.902401951977;4884.340614017134;4885.975570122162;4888.951110488921;7880.133185349607;7881.605919703992;7891.21087891212;7898;7918.6436610352675;4013.819378127991;4724.645651576146;4835.395575553056;4913.778879950411;4919.508049195052;4098.692598055158;4534.956959899242;4998.90002199954;4999.125153098194;5040.6219533534395;5611.270534830446;6003.189569408161;6009.36901625323;6018.909716354171;6033.155358249848;7468.029156209658;7480.401567874557;7500.887486687704;7504.924950750532;7522.134954480195;1663.6173680053655;1711.2898147268745;1749.82501749824;1764.1091248919213;1777.3956854669475;1012.8936461671566;1122.792283427552;1129.5425352732157;1139.3505701749923;1155.0817100405197;6942.479314051467;6943;6967.338102880219;6973.686184121625;7078.504504684623;7660;7672.232776722395;7676.424268179909;7697.461177717506;7718.652660630285;5703.54371650267;6954.965225173842;6959.234484206733;6972.79081627552;6976.965115174392;3281.6226133994896;3726.9440958385644;3801.923961520754;4027.7381970171846;4067.1458993611673;8011.719589814328;8072.4349295548745;8102;8123.9593802031795;8149.940507734075;8083.514989100673;8106.756797296091;8111.432199745961;8113.391495637851;8144.470609410369;8203.26170644621;8213.79465513355;8218.178182181735;8221.136780638066;8232.711855085043;6255.655938923403;6309.873802524015;7396.6671499783715;7751.7674469766;7818.218178182136;7615.162332143571;7670.194629564038;7671.578063206577;7675.2324767522805;7694.230576942261;8154;8190.058143313595;8196.262336389753;8204;8216.671333146845;4564.77176141185;5003.449620541664;5015.322931404214;5022.547970682656;5038.722870242025;6402.967985160044;7455.664495097625;7734.381249499914;7736.574488403192;7766.106897706836;7459.738909138371;7479.4764366496;7490.292305308907;7523.699052037857;7525.774226773206;7483.92516074854;7491.138519070377;7505.8498830022;7514.098308202832;7520.210377910459;7090.149182098181;7294.343509084208;7311.524750891175;7311.744088956861;7319.121705395387;6023.939760602338;7425;7455.329020388191;7480.251974802476;7501.887471688038;6150.708351246289;7109.289071093056;7314.597697126496;7314.634268286671;7322 02:58:05 INFO - PROCESS | 1666 | |5;yui.html;599.8710277290385;675.2538445018255;682.3313153109953;707.2008630247819;723.4429489293248;14650;14795.556133315991;15021.774673379909;15033.022853514527;15040.0223985441;13498.797518037238;13690.247036412993;13696.041277110606;13710.177389356646;13728.176309421417;720.5280541245493;854.6453221912899;859.716293623106;864.148813418782;888.693400776731;847.4872702015284;871.3682580129419;886.5655828643951;889.208604342136;889.5107690770051;898.4833720610642;936.5317341329335;937.610891480035;942.0767647705253;943.056943056943;893.3657103456553;914.6890057380456;915.9633614655406;935.7052528453515;936.2556767369957;653.9869202615969;655.2006552006544;676.2966514824576;677.9932200678029;691.8547105107933;14832.406703731838;14832.480863169738;15095.773563396559;15158.696826063417;15190.316435760416;12437.253764774143;12574.371281435891;12620.936895315557;12746.80879786804;12850.293233872133;8226.670933162666;9719.17387022104;9845.90154098457;9848.162906152986;10124.088832005154;3453.2748122894222;3489.616142224353;3492.877749278763;3494.6680065394003;3494.755367124302;78046;78150;79486.20513794904;82066;82086.76869846958;8039.758807235792;9198.494082825375;9234.630614775333;9318.301127415336;9459.38513996588;18419.355322563915;20657.483562910747;21149.57700846005;21234.469138271357;21273.255436059662;7400.740974065882;7461.440391970624;7483.32650061497;7488.438367122379;7608.80977975544;3982.78094704794;3988.720789544704;4056.3104272273786;4066.9796651016554;4080.10237747695;3198.2425498859297;3205.230744621321;3233.272513684449;3252.609686837595;3252.756043296762;490.6099650777569;576.1012820000813;584.7573257098342;589.9616524925866;598.5152026858259;463.7426228443246;542.6662602499513;554.7309554865886;582.7348556406824;583.4311546242379;7788.221177882167;7879.448438609243;7964.323032542183;8024.117347091816;8164.836703265902;506.97465126744254;524.3262407805951;559.7760895641694;588.5791658963776;595.428388746808;3079.9538006929915;3710.9072273192846;3785.9967108716214;3853.899624704543;3855.306044911943;80372.3925521498;82037;82389;82864.17135828685;83941.16058839456;56505;70845.2915470849;74299.62850185715;74486.62756686182;75651;50651.7467412668;68376.6581167101;68385.97421038688;68704.3129568708;68880.96678549825;7373.18894921569;7406.7037318506655;7463.402927765875;7479.84062470318;7649.923500765144;47204;47672.76163619159;49248.50751492583;49485.50514494809;49744.50766477011;48607.75696121497;57932;64681.35318646753;65571.67214163899;66896.6655166721;8688;9209.125133112344;9549.331546791658;10132.986701329808;11158.274712143684;9740;11744.17790754639;11953.760924781629;11993;12172.208806427554;10521;10547.050765431148;10661.786764264827;10728.463576821285;10997.99774435695;9587.90412095898;10750.51622676997;10919.890801091888;10944.726381840199;11316.490757916079;10926.50830712604;10992.230543861853;11241.156913231376;11273.71815704614;11280.210385272952;8610.78473038179;8710.520921349387;8810.911890881009;8854.203121719076;9204.677836275698;8178.713745018896;8540.658373664985;8635.222829945335;9143.954280228556;9210.355275130676 02:58:05 INFO - PROCESS | 1666 | __end_tp_report 02:58:05 INFO - PROCESS | 1666 | __start_cc_report 02:58:05 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,337 02:58:05 INFO - PROCESS | 1666 | __end_cc_report 02:58:05 INFO - PROCESS | 1666 | __startTimestamp1457089085785__endTimestamp 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | ------- Summary: start ------- 02:58:05 INFO - PROCESS | 1666 | Number of tests: 6 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5674.03 Median:5904.32 stddev:656.70 (11.1%) stddev-sans-first:633.37 02:58:05 INFO - PROCESS | 1666 | Values: 3370.8 3504.9 3525.8 3595.0 3596.1 5686.9 5720.9 5758.8 5765.3 5791.8 5631.3 5781.5 5790.6 5822.4 5839.1 5164.0 5195.4 5210.6 5284.8 5311.2 5256.3 5269.2 5284.7 5285.2 5292.8 5087.4 5090.2 5117.3 5203.2 5212.4 4231.3 4249.8 4344.6 5188.4 5261.2 4339.3 5061.6 5153.2 5167.6 5183.5 5338.1 5437.0 5438.3 5477.0 5490.7 6174.9 6200.0 6202.5 6241.9 6246.3 5742.3 6127.5 6134.0 6208.5 6211.3 4927.0 5751.7 5779.5 5783.5 5798.7 6206.9 6232.5 6248.4 6258.5 6262.2 5584.9 6078.7 6081.2 6085.4 6112.8 6085.4 6109.2 6115.1 6144.4 6192.4 6035.9 6066.4 6108.3 6108.5 6119.0 6099.7 6104.6 6125.1 6128.1 6131.8 4282.8 4951.8 4954.1 4962.4 4973.9 4223.7 4406.2 4419.2 4421.8 4479.1 4840.9 5666.2 5820.2 5861.0 5889.9 5428.6 6139.9 6209.9 6212.6 6224.1 5830.9 5878.3 5879.3 5884.6 5917.8 5318.1 5360.3 5449.0 5467.2 5491.5 6272.5 6285.4 6286.0 6291.8 6298.2 6135.3 6164.4 6186.4 6190.6 6192.8 5773.5 6089.4 6319.4 6344.7 6384.8 5630.4 5802.8 6151.5 6161.4 6179.7 6043.9 6116.7 6188.9 6192.4 6196.3 5314.5 6017.8 6101.4 6119.5 6197.6 6166.1 6184.2 6204.6 6205.1 6206.8 4847.0 5904.3 5918.3 5992.6 6049.5 6074.9 6126.0 6127.6 6135.9 6207.4 6032.4 6032.6 6033.5 6062.9 6066.0 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:70528.20 Median:37169.35 stddev:154720.66 (416.3%) stddev-sans-first:155065.42 02:58:05 INFO - PROCESS | 1666 | Values: 522.9 574.7 577.5 591.4 647.6 30454.0 31171.0 36473.0 37196.9 37334.6 38486.2 38884.8 38895.6 38948.8 39096.4 9308.6 9442.2 9546.3 9551.9 9562.3 9395.2 9634.4 9647.1 9658.0 9666.3 9500.0 9607.5 9638.7 9660.8 9686.9 9431.2 9435.4 9540.9 9624.4 9625.4 9428.6 9470.5 9513.2 9597.2 9599.5 32075.7 38484.8 38812.4 38832.8 38961.0 3065.0 3114.4 3151.5 3158.2 3345.5 28811.6 29034.9 29117.1 29524.6 29559.4 2730.4 2773.8 2774.4 2789.0 3005.6 672815.0 708352.0 718790.4 721565.0 727627.0 70797.3 71552.0 72355.0 72418.6 72474.6 76428.0 76613.0 77107.2 77572.6 77969.2 16696.7 16822.2 17029.1 17036.7 17057.8 12346.8 12403.1 12717.6 12727.0 12856.3 22182.9 22448.8 22716.5 22879.3 23197.0 10001.9 10260.0 10260.1 10263.8 10314.9 906.3 934.6 984.5 1092.4 1152.8 29194.0 29248.9 29449.6 29708.7 29908.6 896.6 1035.9 1059.4 1059.9 1107.6 11143.2 13103.5 14064.9 14774.1 15145.5 527860.4 535816.6 537474.0 539341.0 541063.3 56582.4 57268.7 58096.5 58201.7 58454.0 1272.7 1375.7 1418.9 1422.7 1430.7 26169.3 28949.9 29259.4 29442.6 29643.4 50284.5 50851.7 50920.5 51306.0 51472.7 417624.0 418825.0 419641.0 511248.0 511421.0 33399.0 33791.8 33828.7 34252.8 34292.7 44613.3 44716.6 44873.3 45324.5 46043.5 37082.4 37176.1 37214.4 37709.4 37741.0 36144.2 36155.6 36251.6 36656.8 37162.6 36194.8 36809.0 36864.4 36898.4 36990.9 31905.4 32665.7 32718.7 32767.3 32769.5 24441.5 25096.2 25205.4 25261.0 25542.0 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33562.72 Median:1552.28 stddev:97620.09 (6288.8%) stddev-sans-first:97862.08 02:58:05 INFO - PROCESS | 1666 | Values: 348.9 355.9 356.6 363.4 365.2 18838.7 18865.1 19830.4 19869.9 20225.3 18925.8 19444.0 19776.5 19780.0 19790.1 5727.4 5989.7 6055.6 6066.8 6089.8 4261.5 5948.9 6326.7 6586.5 6613.0 6523.6 6525.1 6530.9 6531.2 6543.4 5370.6 5593.1 5603.8 5647.3 5650.1 5267.3 5300.6 5302.7 5404.8 5421.7 12924.8 13069.2 13093.9 14550.6 23437.6 1791.0 2030.1 2282.7 2689.8 2755.7 9539.2 9553.4 9693.2 9887.8 9935.0 1647.9 1730.4 1771.5 1779.7 1948.4 104235.0 106915.0 108654.0 110011.3 114287.0 9957.0 10483.6 10891.2 11297.1 11397.5 13419.3 13583.9 13619.3 13645.7 13680.2 8371.9 8512.7 8565.5 8579.7 8633.9 8535.4 8648.1 8687.1 8752.1 8773.9 4406.4 4446.5 4484.0 4507.9 4513.0 1776.1 1830.7 1863.5 1920.7 1922.4 846.4 916.9 920.0 943.8 971.0 17202.1 17443.5 19435.8 19563.1 20408.5 906.1 925.6 960.2 966.3 993.4 10374.9 10654.7 10703.3 10772.9 10948.3 543616.0 544199.0 561641.0 591102.0 678906.2 108453.0 123482.0 126519.4 127279.4 131292.0 1029.2 1041.0 1061.0 1062.5 1063.7 17077.8 18011.5 18011.7 18269.2 18562.6 51731.2 52351.7 52574.2 53005.5 53213.0 67755.7 70112.6 70936.3 71516.6 72392.0 6843.0 7281.5 7892.8 8263.2 8280.6 10785.9 12805.9 12983.0 13110.0 13244.1 9985.2 10462.2 11563.4 11760.9 11914.3 8997.7 10097.2 11258.8 11310.5 11587.9 11632.3 11639.7 11764.4 11861.8 11992.7 8073.0 8104.9 8197.7 8216.2 8382.4 8539.9 10033.4 10694.7 11818.9 11844.6 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5840.30 Median:5362.76 stddev:3038.05 (56.7%) stddev-sans-first:3029.21 02:58:05 INFO - PROCESS | 1666 | Values: 1519.1 1521.8 1751.4 1874.2 1890.1 7737.7 8382.0 8460.4 8645.2 8674.7 7349.6 8432.6 8453.3 8517.7 8540.2 2348.9 2377.1 2384.6 2385.1 2388.7 2109.9 2350.1 2426.8 2427.7 2431.5 2407.1 2439.5 2449.9 2465.5 2468.4 2024.8 2277.0 2291.3 2307.4 2360.8 2401.7 2425.4 2427.0 2441.0 2444.8 7353.8 8580.6 8590.4 8638.3 8672.3 5256.6 5348.7 5376.9 5401.4 5442.0 3505.6 3576.2 3604.8 3620.7 3643.8 1006.9 1023.7 1028.3 1029.6 1045.1 11017.0 11176.1 11191.2 11241.7 11590.4 4479.7 4539.8 4597.3 4597.9 4629.4 8923.0 8925.0 8943.0 8957.3 8972.8 5158.5 5169.3 5203.0 5205.6 5213.5 4375.3 4706.5 4830.0 4845.4 4913.4 3278.3 3595.7 3636.7 3677.2 3717.8 1176.7 1177.1 1180.8 1181.2 1189.8 1319.5 1325.2 1336.7 1348.2 1353.0 7929.2 7965.6 8122.5 8133.8 8140.8 1179.5 1192.6 1193.3 1197.9 1201.7 5948.9 6178.3 6241.6 6244.9 6248.3 10220.7 10402.4 10428.7 10466.9 10488.2 8883.7 10136.1 10466.3 10499.4 10518.4 6939.3 8064.3 8204.9 8273.0 8279.0 7545.6 7592.5 7620.5 7636.1 7676.8 9154.1 9322.9 9462.8 9566.5 9589.3 9643.7 9695.4 9834.0 9898.4 9910.8 6296.2 6616.2 6839.8 6863.2 6935.3 7878.8 7976.9 7987.1 8008.0 8059.0 7096.6 7198.2 7235.0 7330.9 7332.9 7096.9 7099.2 7181.6 7244.6 7247.5 7310.1 7440.9 7491.6 7522.5 7526.0 6794.4 6815.0 6826.9 6828.8 6834.7 6779.1 6798.7 6849.6 6858.0 6861.1 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5998.81 Median:6855.30 stddev:2000.86 (29.2%) stddev-sans-first:1960.65 02:58:05 INFO - PROCESS | 1666 | Values: 326.1 327.2 329.3 333.2 334.9 5466.2 5770.7 6840.1 6870.5 7082.2 6898.8 6945.1 6972.0 6975.3 6998.8 4104.9 4425.6 4520.6 4613.8 5053.7 5012.2 5028.7 5030.6 5038.3 5044.6 3620.4 4432.1 4599.8 4976.3 4998.8 4094.5 4977.8 4978.2 4989.3 5038.0 4326.7 4332.9 4334.7 4338.9 4343.9 6423.4 6624.4 6667.2 6680.2 6697.2 4676.6 5984.6 6008.9 6017.7 6020.7 5737.5 6545.6 6901.4 7414.5 7434.0 4870.3 4879.9 4884.3 4886.0 4889.0 7880.1 7881.6 7891.2 7898.0 7918.6 4013.8 4724.6 4835.4 4913.8 4919.5 4098.7 4535.0 4998.9 4999.1 5040.6 5611.3 6003.2 6009.4 6018.9 6033.2 7468.0 7480.4 7500.9 7504.9 7522.1 1663.6 1711.3 1749.8 1764.1 1777.4 1012.9 1122.8 1129.5 1139.4 1155.1 6942.5 6943.0 6967.3 6973.7 7078.5 7660.0 7672.2 7676.4 7697.5 7718.7 5703.5 6955.0 6959.2 6972.8 6977.0 3281.6 3726.9 3801.9 4027.7 4067.1 8011.7 8072.4 8102.0 8124.0 8149.9 8083.5 8106.8 8111.4 8113.4 8144.5 8203.3 8213.8 8218.2 8221.1 8232.7 6255.7 6309.9 7396.7 7751.8 7818.2 7615.2 7670.2 7671.6 7675.2 7694.2 8154.0 8190.1 8196.3 8204.0 8216.7 4564.8 5003.4 5015.3 5022.5 5038.7 6403.0 7455.7 7734.4 7736.6 7766.1 7459.7 7479.5 7490.3 7523.7 7525.8 7483.9 7491.1 7505.8 7514.1 7520.2 7090.1 7294.3 7311.5 7311.7 7319.1 6023.9 7425.0 7455.3 7480.3 7501.9 6150.7 7109.3 7314.6 7314.6 7322.0 02:58:05 INFO - PROCESS | 1666 | 02:58:05 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17159.61 Median:32640.61 stddev:23824.54 (73.0%) stddev-sans-first:23858.93 02:58:05 INFO - PROCESS | 1666 | Values: 599.9 675.3 682.3 707.2 723.4 14650.0 14795.6 15021.8 15033.0 15040.0 13498.8 13690.2 13696.0 13710.2 13728.2 720.5 854.6 859.7 864.1 888.7 847.5 871.4 886.6 889.2 889.5 898.5 936.5 937.6 942.1 943.1 893.4 914.7 916.0 935.7 936.3 654.0 655.2 676.3 678.0 691.9 14832.4 14832.5 15095.8 15158.7 15190.3 12437.3 12574.4 12620.9 12746.8 12850.3 8226.7 9719.2 9845.9 9848.2 10124.1 3453.3 3489.6 3492.9 3494.7 3494.8 78046.0 78150.0 79486.2 82066.0 82086.8 8039.8 9198.5 9234.6 9318.3 9459.4 18419.4 20657.5 21149.6 21234.5 21273.3 7400.7 7461.4 7483.3 7488.4 7608.8 3982.8 3988.7 4056.3 4067.0 4080.1 3198.2 3205.2 3233.3 3252.6 3252.8 490.6 576.1 584.8 590.0 598.5 463.7 542.7 554.7 582.7 583.4 7788.2 7879.4 7964.3 8024.1 8164.8 507.0 524.3 559.8 588.6 595.4 3080.0 3710.9 3786.0 3853.9 3855.3 80372.4 82037.0 82389.0 82864.2 83941.2 56505.0 70845.3 74299.6 74486.6 75651.0 50651.7 68376.7 68386.0 68704.3 68881.0 7373.2 7406.7 7463.4 7479.8 7649.9 47204.0 47672.8 49248.5 49485.5 49744.5 48607.8 57932.0 64681.4 65571.7 66896.7 8688.0 9209.1 9549.3 10133.0 11158.3 9740.0 11744.2 11953.8 11993.0 12172.2 10521.0 10547.1 10661.8 10728.5 10998.0 9587.9 10750.5 10919.9 10944.7 11316.5 10926.5 10992.2 11241.2 11273.7 11280.2 8610.8 8710.5 8810.9 8854.2 9204.7 8178.7 8540.7 8635.2 9144.0 9210.4 02:58:05 INFO - PROCESS | 1666 | -------- Summary: end -------- 02:58:05 INFO - PROCESS | 1666 | 02:58:06 INFO - TEST-INFO | 1666: exit 0 02:58:06 INFO - TEST-OK | dromaeo_css | took 1111504ms 02:58:06 INFO - TEST-START | kraken 02:58:06 INFO - operating with platform_type : mac_ 02:58:06 INFO - Initialising browser for kraken test... 02:58:06 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpjeVdBa/profile http://localhost:49270/getInfo.html) 02:58:09 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 02:58:09 INFO - PROCESS | 1678 | colorDepth:24 02:58:09 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 02:58:09 INFO - PROCESS | 1678 | __metrics 02:58:09 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:58:09 INFO - TEST-INFO | 1678: exit 0 02:58:09 INFO - Browser initialized. 02:58:09 INFO - Running cycle 1/1 for kraken test... 02:58:09 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpjeVdBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:21 INFO - PROCESS | 1681 | RSS: Main: 254132224 02:58:21 INFO - PROCESS | 1681 | 02:58:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:25 INFO - PROCESS | 1681 | RSS: Main: 269111296 02:58:25 INFO - PROCESS | 1681 | 02:58:27 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 02:58:28 INFO - PROCESS | 1681 | RSS: Main: 276393984 02:58:28 INFO - PROCESS | 1681 | 02:58:32 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 02:58:32 INFO - PROCESS | 1681 | RSS: Main: 279760896 02:58:32 INFO - PROCESS | 1681 | 02:58:34 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 02:58:35 INFO - PROCESS | 1681 | RSS: Main: 282599424 02:58:35 INFO - PROCESS | 1681 | 02:58:37 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:37 INFO - PROCESS | 1681 | RSS: Main: 282460160 02:58:37 INFO - PROCESS | 1681 | 02:58:40 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:41 INFO - PROCESS | 1681 | RSS: Main: 283082752 02:58:41 INFO - PROCESS | 1681 | 02:58:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:44 INFO - PROCESS | 1681 | RSS: Main: 283320320 02:58:44 INFO - PROCESS | 1681 | 02:58:47 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 02:58:48 INFO - PROCESS | 1681 | RSS: Main: 283230208 02:58:48 INFO - PROCESS | 1681 | 02:58:49 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:50 INFO - PROCESS | 1681 | RSS: Main: 283758592 02:58:50 INFO - PROCESS | 1681 | 02:58:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:52 INFO - PROCESS | 1681 | RSS: Main: 282173440 02:58:52 INFO - PROCESS | 1681 | 02:58:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:55 INFO - PROCESS | 1681 | RSS: Main: 282419200 02:58:55 INFO - PROCESS | 1681 | 02:58:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:58 INFO - PROCESS | 1681 | RSS: Main: 282480640 02:58:58 INFO - PROCESS | 1681 | 02:59:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:02 INFO - PROCESS | 1681 | RSS: Main: 284667904 02:59:02 INFO - PROCESS | 1681 | 02:59:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 02:59:04 INFO - PROCESS | 1681 | RSS: Main: 284823552 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | __start_tp_report 02:59:04 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 02:59:04 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 02:59:04 INFO - PROCESS | 1681 | |i|pagename|runs| 02:59:04 INFO - PROCESS | 1681 | |0;ai-astar;117;107;115;113;114;124;114;115;115;111 02:59:04 INFO - PROCESS | 1681 | |1;audio-beat-detection;151;131;135;177;156;175;160;151;158;121 02:59:04 INFO - PROCESS | 1681 | |2;audio-dft;196;198;202;210;278;277;264;243;200;203 02:59:04 INFO - PROCESS | 1681 | |3;audio-fft;73;76;73;123;56;58;52;58;105;49 02:59:04 INFO - PROCESS | 1681 | |4;audio-oscillator;83;85;117;78;79;85;106;101;113;141 02:59:04 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;89;88;101;131;121;85;78;127;89;86 02:59:04 INFO - PROCESS | 1681 | |6;imaging-darkroom;97;101;149;95;104;130;95;121;114;96 02:59:04 INFO - PROCESS | 1681 | |7;imaging-desaturate;94;92;90;97;110;144;150;90;90;100 02:59:04 INFO - PROCESS | 1681 | |8;json-parse-financial;57;59;56;59;57;60;58;62;58;63 02:59:04 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;65;67;65;71;70;73;70;68;68;71 02:59:04 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;113;110;115;83;85;86;86;85;85;87 02:59:04 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;124;163;141;136;115;127;122;121;137;134 02:59:04 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;144;142;143;138;141;130;164;181;182;157 02:59:04 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;69;67;67;70;70;68;66;68;70;69 02:59:04 INFO - PROCESS | 1681 | __end_tp_report 02:59:04 INFO - PROCESS | 1681 | __start_cc_report 02:59:04 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,886 02:59:04 INFO - PROCESS | 1681 | __end_cc_report 02:59:04 INFO - PROCESS | 1681 | __startTimestamp1457089144103__endTimestamp 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | ------- Summary: start ------- 02:59:04 INFO - PROCESS | 1681 | Number of tests: 14 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:4.33 (3.8%) stddev-sans-first:4.49 02:59:04 INFO - PROCESS | 1681 | Values: 117.0 107.0 115.0 113.0 114.0 124.0 114.0 115.0 115.0 111.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.00 stddev:18.14 (11.6%) stddev-sans-first:19.24 02:59:04 INFO - PROCESS | 1681 | Values: 151.0 131.0 135.0 177.0 156.0 175.0 160.0 151.0 158.0 121.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:227.10 Median:226.50 stddev:34.56 (15.3%) stddev-sans-first:34.77 02:59:04 INFO - PROCESS | 1681 | Values: 196.0 198.0 202.0 210.0 278.0 277.0 264.0 243.0 200.0 203.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:72.30 Median:58.00 stddev:24.23 (41.8%) stddev-sans-first:25.70 02:59:04 INFO - PROCESS | 1681 | Values: 73.0 76.0 73.0 123.0 56.0 58.0 52.0 58.0 105.0 49.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:78.50 stddev:20.62 (26.3%) stddev-sans-first:21.06 02:59:04 INFO - PROCESS | 1681 | Values: 83.0 85.0 117.0 78.0 79.0 85.0 106.0 101.0 113.0 141.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:85.50 stddev:19.50 (22.8%) stddev-sans-first:20.30 02:59:04 INFO - PROCESS | 1681 | Values: 89.0 88.0 101.0 131.0 121.0 85.0 78.0 127.0 89.0 86.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:122.00 stddev:18.23 (14.9%) stddev-sans-first:18.69 02:59:04 INFO - PROCESS | 1681 | Values: 97.0 101.0 149.0 95.0 104.0 130.0 95.0 121.0 114.0 96.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:105.70 Median:90.00 stddev:22.66 (25.2%) stddev-sans-first:23.63 02:59:04 INFO - PROCESS | 1681 | Values: 94.0 92.0 90.0 97.0 110.0 144.0 150.0 90.0 90.0 100.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:2.23 (3.8%) stddev-sans-first:2.26 02:59:04 INFO - PROCESS | 1681 | Values: 57.0 59.0 56.0 59.0 57.0 60.0 58.0 62.0 58.0 63.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:70.00 stddev:2.66 (3.8%) stddev-sans-first:2.44 02:59:04 INFO - PROCESS | 1681 | Values: 65.0 67.0 65.0 71.0 70.0 73.0 70.0 68.0 68.0 71.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:85.00 stddev:13.32 (15.7%) stddev-sans-first:12.11 02:59:04 INFO - PROCESS | 1681 | Values: 113.0 110.0 115.0 83.0 85.0 86.0 86.0 85.0 85.0 87.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:135.00 stddev:13.69 (10.1%) stddev-sans-first:14.21 02:59:04 INFO - PROCESS | 1681 | Values: 124.0 163.0 141.0 136.0 115.0 127.0 122.0 121.0 137.0 134.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:150.50 stddev:18.12 (12.0%) stddev-sans-first:18.98 02:59:04 INFO - PROCESS | 1681 | Values: 144.0 142.0 143.0 138.0 141.0 130.0 164.0 181.0 182.0 157.0 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.50 02:59:04 INFO - PROCESS | 1681 | Values: 69.0 67.0 67.0 70.0 70.0 68.0 66.0 68.0 70.0 69.0 02:59:04 INFO - PROCESS | 1681 | -------- Summary: end -------- 02:59:04 INFO - PROCESS | 1681 | 02:59:04 INFO - TEST-INFO | 1681: exit 0 02:59:04 INFO - TEST-OK | kraken | took 58451ms 02:59:04 INFO - SUITE-END | took 1169s 02:59:05 INFO - Completed test suite (00:19:30) 02:59:05 INFO - Working with test: dromaeo_css 02:59:05 INFO - Generating results file: dromaeo_css 02:59:05 INFO - Working with test: kraken 02:59:05 INFO - Generating results file: kraken 02:59:05 INFO - javascript benchmark 02:59:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:59:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 02:59:05 INFO - process_Request line: dromaeo_css 7485.51 graph.html#tests=[[72,1,61]] 02:59:05 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:59:05 INFO - process_Request line: kraken 1553.40 graph.html#tests=[[232,1,61]] 02:59:05 INFO - RETURN: dromaeo_css: 7485.51 02:59:05 INFO - RETURN: kraken: 1553.40 02:59:05 INFO - javascript benchmark 02:59:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3370.8146051967133, 3504.8598056077753, 3525.788452692837, 3595.047312462197, 3596.0829988352966, 5686.943130568693, 5720.856978575538, 5758.827235182946, 5765.308163020438, 5791.768329266824, 5631.267935168433, 5781.479666829984, 5790.623609465392, 5822.4177582241755, 5839.065749480084, 5163.974180129113, 5195.402528709209, 5210.583153347742, 5284.762185701653, 5311.1502159654465, 5256.290400795901, 5269.209618557209, 5284.735763211843, 5285.233641122035, 5292.761825717852, 5087.440381558025, 5090.1855703087695, 5117.283580298761, 5203.19350500673, 5212.400573933989, 4231.344141658048, 4249.766262855542, 4344.608985191317, 5188.429272779991, 5261.158214685632, 4339.305711086211, 5061.5950723942, 5153.201253805666, 5167.560757335631, 5183.45573714762, 5338.092524270884, 5437.0, 5438.320209973754, 5477.014137455257, 5490.670559766387, 6174.9073763893575, 6200.0, 6202.534809889276, 6241.87516249677, 6246.3441338659695, 5742.3396309424115, 6127.494965205055, 6133.9774042876015, 6208.472279856218, 6211.3167551569295, 4926.975365123151, 5751.734618383991, 5779.508741756998, 5783.508401785811, 5798.710064496842, 6206.937930620636, 6232.470240029557, 6248.4376406123665, 6258.499320054385, 6262.2172228471445, 5584.944150558524, 6078.726457309432, 6081.209442772411, 6085.421884920926, 6112.837854638568, 6085.421884920926, 6109.192117492145, 6115.088229002436, 6144.433169541828, 6192.442680158807, 6035.8792824143275, 6066.3630318815885, 6108.267007959073, 6108.5418593605655, 6119.0, 6099.664518451439, 6104.572679912452, 6125.111858780452, 6128.142060111588, 6131.785387511416, 4282.828686852553, 4951.8266860659705, 4954.133026720309, 4962.429320628102, 4973.850784476472, 4223.68322375823, 4406.162829062468, 4419.204543182258, 4421.7789110544345, 4479.126570318822, 4840.927386089212, 5666.17840413146, 5820.156077368758, 5861.0, 5889.941100589025, 5428.565714742811, 6139.938600614026, 6209.875802483925, 6212.565120441616, 6224.128621992924, 5830.854228644318, 5878.265216847894, 5879.265091863517, 5884.6469211847425, 5917.792877249276, 5318.095923692981, 5360.276362690986, 5448.972755136199, 5467.234587157801, 5491.533219676372, 6272.498200143978, 6285.402886725754, 6285.96857015712, 6291.811245662638, 6298.1812364392335, 6135.324535308442, 6164.352742961924, 6186.412290832363, 6190.628562286277, 6192.752289908353, 5773.451522105393, 6089.391060893875, 6319.399657032574, 6344.651044192429, 6384.840378990562, 5630.408807075198, 5802.83943211351, 6151.5386346025125, 6161.44546990773, 6179.721912514037, 6043.939560604514, 6116.731440059295, 6188.876222475616, 6192.411720886508, 6196.318404975539, 5314.468553144809, 6017.819465416044, 6101.368489499475, 6119.510439164767, 6197.566170368031, 6166.136740856194, 6184.196054512884, 6204.5967012144065, 6205.069239613914, 6206.751729930752, 4846.982133751952, 5904.3210030847, 5918.348981611933, 5992.610480318765, 6049.455549000611, 6074.939250607437, 6126.000349031473, 6127.647695153045, 6135.906433916094, 6207.441330280297, 6032.426919442646, 6032.577719559588, 6033.487153591994, 6062.939370606237, 6066.0], "unit": "score", "name": "dojo.html", "value": 5634.29227475368}, {"lowerIsBetter": false, "replicates": [522.8862522826379, 574.7413165168281, 577.4831525784423, 591.3820058039348, 647.5984889368592, 30454.0, 31171.0, 36473.0, 37196.8840934772, 37334.62665373349, 38486.230275394475, 38884.805575972154, 38895.611043889556, 38948.80525597375, 39096.413553796716, 9308.58111384986, 9442.244620430383, 9546.331756776994, 9551.85672214914, 9562.330636855422, 9395.154436100749, 9634.421934683907, 9647.131758141766, 9657.95171024144, 9666.323357364987, 9500.0, 9607.4715890626, 9638.710838674851, 9660.75848103796, 9686.903130968705, 9431.151196392357, 9435.433873967584, 9540.904590954106, 9624.422534647943, 9625.374350667184, 9428.622855085858, 9470.52647367629, 9513.191378732816, 9597.184239339664, 9599.4720290384, 32075.6792432075, 38484.80757596222, 38812.41781373282, 38832.80583597064, 38961.02597435058, 3064.9540256896166, 3114.377124575094, 3151.5115157150676, 3158.2262345725217, 3345.46472564391, 28811.56782648262, 29034.854825725946, 29117.126486205238, 29524.557131643043, 29559.408811823858, 2730.3720144366907, 2773.778097752195, 2774.3981490715496, 2788.9860550697117, 3005.6393232811984, 672815.0, 708352.0, 718790.4060479717, 721565.0, 727627.0, 70797.2920270801, 71552.0, 72355.0, 72418.63790681119, 72474.63762681259, 76428.0, 76613.0, 77107.22892771, 77572.56992010504, 77969.22030779732, 16696.666066678597, 16822.158892055348, 17029.063401512787, 17036.744448833277, 17057.829421705872, 12346.75306493883, 12403.077522983953, 12717.55488557896, 12727.0, 12856.292903890377, 22182.88908555479, 22448.765317907673, 22716.545669086856, 22879.31362059141, 23196.956136973877, 10001.899981000097, 10260.0, 10260.076593106656, 10263.794724105475, 10314.948425257975, 906.3323484788021, 934.5654270764128, 984.522506584306, 1092.3609688332256, 1152.8213126965334, 29194.0, 29248.853755731085, 29449.55825662617, 29708.69932013334, 29908.55137172944, 896.614455784006, 1035.9378437293788, 1059.369675043348, 1059.8516207730925, 1107.5514416661265, 11143.2199746017, 13103.541376051793, 14064.85935140656, 14774.113553186844, 15145.469908553368, 527860.360698194, 535816.6418335767, 537474.0, 539341.0, 541063.294683524, 56582.43417565772, 57268.71365643145, 58096.547586310684, 58201.70899145477, 58454.0, 1272.6754677557165, 1375.6835927736677, 1418.865207805257, 1422.679897023182, 1430.7281616492833, 26169.345766355993, 28949.855250723613, 29259.41481170407, 29442.558361624164, 29643.40713185767, 50284.49715502798, 50851.72870678115, 50920.49079509157, 51306.0, 51472.74263628658, 417624.0, 418825.0, 419641.0, 511248.0, 511421.0, 33399.0, 33791.831040845624, 33828.66171338255, 34252.828735856165, 34292.65707342895, 44613.33080003737, 44716.55283447124, 44873.32690009718, 45324.54675453335, 46043.539564603925, 37082.443763343035, 37176.07059823526, 37214.44178337273, 37709.4343584841, 37741.0, 36144.243278942384, 36155.553777849644, 36251.637483625884, 36656.81671591732, 37162.62837371592, 36194.81902590575, 36809.0, 36864.44703329506, 36898.44652330164, 36990.89027329184, 31905.361892762478, 32665.673343267215, 32718.672813272515, 32767.344653106327, 32769.50845737268, 24441.51116977615, 25096.24711258665, 25205.369865753502, 25260.989560417376, 25542.0], "unit": "score", "name": "ext.html", "value": 20146.97775590055}, {"lowerIsBetter": false, "replicates": [348.8674303764569, 355.94660800879865, 356.6362310443348, 363.4022033754474, 365.2439450337798, 18838.71741923872, 18865.05674716264, 19830.40508784735, 19869.907155106463, 20225.292114775984, 18925.810741892576, 19444.0, 19776.505587360323, 19780.01099945004, 19790.10944507497, 5727.42725727427, 5989.700514974255, 6055.636661800284, 6066.848328791772, 6089.756409743605, 4261.488621365425, 5948.940510594882, 6326.715297811586, 6586.506012049115, 6612.966935165317, 6523.641199734013, 6525.119108920282, 6530.869382612369, 6531.183602049744, 6543.411093001629, 5370.570354371661, 5593.105103183491, 5603.803866864681, 5647.29408823897, 5650.124230744221, 5267.26258323835, 5300.602454815904, 5302.655327403706, 5404.83785486436, 5421.72589441481, 12924.806127908088, 13069.215847049112, 13093.86906130936, 14550.563483095524, 23437.593744375223, 1790.970192139512, 2030.127045370505, 2282.7460619147596, 2689.843367352038, 2755.6968733439307, 9539.236861051098, 9553.379030363005, 9693.22454203662, 9887.752806179904, 9935.0, 1647.9176041198011, 1730.4289584437106, 1771.4774141628122, 1779.7063484525038, 1948.3570421760785, 104235.0, 106915.0, 108654.0, 110011.34982975342, 114287.0, 9957.004299569984, 10483.580656773644, 10891.18316126278, 11297.096232301396, 11397.544098236143, 13419.329033548283, 13583.864161358457, 13619.250941198132, 13645.727085458235, 13680.179189248676, 8371.916280837235, 8512.74461766148, 8565.48607083577, 8579.656813727506, 8633.870491942625, 8535.445196062235, 8648.135186481302, 8687.131286871263, 8752.081031491602, 8773.912260877309, 4406.361077643724, 4446.510883802779, 4483.991102002089, 4507.940633951019, 4513.0, 1776.0764402510622, 1830.7387095330746, 1863.4782260966952, 1920.7118932160288, 1922.3656193456407, 846.399056669759, 916.9403988740711, 920.0431551186824, 943.8253923024263, 970.9854352184723, 17202.1398930053, 17443.476695699148, 19435.805641943683, 19563.119659615353, 20408.510042829857, 906.1165363770272, 925.5973651461636, 960.2174228004154, 966.2608104799833, 993.4337427666161, 10374.93939287912, 10654.680359589225, 10703.250772445854, 10772.892271077346, 10948.288361256493, 543616.0, 544199.0, 561641.0, 591102.0, 678906.2109378942, 108453.0, 123482.0, 126519.36740316423, 127279.3636031814, 131292.0, 1029.1869423155624, 1040.958361665525, 1061.0, 1062.5218651606654, 1063.6649455421518, 17077.829221707623, 18011.459656210336, 18011.72982405239, 18269.17788699485, 18562.628747424707, 51731.224031638805, 52351.69120772011, 52574.15990440316, 53005.46994530159, 53213.0, 67755.66122169358, 70112.64943675249, 70936.29063709504, 71516.5696686053, 72392.0, 6843.0, 7281.526700764433, 7892.763217103496, 8263.173682631688, 8280.58597070156, 10785.86748391439, 12805.87194128084, 12983.0, 13109.951203903856, 13244.139130956457, 9985.201183905125, 10462.21533384984, 11563.36401497892, 11760.941195293968, 11914.285142891455, 8997.730068097968, 10097.242706797166, 11258.774824503627, 11310.4910279036, 11587.942060289983, 11632.302061876315, 11639.6508104757, 11764.35296058725, 11861.822072668745, 11992.700182495508, 8073.0, 8104.878426823484, 8197.672093116209, 8216.21945915137, 8382.449246889346, 8539.871901921351, 10033.44816035125, 10694.679159625224, 11818.881811182122, 11844.585439509576], "unit": "score", "name": "jquery.html", "value": 9249.152602862643}, {"lowerIsBetter": false, "replicates": [1519.0657745486526, 1521.8325984141745, 1751.4220307298585, 1874.2409324223686, 1890.09275547737, 7737.690492380298, 8382.0, 8460.407771456, 8645.221930026288, 8674.739757807269, 7349.595772232525, 8432.578371081438, 8453.281471074966, 8517.659293628263, 8540.231379175873, 2348.8825558722124, 2377.108584280895, 2384.618461046233, 2385.0817435287454, 2388.713354397466, 2109.9344830860396, 2350.118705485443, 2426.7573242675767, 2427.66012758214, 2431.489387228684, 2407.085307583116, 2439.487707581401, 2449.938751531217, 2465.457599328145, 2468.4445999650115, 2024.8177664010163, 2276.998120826831, 2291.2667946257206, 2307.3539408965435, 2360.8111351092043, 2401.7238017627847, 2425.4300239443714, 2427.041318679112, 2441.035790862617, 2444.767747064026, 7353.816154596125, 8580.570971451403, 8590.398672092955, 8638.265747411477, 8672.306215502807, 5256.605754568384, 5348.652337598082, 5376.865578360533, 5401.378841433247, 5442.020436321461, 3505.5968563615256, 3576.159602493412, 3604.7656902301264, 3620.6560376764164, 3643.8178091095338, 1006.9345492542961, 1023.744063984004, 1028.2647906746713, 1029.6499190275342, 1045.1429827541342, 11017.0, 11176.050035746972, 11191.216614836965, 11241.718957026058, 11590.420478976017, 4479.686421950498, 4539.773011349419, 4597.3333866589155, 4597.862064138081, 4629.421322334708, 8922.955385223162, 8925.0, 8942.955285223532, 8957.283417326598, 8972.775680607907, 5158.509941555546, 5169.25045868347, 5203.0, 5205.6356055075785, 5213.45258747826, 4375.299952007664, 4706.505816889246, 4829.95170048295, 4845.394325709286, 4913.361263035854, 3278.3115545735664, 3595.658412450813, 3636.6908812750685, 3677.154254521475, 3717.7769333840056, 1176.670532250971, 1177.1112809828526, 1180.7874582575048, 1181.220394539617, 1189.756099999498, 1319.4854006937303, 1325.1982550556968, 1336.6791969927147, 1348.2247707567992, 1353.0190611806559, 7929.20707929214, 7965.56189409588, 8122.472039317426, 8133.75598732039, 8140.75577732669, 1179.4574495732058, 1192.612400969671, 1193.2661413230974, 1197.9401029948467, 1201.6695408762484, 5948.910766338508, 6178.320384757673, 6241.563090583706, 6244.937550624527, 6248.250209974741, 10220.744481387876, 10402.375857448576, 10428.687139385831, 10466.947665261778, 10488.160947124212, 8883.689070882489, 10136.0877521022, 10466.267361284788, 10499.370037797604, 10518.421486818299, 6939.271376505495, 8064.314533264738, 8204.876926845982, 8272.958635206785, 8279.0, 7545.622718864144, 7592.468527203043, 7620.542767433972, 7636.08366995964, 7676.769696909102, 9154.130357616015, 9322.906770932204, 9462.810743785223, 9566.521673916415, 9589.280803939871, 9643.710688679352, 9695.418274903528, 9834.01659834011, 9898.356606820533, 9910.752231194278, 6296.150019747275, 6616.172978377703, 6839.794806155824, 6863.245043045161, 6935.3411425914455, 7878.803029924297, 7976.880346794686, 7987.121416644049, 8008.039035315566, 8059.0, 7096.645167741489, 7198.172210195895, 7234.987101805857, 7330.853382932418, 7332.853342933218, 7096.858062838611, 7099.183593886769, 7181.569105853666, 7244.565326080452, 7247.528910620793, 7310.086239220098, 7440.888386674096, 7491.587962662106, 7522.511036782592, 7526.0, 6794.422474089758, 6814.965925170342, 6826.93173068263, 6828.795136145924, 6834.658267086526, 6779.118714567075, 6798.694058767268, 6849.623270720158, 6857.965710171417, 6861.073755043005], "unit": "score", "name": "mootools.html", "value": 4791.966153414712}, {"lowerIsBetter": false, "replicates": [326.10972046313566, 327.22611024926044, 329.2821648805603, 333.19200937726026, 334.94640857462804, 5466.207399927008, 5770.682612456313, 6840.076589660388, 6870.519063665539, 7082.185548661905, 6898.793036208909, 6945.097137372135, 6971.965140174305, 6975.302469753022, 6998.790036298907, 4104.897377565555, 4425.579569940851, 4520.615747661453, 4613.815447382118, 5053.747312634354, 5012.248162775594, 5028.7485625718755, 5030.622703297249, 5038.345015148044, 5044.621653376012, 3620.4207326827714, 4432.11357728454, 4599.8390056348035, 4976.328195693589, 4998.77505512251, 4094.549599544048, 4977.776000079987, 4978.178600530926, 4989.326440930482, 5037.974810125926, 4326.6538676905775, 4332.895111746516, 4334.674899382559, 4338.891527711801, 4343.9348409773875, 6423.389777971085, 6624.403803657694, 6667.19993600771, 6680.1983761948395, 6697.196336439659, 4676.579107880273, 5984.581079324449, 6008.879822403527, 6017.699115044274, 6020.729067191943, 5737.483626473596, 6545.574537655038, 6901.378875901143, 7414.518056326321, 7434.0, 4870.269459581055, 4879.902401951977, 4884.340614017134, 4885.975570122162, 4888.951110488921, 7880.133185349607, 7881.605919703992, 7891.21087891212, 7898.0, 7918.6436610352675, 4013.819378127991, 4724.645651576146, 4835.395575553056, 4913.778879950411, 4919.508049195052, 4098.692598055158, 4534.956959899242, 4998.90002199954, 4999.125153098194, 5040.6219533534395, 5611.270534830446, 6003.189569408161, 6009.36901625323, 6018.909716354171, 6033.155358249848, 7468.029156209658, 7480.401567874557, 7500.887486687704, 7504.924950750532, 7522.134954480195, 1663.6173680053655, 1711.2898147268745, 1749.82501749824, 1764.1091248919213, 1777.3956854669475, 1012.8936461671566, 1122.792283427552, 1129.5425352732157, 1139.3505701749923, 1155.0817100405197, 6942.479314051467, 6943.0, 6967.338102880219, 6973.686184121625, 7078.504504684623, 7660.0, 7672.232776722395, 7676.424268179909, 7697.461177717506, 7718.652660630285, 5703.54371650267, 6954.965225173842, 6959.234484206733, 6972.79081627552, 6976.965115174392, 3281.6226133994896, 3726.9440958385644, 3801.923961520754, 4027.7381970171846, 4067.1458993611673, 8011.719589814328, 8072.4349295548745, 8102.0, 8123.9593802031795, 8149.940507734075, 8083.514989100673, 8106.756797296091, 8111.432199745961, 8113.391495637851, 8144.470609410369, 8203.26170644621, 8213.79465513355, 8218.178182181735, 8221.136780638066, 8232.711855085043, 6255.655938923403, 6309.873802524015, 7396.6671499783715, 7751.7674469766, 7818.218178182136, 7615.162332143571, 7670.194629564038, 7671.578063206577, 7675.2324767522805, 7694.230576942261, 8154.0, 8190.058143313595, 8196.262336389753, 8204.0, 8216.671333146845, 4564.77176141185, 5003.449620541664, 5015.322931404214, 5022.547970682656, 5038.722870242025, 6402.967985160044, 7455.664495097625, 7734.381249499914, 7736.574488403192, 7766.106897706836, 7459.738909138371, 7479.4764366496, 7490.292305308907, 7523.699052037857, 7525.774226773206, 7483.92516074854, 7491.138519070377, 7505.8498830022, 7514.098308202832, 7520.210377910459, 7090.149182098181, 7294.343509084208, 7311.524750891175, 7311.744088956861, 7319.121705395387, 6023.939760602338, 7425.0, 7455.329020388191, 7480.251974802476, 7501.887471688038, 6150.708351246289, 7109.289071093056, 7314.597697126496, 7314.634268286671, 7322.0], "unit": "score", "name": "prototype.html", "value": 5334.267742827455}, {"lowerIsBetter": false, "replicates": [599.8710277290385, 675.2538445018255, 682.3313153109953, 707.2008630247819, 723.4429489293248, 14650.0, 14795.556133315991, 15021.774673379909, 15033.022853514527, 15040.0223985441, 13498.797518037238, 13690.247036412993, 13696.041277110606, 13710.177389356646, 13728.176309421417, 720.5280541245493, 854.6453221912899, 859.716293623106, 864.148813418782, 888.693400776731, 847.4872702015284, 871.3682580129419, 886.5655828643951, 889.208604342136, 889.5107690770051, 898.4833720610642, 936.5317341329335, 937.610891480035, 942.0767647705253, 943.056943056943, 893.3657103456553, 914.6890057380456, 915.9633614655406, 935.7052528453515, 936.2556767369957, 653.9869202615969, 655.2006552006544, 676.2966514824576, 677.9932200678029, 691.8547105107933, 14832.406703731838, 14832.480863169738, 15095.773563396559, 15158.696826063417, 15190.316435760416, 12437.253764774143, 12574.371281435891, 12620.936895315557, 12746.80879786804, 12850.293233872133, 8226.670933162666, 9719.17387022104, 9845.90154098457, 9848.162906152986, 10124.088832005154, 3453.2748122894222, 3489.616142224353, 3492.877749278763, 3494.6680065394003, 3494.755367124302, 78046.0, 78150.0, 79486.20513794904, 82066.0, 82086.76869846958, 8039.758807235792, 9198.494082825375, 9234.630614775333, 9318.301127415336, 9459.38513996588, 18419.355322563915, 20657.483562910747, 21149.57700846005, 21234.469138271357, 21273.255436059662, 7400.740974065882, 7461.440391970624, 7483.32650061497, 7488.438367122379, 7608.80977975544, 3982.78094704794, 3988.720789544704, 4056.3104272273786, 4066.9796651016554, 4080.10237747695, 3198.2425498859297, 3205.230744621321, 3233.272513684449, 3252.609686837595, 3252.756043296762, 490.6099650777569, 576.1012820000813, 584.7573257098342, 589.9616524925866, 598.5152026858259, 463.7426228443246, 542.6662602499513, 554.7309554865886, 582.7348556406824, 583.4311546242379, 7788.221177882167, 7879.448438609243, 7964.323032542183, 8024.117347091816, 8164.836703265902, 506.97465126744254, 524.3262407805951, 559.7760895641694, 588.5791658963776, 595.428388746808, 3079.9538006929915, 3710.9072273192846, 3785.9967108716214, 3853.899624704543, 3855.306044911943, 80372.3925521498, 82037.0, 82389.0, 82864.17135828685, 83941.16058839456, 56505.0, 70845.2915470849, 74299.62850185715, 74486.62756686182, 75651.0, 50651.7467412668, 68376.6581167101, 68385.97421038688, 68704.3129568708, 68880.96678549825, 7373.18894921569, 7406.7037318506655, 7463.402927765875, 7479.84062470318, 7649.923500765144, 47204.0, 47672.76163619159, 49248.50751492583, 49485.50514494809, 49744.50766477011, 48607.75696121497, 57932.0, 64681.35318646753, 65571.67214163899, 66896.6655166721, 8688.0, 9209.125133112344, 9549.331546791658, 10132.986701329808, 11158.274712143684, 9740.0, 11744.17790754639, 11953.760924781629, 11993.0, 12172.208806427554, 10521.0, 10547.050765431148, 10661.786764264827, 10728.463576821285, 10997.99774435695, 9587.90412095898, 10750.51622676997, 10919.890801091888, 10944.726381840199, 11316.490757916079, 10926.50830712604, 10992.230543861853, 11241.156913231376, 11273.71815704614, 11280.210385272952, 8610.78473038179, 8710.520921349387, 8810.911890881009, 8854.203121719076, 9204.677836275698, 8178.713745018896, 8540.658373664985, 8635.222829945335, 9143.954280228556, 9210.355275130676], "unit": "score", "name": "yui.html", "value": 6554.7201817320065}], "name": "dromaeo_css", "value": 7485.513852480884}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 107.0, 115.0, 113.0, 114.0, 124.0, 114.0, 115.0, 115.0, 111.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 135.0, 177.0, 156.0, 175.0, 160.0, 151.0, 158.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [196.0, 198.0, 202.0, 210.0, 278.0, 277.0, 264.0, 243.0, 200.0, 203.0], "unit": "score", "name": "audio-dft", "value": 227.1}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 73.0, 123.0, 56.0, 58.0, 52.0, 58.0, 105.0, 49.0], "unit": "score", "name": "audio-fft", "value": 72.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 117.0, 78.0, 79.0, 85.0, 106.0, 101.0, 113.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 98.8}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 101.0, 131.0, 121.0, 85.0, 78.0, 127.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.5}, {"lowerIsBetter": true, "replicates": [97.0, 101.0, 149.0, 95.0, 104.0, 130.0, 95.0, 121.0, 114.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 110.2}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 90.0, 97.0, 110.0, 144.0, 150.0, 90.0, 90.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 105.7}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 59.0, 57.0, 60.0, 58.0, 62.0, 58.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 71.0, 70.0, 73.0, 70.0, 68.0, 68.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 115.0, 83.0, 85.0, 86.0, 86.0, 85.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.5}, {"lowerIsBetter": true, "replicates": [124.0, 163.0, 141.0, 136.0, 115.0, 127.0, 122.0, 121.0, 137.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.0}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 143.0, 138.0, 141.0, 130.0, 164.0, 181.0, 182.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 70.0, 70.0, 68.0, 66.0, 68.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1553.4}]} 02:59:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1553.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7485.51"}}} 02:59:05 INFO - Return code: 0 02:59:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:59:05 ERROR - # TBPL SUCCESS # 02:59:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:59:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:59:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:59:05 INFO - 2016-03-04 02:59:05.968 screenresolution[1686:10269] starting screenresolution argv=screenresolution get 02:59:05 INFO - 2016-03-04 02:59:05.971 screenresolution[1686:10269] Display 0: 1600x1200x32@60 02:59:05 INFO - 2016-03-04 02:59:05.977 screenresolution[1687:10272] starting screenresolution argv=screenresolution list 02:59:05 INFO - Available Modes on Display 0 02:59:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:59:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:59:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:59:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:59:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:59:06 INFO - Intel Iris: 02:59:06 INFO - Chipset Model: Intel Iris 02:59:06 INFO - Type: GPU 02:59:06 INFO - Bus: Built-In 02:59:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:59:06 INFO - Vendor: Intel (0x8086) 02:59:06 INFO - Device ID: 0x0a2e 02:59:06 INFO - Revision ID: 0x0009 02:59:06 INFO - Displays: 02:59:06 INFO - Display: 02:59:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:59:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:59:06 INFO - Display Serial Number: 1600x1200 60 02:59:06 INFO - Main Display: Yes 02:59:06 INFO - Mirror: Off 02:59:06 INFO - Online: Yes 02:59:06 INFO - Rotation: Supported 02:59:06 INFO - Return code: 0 02:59:06 INFO - Running post-action listener: _resource_record_post_action 02:59:06 INFO - Running post-run listener: _resource_record_post_run 02:59:07 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39306752; Write bytes: 707482624; Read time: 428; Write time: 1945 02:59:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402315776; Write bytes: 404519936; Read time: 30530; Write time: 751 02:59:07 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37357056; Write bytes: 302114816; Read time: 402; Write time: 1192 02:59:07 INFO - Running post-run listener: _upload_blobber_files 02:59:07 INFO - Blob upload gear active. 02:59:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:07 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 02:59:07 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:59:07 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:59:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:08 INFO - (blobuploader) - INFO - Done attempting. 02:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:09 INFO - (blobuploader) - INFO - Done attempting. 02:59:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:09 INFO - Return code: 0 02:59:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e788b4cd4c14c7321bd5651b3da405ea9353c10b600b775280a358fd922e86a3461757199fbdf4a6130b5f9691182a14f053dd10d4188e6eddffb24a3529dbed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8897d2bd81c2076561fa82aa741e41c763a9e300daae06bc24639c996b83a5bb0eea8924508ad42fe8c9f49cacc99d6c43973e3afbf86837c4cce17e8a144b3"} 02:59:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:09 INFO - Contents: 02:59:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e788b4cd4c14c7321bd5651b3da405ea9353c10b600b775280a358fd922e86a3461757199fbdf4a6130b5f9691182a14f053dd10d4188e6eddffb24a3529dbed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8897d2bd81c2076561fa82aa741e41c763a9e300daae06bc24639c996b83a5bb0eea8924508ad42fe8c9f49cacc99d6c43973e3afbf86837c4cce17e8a144b3"} 02:59:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:09 INFO - Copying logs to upload dir... 02:59:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.300556 ========= master_lag: 4.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-04 02:59:14.292092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 02:59:14.295912) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/Firefox/sha512/e788b4cd4c14c7321bd5651b3da405ea9353c10b600b775280a358fd922e86a3461757199fbdf4a6130b5f9691182a14f053dd10d4188e6eddffb24a3529dbed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8897d2bd81c2076561fa82aa741e41c763a9e300daae06bc24639c996b83a5bb0eea8924508ad42fe8c9f49cacc99d6c43973e3afbf86837c4cce17e8a144b3"} build_url:https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010935 build_url: 'https://queue.taskcluster.net/v1/task/DCF7tAZ9RcCazxE4hw_V4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e788b4cd4c14c7321bd5651b3da405ea9353c10b600b775280a358fd922e86a3461757199fbdf4a6130b5f9691182a14f053dd10d4188e6eddffb24a3529dbed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8897d2bd81c2076561fa82aa741e41c763a9e300daae06bc24639c996b83a5bb0eea8924508ad42fe8c9f49cacc99d6c43973e3afbf86837c4cce17e8a144b3"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 02:59:14.362132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:59:14.362469) ========= 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.j5LIX6wsFu/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.yTxsESXzIE/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005180 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 02:59:14.411109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 02:59:14.411414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 02:59:14.411769) ========= ========= Total master_lag: 4.71 =========