builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0018 starttime: 1446383528.26 results: success (0) buildid: 20151101030343 builduid: 34d6cf4fe0cc4a84b5dfeee00cb9cd2a revision: 96377bdbcdf3e444a22aeaa677da696243b00d98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.261427) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.261989) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.262390) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005959 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.334236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.334554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.355180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.355499) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.027251 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.404813) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.405135) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.405557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.405882) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False --2015-11-01 05:12:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.0M=0.001s 2015-11-01 05:12:08 (12.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.618861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.619169) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.041878 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.675159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:08.675537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 96377bdbcdf3e444a22aeaa677da696243b00d98 --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 96377bdbcdf3e444a22aeaa677da696243b00d98 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False 2015-11-01 05:12:08,768 truncating revision to first 12 chars 2015-11-01 05:12:08,768 Setting DEBUG logging. 2015-11-01 05:12:08,768 attempt 1/10 2015-11-01 05:12:08,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/96377bdbcdf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-01 05:12:09,204 unpacking tar archive at: mozilla-central-96377bdbcdf3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:09.403701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:09.404131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:09.417556) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:09.417959) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-01 05:12:09.418401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-01 05:12:09.418701) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False 05:12:09 INFO - MultiFileLogger online at 20151101 05:12:09 in /builds/slave/test 05:12:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:12:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:09 INFO - {'append_to_log': False, 05:12:09 INFO - 'base_work_dir': '/builds/slave/test', 05:12:09 INFO - 'blob_upload_branch': 'Firefox', 05:12:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:09 INFO - 'branch': 'Firefox', 05:12:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:09 INFO - 'config_files': ('talos/mac_config.py',), 05:12:09 INFO - 'default_actions': ('clobber', 05:12:09 INFO - 'read-buildbot-config', 05:12:09 INFO - 'download-and-extract', 05:12:09 INFO - 'populate-webroot', 05:12:09 INFO - 'create-virtualenv', 05:12:09 INFO - 'install', 05:12:09 INFO - 'run-tests'), 05:12:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:09 INFO - 'download_minidump_stackwalk': True, 05:12:09 INFO - 'download_symbols': 'ondemand', 05:12:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:09 INFO - 'installer_path': 'installer.exe', 05:12:09 INFO - 'log_level': 'info', 05:12:09 INFO - 'log_name': 'talos', 05:12:09 INFO - 'log_to_console': True, 05:12:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:12:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:12:09 INFO - 'opt_config_files': (), 05:12:09 INFO - 'pip_index': False, 05:12:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:09 INFO - 'cmd': ('bash', 05:12:09 INFO - '-c', 05:12:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:09 INFO - 'enabled': True, 05:12:09 INFO - 'halt_on_failure': False, 05:12:09 INFO - 'name': 'check_screen_resolution'},), 05:12:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:09 INFO - 'cmd': ('bash', 05:12:09 INFO - '-c', 05:12:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:09 INFO - 'enabled': True, 05:12:09 INFO - 'halt_on_failure': False, 05:12:09 INFO - 'name': 'check_screen_resolution'},), 05:12:09 INFO - 'run_cmd_checks_enabled': True, 05:12:09 INFO - 'sps_profile': False, 05:12:09 INFO - 'sps_profile_interval': 0, 05:12:09 INFO - 'suite': 'dromaeojs', 05:12:09 INFO - 'system_bits': '64', 05:12:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:09 INFO - 'title': 't-yosemite-r5-0018', 05:12:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:09 INFO - 'use_talos_json': True, 05:12:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:09 INFO - 'work_dir': 'build'} 05:12:09 INFO - ##### 05:12:09 INFO - ##### Running clobber step. 05:12:09 INFO - ##### 05:12:09 INFO - Running pre-action listener: _resource_record_pre_action 05:12:09 INFO - Running main action method: clobber 05:12:09 INFO - rmtree: /builds/slave/test/build 05:12:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running read-buildbot-config step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: read_buildbot_config 05:12:12 INFO - Using buildbot properties: 05:12:12 INFO - { 05:12:12 INFO - "properties": { 05:12:12 INFO - "buildnumber": 550, 05:12:12 INFO - "product": "firefox", 05:12:12 INFO - "script_repo_revision": "production", 05:12:12 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:12:12 INFO - "repository": "", 05:12:12 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:12:12 INFO - "buildid": "20151101030343", 05:12:12 INFO - "slavename": "t-yosemite-r5-0018", 05:12:12 INFO - "stage_platform": "macosx64", 05:12:12 INFO - "basedir": "/builds/slave/test", 05:12:12 INFO - "nightly_build": "True", 05:12:12 INFO - "project": "", 05:12:12 INFO - "platform": "yosemite", 05:12:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:12:12 INFO - "slavebuilddir": "test", 05:12:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:12:12 INFO - "branch": "mozilla-central", 05:12:12 INFO - "repo_path": "mozilla-central", 05:12:12 INFO - "pgo_build": "False", 05:12:12 INFO - "builduid": "34d6cf4fe0cc4a84b5dfeee00cb9cd2a", 05:12:12 INFO - "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98" 05:12:12 INFO - }, 05:12:12 INFO - "sourcestamp": { 05:12:12 INFO - "repository": "", 05:12:12 INFO - "hasPatch": false, 05:12:12 INFO - "project": "", 05:12:12 INFO - "branch": "mozilla-central-macosx64-talos", 05:12:12 INFO - "changes": [ 05:12:12 INFO - { 05:12:12 INFO - "category": null, 05:12:12 INFO - "files": [ 05:12:12 INFO - { 05:12:12 INFO - "url": null, 05:12:12 INFO - "name": "https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:12:12 INFO - } 05:12:12 INFO - ], 05:12:12 INFO - "repository": "", 05:12:12 INFO - "rev": "96377bdbcdf3e444a22aeaa677da696243b00d98", 05:12:12 INFO - "who": "sendchange", 05:12:12 INFO - "when": 1446383251, 05:12:12 INFO - "number": 6605989, 05:12:12 INFO - "comments": "", 05:12:12 INFO - "project": "", 05:12:12 INFO - "at": "Sun 01 Nov 2015 05:07:31", 05:12:12 INFO - "branch": "mozilla-central-macosx64-talos", 05:12:12 INFO - "revlink": "", 05:12:12 INFO - "properties": [ 05:12:12 INFO - [ 05:12:12 INFO - "buildid", 05:12:12 INFO - "20151101030343", 05:12:12 INFO - "Change" 05:12:12 INFO - ], 05:12:12 INFO - [ 05:12:12 INFO - "builduid", 05:12:12 INFO - "34d6cf4fe0cc4a84b5dfeee00cb9cd2a", 05:12:12 INFO - "Change" 05:12:12 INFO - ], 05:12:12 INFO - [ 05:12:12 INFO - "nightly_build", 05:12:12 INFO - "True", 05:12:12 INFO - "Change" 05:12:12 INFO - ], 05:12:12 INFO - [ 05:12:12 INFO - "pgo_build", 05:12:12 INFO - "False", 05:12:12 INFO - "Change" 05:12:12 INFO - ] 05:12:12 INFO - ], 05:12:12 INFO - "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98" 05:12:12 INFO - } 05:12:12 INFO - ], 05:12:12 INFO - "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98" 05:12:12 INFO - } 05:12:12 INFO - } 05:12:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running download-and-extract step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: download_and_extract 05:12:12 INFO - mkdir: /builds/slave/test/build/tests 05:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:12 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:12:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/test_packages.json 05:12:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/test_packages.json 05:12:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:12:13 INFO - Downloaded 1149 bytes. 05:12:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:12:13 INFO - Using the following test package requirements: 05:12:13 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:12:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'jsshell-mac.zip'], 05:12:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:12:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:12:13 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:12:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:12:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:13 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:12:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:12:13 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')]} 05:12:13 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:14 INFO - Downloaded 17452721 bytes. 05:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:12:18 INFO - Return code: 0 05:12:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:12:18 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')]} 05:12:18 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:19 INFO - Downloaded 17452721 bytes. 05:12:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:12:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:12:24 INFO - Return code: 0 05:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:24 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:12:26 INFO - Downloaded 11131307 bytes. 05:12:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:12:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:12:26 INFO - Return code: 0 05:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:26 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:12:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:12:26 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:26 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 05:12:26 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 05:12:26 INFO - Server: 10.26.75.40 05:12:26 INFO - Address: 10.26.75.40#53 05:12:26 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 05:12:26 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 05:12:26 INFO - Address: 10.26.48.46 05:12:26 INFO - Return code: 0 05:12:26 INFO - retry: attempt #1 caught exception: 05:12:26 INFO - retry: Failed, sleeping 30 seconds before retrying 05:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #2 05:13:00 INFO - Downloaded 108646172 bytes. 05:13:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:13:00 INFO - mkdir: /builds/slave/test/properties 05:13:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:00 INFO - Contents: 05:13:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:13:00 INFO - Running post-action listener: _resource_record_post_action 05:13:00 INFO - Running post-action listener: set_extra_try_arguments 05:13:00 INFO - ##### 05:13:00 INFO - ##### Running populate-webroot step. 05:13:00 INFO - ##### 05:13:00 INFO - Running pre-action listener: _resource_record_pre_action 05:13:00 INFO - Running main action method: populate_webroot 05:13:00 INFO - Guessing talos json url... 05:13:00 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')]} 05:13:00 INFO - https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:13:00 INFO - Downloaded 99 bytes. 05:13:00 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:13:00 INFO - Contents: 05:13:00 INFO - 20151101030343 05:13:00 INFO - https://hg.mozilla.org/mozilla-central/rev/96377bdbcdf3e444a22aeaa677da696243b00d98 05:13:00 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')]} 05:13:00 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/96377bdbcd/testing/talos/talos.json 05:13:00 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/96377bdbcd/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/96377bdbcd/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:13:01 INFO - Downloaded 4264 bytes. 05:13:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:13:01 INFO - '../fennec_ids.txt'], 05:13:01 INFO - 'tests': ['tcheck2']}, 05:13:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:01 INFO - '--tppagecycles', 05:13:01 INFO - '7'], 05:13:01 INFO - 'tests': ['tsvgm']}}, 05:13:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:13:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:13:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:13:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'tests': ['damp', 'tps']}, 05:13:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['damp', 'tps']}, 05:13:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:13:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:01 INFO - 'other': {'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'other_l64': {'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'other_nol64': {'tests': ['a11yr', 05:13:01 INFO - 'ts_paint', 05:13:01 INFO - 'tpaint', 05:13:01 INFO - 'sessionrestore', 05:13:01 INFO - 'sessionrestore_no_auto_restore']}, 05:13:01 INFO - 'svgr': {'tests': ['tsvgx', 05:13:01 INFO - 'tsvgr_opacity', 05:13:01 INFO - 'tart', 05:13:01 INFO - 'tscrollx', 05:13:01 INFO - 'cart']}, 05:13:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['tsvgx', 05:13:01 INFO - 'tsvgr_opacity', 05:13:01 INFO - 'tart', 05:13:01 INFO - 'tscrollx', 05:13:01 INFO - 'cart']}, 05:13:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'tests': ['tp5o']}, 05:13:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'talos_options': ['--e10s'], 05:13:01 INFO - 'tests': ['tp5o']}, 05:13:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'talos_options': ['--xperf_path', 05:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:01 INFO - 'tests': ['tp5n']}, 05:13:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:01 INFO - 'talos_options': ['--e10s', 05:13:01 INFO - '--xperf_path', 05:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:13:01 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:13:01 INFO - 'tests': ['tp5n']}}, 05:13:01 INFO - 'talos.zip': {'path': '', 05:13:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:01 INFO - Running post-action listener: _resource_record_post_action 05:13:01 INFO - ##### 05:13:01 INFO - ##### Running create-virtualenv step. 05:13:01 INFO - ##### 05:13:01 INFO - Running pre-action listener: _resource_record_pre_action 05:13:01 INFO - Running main action method: create_virtualenv 05:13:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:01 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 05:13:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:01 INFO - Using real prefix '/tools/python27' 05:13:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:06 INFO - Installing pip.................done. 05:13:06 INFO - Return code: 0 05:13:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13:06 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')]} 05:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:06 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')]} 05:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:06 INFO - 'HOME': '/Users/cltbld', 05:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:06 INFO - 'LOGNAME': 'cltbld', 05:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:06 INFO - 'MOZ_NO_REMOTE': '1', 05:13:06 INFO - 'NO_EM_RESTART': '1', 05:13:06 INFO - 'PAGER': '/bin/cat', 05:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:06 INFO - 'PWD': '/builds/slave/test', 05:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:06 INFO - 'SHELL': '/bin/bash', 05:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:06 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:06 INFO - 'USER': 'cltbld', 05:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:06 INFO - 'XPC_FLAGS': '0x0', 05:13:06 INFO - 'XPC_SERVICE_NAME': '0', 05:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:13:07 INFO - Cleaning up... 05:13:07 INFO - Return code: 0 05:13:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:07 INFO - 'HOME': '/Users/cltbld', 05:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:07 INFO - 'LOGNAME': 'cltbld', 05:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:07 INFO - 'MOZ_NO_REMOTE': '1', 05:13:07 INFO - 'NO_EM_RESTART': '1', 05:13:07 INFO - 'PAGER': '/bin/cat', 05:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:07 INFO - 'PWD': '/builds/slave/test', 05:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:07 INFO - 'SHELL': '/bin/bash', 05:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:07 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:07 INFO - 'USER': 'cltbld', 05:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:07 INFO - 'XPC_FLAGS': '0x0', 05:13:07 INFO - 'XPC_SERVICE_NAME': '0', 05:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:07 INFO - Downloading/unpacking psutil>=0.7.1 05:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:13:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:10 INFO - Installing collected packages: psutil 05:13:10 INFO - Running setup.py install for psutil 05:13:10 INFO - building 'psutil._psutil_osx' extension 05:13:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:13:12 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 05:13:12 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 05:13:12 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 05:13:12 INFO - building 'psutil._psutil_posix' extension 05:13:12 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 05:13:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:13:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:13:12 INFO - ^ 05:13:12 INFO - 1 warning generated. 05:13:12 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 05:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:13 INFO - Successfully installed psutil 05:13:13 INFO - Cleaning up... 05:13:13 INFO - Return code: 0 05:13:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:13:13 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')]} 05:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:13 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')]} 05:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:13 INFO - 'HOME': '/Users/cltbld', 05:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:13 INFO - 'LOGNAME': 'cltbld', 05:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:13 INFO - 'MOZ_NO_REMOTE': '1', 05:13:13 INFO - 'NO_EM_RESTART': '1', 05:13:13 INFO - 'PAGER': '/bin/cat', 05:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:13 INFO - 'PWD': '/builds/slave/test', 05:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:13 INFO - 'SHELL': '/bin/bash', 05:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:13 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:13 INFO - 'USER': 'cltbld', 05:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:13 INFO - 'XPC_FLAGS': '0x0', 05:13:13 INFO - 'XPC_SERVICE_NAME': '0', 05:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:13:16 INFO - Installing collected packages: mozsystemmonitor 05:13:16 INFO - Running setup.py install for mozsystemmonitor 05:13:16 INFO - Successfully installed mozsystemmonitor 05:13:16 INFO - Cleaning up... 05:13:16 INFO - Return code: 0 05:13:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13:16 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')]} 05:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:16 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')]} 05:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:16 INFO - 'HOME': '/Users/cltbld', 05:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:16 INFO - 'LOGNAME': 'cltbld', 05:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:16 INFO - 'MOZ_NO_REMOTE': '1', 05:13:16 INFO - 'NO_EM_RESTART': '1', 05:13:16 INFO - 'PAGER': '/bin/cat', 05:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:16 INFO - 'PWD': '/builds/slave/test', 05:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:16 INFO - 'SHELL': '/bin/bash', 05:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:16 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:16 INFO - 'USER': 'cltbld', 05:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:16 INFO - 'XPC_FLAGS': '0x0', 05:13:16 INFO - 'XPC_SERVICE_NAME': '0', 05:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:19 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 05:13:20 INFO - Downloading docopt-0.6.1.tar.gz 05:13:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:20 INFO - Running setup.py install for blobuploader 05:13:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:20 INFO - Running setup.py install for requests 05:13:21 INFO - Running setup.py install for docopt 05:13:21 INFO - Successfully installed blobuploader requests docopt 05:13:21 INFO - Cleaning up... 05:13:21 INFO - Return code: 0 05:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:21 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')]} 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 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')]} 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 05:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:21 INFO - 'HOME': '/Users/cltbld', 05:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:21 INFO - 'LOGNAME': 'cltbld', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PAGER': '/bin/cat', 05:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test', 05:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:21 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - 'XPC_FLAGS': '0x0', 05:13:21 INFO - 'XPC_SERVICE_NAME': '0', 05:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:21 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-9UYRl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-OadYtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-q2n1qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-Lw_ijx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-rZnxWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-PX3OPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-0VELJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-IrnYXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:22 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-sztTZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-uYcwuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ZP3Fom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-J868r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-F6XiX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-We253l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-bFhLbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-1m2lgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:23 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-XZlfIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:24 INFO - Running setup.py install for manifestparser 05:13:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:24 INFO - Running setup.py install for mozcrash 05:13:24 INFO - Running setup.py install for mozdebug 05:13:24 INFO - Running setup.py install for mozdevice 05:13:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:13:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:24 INFO - Running setup.py install for mozfile 05:13:24 INFO - Running setup.py install for mozhttpd 05:13:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Running setup.py install for mozinfo 05:13:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Running setup.py install for mozInstall 05:13:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Running setup.py install for mozleak 05:13:25 INFO - Running setup.py install for mozlog 05:13:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:25 INFO - Running setup.py install for moznetwork 05:13:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:26 INFO - Running setup.py install for mozprocess 05:13:26 INFO - Running setup.py install for mozprofile 05:13:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:26 INFO - Running setup.py install for mozrunner 05:13:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:26 INFO - Running setup.py install for mozscreenshot 05:13:26 INFO - Running setup.py install for moztest 05:13:26 INFO - Running setup.py install for mozversion 05:13:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:27 INFO - Cleaning up... 05:13:27 INFO - Return code: 0 05:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:27 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')]} 05:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:27 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')]} 05:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:27 INFO - 'HOME': '/Users/cltbld', 05:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:27 INFO - 'LOGNAME': 'cltbld', 05:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:27 INFO - 'MOZ_NO_REMOTE': '1', 05:13:27 INFO - 'NO_EM_RESTART': '1', 05:13:27 INFO - 'PAGER': '/bin/cat', 05:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:27 INFO - 'PWD': '/builds/slave/test', 05:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:27 INFO - 'SHELL': '/bin/bash', 05:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:27 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:27 INFO - 'USER': 'cltbld', 05:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:27 INFO - 'XPC_FLAGS': '0x0', 05:13:27 INFO - 'XPC_SERVICE_NAME': '0', 05:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-3vamKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:27 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)) 05:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-_OhKAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:27 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)) 05:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-jbnStm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:27 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)) 05:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-IjDWHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-bz48Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-V77Oy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-iUxXIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-oqVgtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-AcQKhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-3pKyGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-mlULNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:28 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)) 05:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-LRg9tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:29 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)) 05:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ZrsVBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 05:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-goUa0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:29 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)) 05:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-WJpxzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:29 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)) 05:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-voyWFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:29 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)) 05:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ImJeu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:29 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)) 05:13:29 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)) 05:13:29 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)) 05:13:29 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)) 05:13:29 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:29 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:32 INFO - Downloading blessings-1.5.1.tar.gz 05:13:32 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:32 INFO - Installing collected packages: blessings 05:13:32 INFO - Running setup.py install for blessings 05:13:32 INFO - Successfully installed blessings 05:13:32 INFO - Cleaning up... 05:13:32 INFO - Return code: 0 05:13:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:13:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:33 INFO - Reading from file tmpfile_stdout 05:13:33 INFO - Current package versions: 05:13:33 INFO - blessings == 1.5.1 05:13:33 INFO - blobuploader == 1.2.4 05:13:33 INFO - docopt == 0.6.1 05:13:33 INFO - manifestparser == 1.1 05:13:33 INFO - mozInstall == 1.12 05:13:33 INFO - mozcrash == 0.16 05:13:33 INFO - mozdebug == 0.1 05:13:33 INFO - mozdevice == 0.47 05:13:33 INFO - mozfile == 1.2 05:13:33 INFO - mozhttpd == 0.7 05:13:33 INFO - mozinfo == 0.9 05:13:33 INFO - mozleak == 0.1 05:13:33 INFO - mozlog == 3.0 05:13:33 INFO - moznetwork == 0.27 05:13:33 INFO - mozprocess == 0.22 05:13:33 INFO - mozprofile == 0.27 05:13:33 INFO - mozrunner == 6.11 05:13:33 INFO - mozscreenshot == 0.1 05:13:33 INFO - mozsystemmonitor == 0.0 05:13:33 INFO - moztest == 0.7 05:13:33 INFO - mozversion == 1.4 05:13:33 INFO - psutil == 3.1.1 05:13:33 INFO - requests == 1.2.3 05:13:33 INFO - wsgiref == 0.1.2 05:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10d655a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f705643c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/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.eERX6v5Ndc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:33 INFO - 'HOME': '/Users/cltbld', 05:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:33 INFO - 'LOGNAME': 'cltbld', 05:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:33 INFO - 'MOZ_NO_REMOTE': '1', 05:13:33 INFO - 'NO_EM_RESTART': '1', 05:13:33 INFO - 'PAGER': '/bin/cat', 05:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:33 INFO - 'PWD': '/builds/slave/test', 05:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:33 INFO - 'SHELL': '/bin/bash', 05:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:13:33 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:33 INFO - 'USER': 'cltbld', 05:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:33 INFO - 'XPC_FLAGS': '0x0', 05:13:33 INFO - 'XPC_SERVICE_NAME': '0', 05:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:33 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 1)) 05:13:33 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 2)) 05:13:33 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 3)) 05:13:33 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 4)) 05:13:33 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 5)) 05:13:33 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 6)) 05:13:33 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 7)) 05:13:33 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 8)) 05:13:33 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:13:33 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 3)) 05:13:33 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:13:33 INFO - Cleaning up... 05:13:33 INFO - Return code: 0 05:13:33 INFO - Running post-action listener: _resource_record_post_action 05:13:33 INFO - Running post-action listener: _start_resource_monitoring 05:13:33 INFO - Starting resource monitoring. 05:13:33 INFO - ##### 05:13:33 INFO - ##### Running install step. 05:13:33 INFO - ##### 05:13:33 INFO - Running pre-action listener: _resource_record_pre_action 05:13:33 INFO - Running main action method: install 05:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:33 INFO - Reading from file tmpfile_stdout 05:13:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:33 INFO - Reading from file tmpfile_stdout 05:13:33 INFO - Output received: 05:13:33 INFO - Usage: mozinstall [options] installer 05:13:33 INFO - Options: 05:13:33 INFO - -h, --help show this help message and exit 05:13:33 INFO - -d DEST, --destination=DEST 05:13:33 INFO - Directory to install application into. [default: 05:13:33 INFO - "/builds/slave/test"] 05:13:33 INFO - --app=APP Application being installed. [default: firefox] 05:13:33 INFO - mkdir: /builds/slave/test/build/application 05:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:14:13 INFO - Reading from file tmpfile_stdout 05:14:13 INFO - Output received: 05:14:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:14:13 INFO - Running post-action listener: _resource_record_post_action 05:14:13 INFO - ##### 05:14:13 INFO - ##### Running run-tests step. 05:14:13 INFO - ##### 05:14:13 INFO - Running pre-action listener: _resource_record_pre_action 05:14:13 INFO - Running main action method: run_tests 05:14:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:13 INFO - 2015-11-01 05:14:13.402 screenresolution[1630:7644] starting screenresolution argv=screenresolution get 05:14:13 INFO - 2015-11-01 05:14:13.405 screenresolution[1630:7644] Display 0: 1600x1200x32@60 05:14:13 INFO - 2015-11-01 05:14:13.412 screenresolution[1631:7646] starting screenresolution argv=screenresolution list 05:14:13 INFO - Available Modes on Display 0 05:14:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:13 INFO - Intel HD Graphics 3000: 05:14:13 INFO - Chipset Model: Intel HD Graphics 3000 05:14:13 INFO - Type: GPU 05:14:13 INFO - Bus: Built-In 05:14:13 INFO - VRAM (Total): 512 MB 05:14:13 INFO - VRAM (Dynamic, Max): 10 05:14:13 INFO - Vendor: Intel (0x8086) 05:14:13 INFO - Device ID: 0x0116 05:14:13 INFO - Revision ID: 0x0009 05:14:13 INFO - Displays: 05:14:13 INFO - Display: 05:14:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:13 INFO - Display Serial Number: 1600x1200 60 05:14:13 INFO - Main Display: Yes 05:14:13 INFO - Mirror: Off 05:14:13 INFO - Online: Yes 05:14:13 INFO - Rotation: Supported 05:14:13 INFO - Return code: 0 05:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:14:13 INFO - Python 2.7.3 05:14:13 INFO - Return code: 0 05:14:13 INFO - grabbing minidump binary from tooltool 05:14:13 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')]} 05:14:13 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 0x10d60a9f0>, '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 0x10d369cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:14:13 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 05:14:13 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 05:14:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:13 INFO - Return code: 0 05:14:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:14:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:14:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:14:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:14:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] in /builds/slave/test/build 05:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0018 --webServer localhost 05:14:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ei8v3U3Qch/Render', 05:14:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:13 INFO - 'HOME': '/Users/cltbld', 05:14:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:13 INFO - 'LOGNAME': 'cltbld', 05:14:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:13 INFO - 'MOZ_NO_REMOTE': '1', 05:14:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'NO_EM_RESTART': '1', 05:14:13 INFO - 'PAGER': '/bin/cat', 05:14:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:13 INFO - 'PWD': '/builds/slave/test', 05:14:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:13 INFO - 'SHELL': '/bin/bash', 05:14:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eERX6v5Ndc/Listeners', 05:14:13 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 05:14:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:13 INFO - 'USER': 'cltbld', 05:14:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:13 INFO - 'XPC_FLAGS': '0x0', 05:14:13 INFO - 'XPC_SERVICE_NAME': '0', 05:14:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:14:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] with output_timeout 3600 05:14:14 INFO - mozversion INFO | application_buildid: 20151101030343 05:14:14 INFO - mozversion INFO | application_changeset: 96377bdbcdf3e444a22aeaa677da696243b00d98 05:14:14 INFO - mozversion INFO | application_display_name: Nightly 05:14:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:14 INFO - mozversion INFO | application_name: Firefox 05:14:14 INFO - mozversion INFO | application_remotingname: firefox 05:14:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:14:14 INFO - mozversion INFO | application_vendor: Mozilla 05:14:14 INFO - mozversion INFO | application_version: 45.0a1 05:14:14 INFO - mozversion INFO | platform_buildid: 20151101030343 05:14:14 INFO - mozversion INFO | platform_changeset: 96377bdbcdf3e444a22aeaa677da696243b00d98 05:14:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:14:14 INFO - mozversion INFO | platform_version: 45.0a1 05:14:14 INFO - 2015-11-01 05:14:14,121 DEBUG : using testdate: 1446383654 05:14:14 INFO - 2015-11-01 05:14:14,121 DEBUG : actual date: 1446383654 05:14:14 INFO - 2015-11-01 05:14:14,134 INFO : starting webserver on 'localhost:49261' 05:14:14 INFO - 2015-11-01 05:14:14,135 INFO : Starting test suite t-yosemite-r5-0018 05:14:14 INFO - 2015-11-01 05:14:14,135 INFO : Starting test dromaeo_css 05:14:14 INFO - 2015-11-01 05:14:14,135 DEBUG : operating with platform_type : mac_ 05:14:14 INFO - 2015-11-01 05:14:14,136 INFO : Initialising browser for dromaeo_css test... 05:14:14 INFO - 2015-11-01 05:14:14,166 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpV8Sgm7/profile http://localhost:49261/getInfo.html 05:14:17 INFO - 2015-11-01 05:14:17,235 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:17 INFO - 2015-11-01 05:14:17,235 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:17 INFO - 2015-11-01 05:14:17,235 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:14:17 INFO - 2015-11-01 05:14:17,235 DEBUG : BROWSER_OUTPUT: __metrics 05:14:17 INFO - 2015-11-01 05:14:17,252 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:17 INFO - 2015-11-01 05:14:17,977 INFO : Browser initialized. 05:14:17 INFO - 2015-11-01 05:14:17,977 INFO : Running cycle 1/1 for dromaeo_css test... 05:14:17 INFO - 2015-11-01 05:14:17,977 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpV8Sgm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:29 INFO - 2015-11-01 05:14:29,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 222236672 05:14:29 INFO - 2015-11-01 05:14:29,982 DEBUG : BROWSER_OUTPUT: 05:15:21 INFO - 2015-11-01 05:15:21,910 DEBUG : BROWSER_OUTPUT: 1446383721904 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] 05:17:31 INFO - 2015-11-01 05:17:31,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49261/tests/dromaeo/cssquery-ext.html) 05:17:33 INFO - 2015-11-01 05:17:33,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 335757312 05:17:33 INFO - 2015-11-01 05:17:33,181 DEBUG : BROWSER_OUTPUT: 05:20:35 INFO - 2015-11-01 05:20:35,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-ext.html (next: http://localhost:49261/tests/dromaeo/cssquery-jquery.html) 05:20:36 INFO - 2015-11-01 05:20:36,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 355745792 05:20:36 INFO - 2015-11-01 05:20:36,545 DEBUG : BROWSER_OUTPUT: 05:23:38 INFO - 2015-11-01 05:23:38,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49261/tests/dromaeo/cssquery-mootools.html) 05:23:39 INFO - 2015-11-01 05:23:39,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 329854976 05:23:39 INFO - 2015-11-01 05:23:39,291 DEBUG : BROWSER_OUTPUT: 05:26:41 INFO - 2015-11-01 05:26:41,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49261/tests/dromaeo/cssquery-prototype.html) 05:26:41 INFO - 2015-11-01 05:26:41,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 312053760 05:26:41 INFO - 2015-11-01 05:26:41,971 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-01 05:29:44,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49261/tests/dromaeo/cssquery-yui.html) 05:29:45 INFO - 2015-11-01 05:29:45,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 314347520 05:29:45 INFO - 2015-11-01 05:29:45,521 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-yui.html (next: http://localhost:49261/tests/dromaeo/cssquery-dojo.html) 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 360681472 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:32:48 INFO - 2015-11-01 05:32:48,659 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:32:48 INFO - 2015-11-01 05:32:48,660 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2833.8866445342187;2913.0241369141336;2919.2993681516427;2925.254060214645;2926.531754919213;4716.985848042678;4852.660313778037;4853.684510506814;4941.431735350431;4992.7753251103695;4825.276208568716;4836.274558816171;4884.951150488494;4895.730734809584;4921.852344429664;4513.571210734975;4574.8627541173655;4584.862454126382;4679.064187162581;4698.64760142989;4625.213713668684;4635.235186194274;4648.070385922812;4684.578387945085;4700.858974230779;4403.251447253974;4431.667624928111;4510.030343476168;4548.8862778430475;4572.862814115599;4541.568550987651;4554.954450455486;4591.265397536378;4619.307103934403;4655.580997710188;4515.209838278321;4544.363789069533;4557.908841823145;4564.246899261618;4608.446986361624;4645.512221216757;4720.409948756405;4729.26696362061;4777.020710754287;4812.254100614376;5133.255677926717;5195.246689230041;5199.740012999335;5216.426193118754;5255.448177941299;5225.608079394023;5240.633155679104;5291.1798671206025;5296.232046353296;5297.337832770903;4728.38530990969;4763.118823017753;4780.569748722632;4825.95174048255;4895.0944075345815;5263.921041184385;5315.574754019669;5326.893462130735;5358.812441564526;5376.91934620981;5107.61692873036;5124.5131712487255;5151.665141765773;5161.071007218661;5207.817726379559;5080.314157588678;5099.69401835891;5171.198464238049;5201.973990130025;5255.947440525622;5198.298229739013;5199.584033277329;5206.713630750345;5241.554467870197;5279.260903473517;5180.922286165711;5210.21846722987;5224.50367215114;5230.137027390438;5246;3938.78336691479;3940.842366305373;4007.699422543321;4020.276350256982;4055.6755459563165;3650.288193802236;3679.7976111314133;3687.3362794697214;3695.7597756145765;3741.5323084614424;4809;4814.470408255089;4859.246816743411;4871.34236878017;4900.362952816111;5110.156824124052;5130.769115389817;5234.18870075139;5246.134387826042;5261.552768014762;4844.636652251095;4857.587105096107;4878.536539028786;4935.75321233944;4952.678075925125;4552.931706024412;4592.517785632527;4626.259798432235;4641.883952901205;4644.187267228222;5025.346704928336;5043.798248070036;5227.555657769132;5235.4764523548865;5312.282841816305;5233.424323324355;5258.50044245796;5267.051930652366;5291.417944026231;5296.073187192149;5226.529612334908;5271.235670827785;5304.681719096867;5316.973415133054;5348.973255133699;4986.12742770021;5020.698758074527;5060.772265248146;5117;5167.793288268427;5214;5236.947630523646;5271.551918087006;5282.392524859691;5295.046891559557;4955.1823949048;5086.3896332440345;5140;5145.768440420115;5211.1922651989;4935.062338155739;4962.181240095344;4993.675411098267;5049.141645920129;5081.415637201769;4999.975000124976;5012.172991456368;5035.194368900959;5046.596272298134;5056.84829455117;5132.5893928486375;5139.203423469368;5179.896402072013;5185.040767458032;5187.403448603308;4777.140114779373;4841.685290456109;4908.312836203006;4962.652614316963;5065.012322597058 05:32:48 INFO - 2015-11-01 05:32:48,660 DEBUG : BROWSER_OUTPUT: |1;ext.html;503.0567685589519;507.46969416959274;510.80078769279964;515.7215103843924;534.9625526213161;27912;28997.27506812331;35695.2860942781;36219;36422.8178859106;38928.80535597325;39028.219435611274;39084.41373379402;39322.60677393225;39341.803290983575;7378.815529611749;8230.176982301768;8377;8401.453905496153;8409.747707568782;7456.291652293024;9943.154831839267;10096.29325947184;10135.581018657394;10180.185585153207;9923.652672156475;10066.899331006705;10106.09045185933;10112.140468060225;10126.29115961883;7598.20218877021;7771.455998080137;9995.75010624733;10008.249381296395;10030.197584193247;9729.464879431629;9861.260405469618;9865.852012219822;9876.90123098767;9893.4558599277;35042.29915401703;35438.468422973674;35471.4679279811;35526.82236588826;35637.643623563694;2587.120379071106;2623.973760262392;2636.525425423423;2703.553913604253;2735.1967252874506;24635.38411539708;25285;25486.74513254862;26042.609360859602;26125.216243512536;2154.450615093141;2166.6425039868404;2180.5965896309235;2190.113004233288;2288.645259984705;230428;235972;237197;237246;238456;51304.48695513072;52600.736996315536;59279;66337.33662663311;67389.66305168443;62965;64206;64446.35553644497;64486.6775666128;64489.35510644833;15552.533423997298;15735.921320393325;15752.606184845241;15838;15891.682166356608;11699.415029248503;11792.587259445878;11825.645230643095;11829.526818927146;11852.525898964117;19995.100220490112;20202.89898550527;20248.29130980438;20253.189872405233;20373.898130509548;8496.107908669625;8706.869396959051;8735.25750311218;8736.344774141964;8801.471911685192;824.6866190847439;911.977200569991;937.840567103594;994.1549682769732;1027.5427434791595;25299.74700252974;25469.490610188062;25597;25781.74218257831;25786.226413207634;927.638221093774;948.393028461785;955.4506158958627;1006.2855372685475;1045.954045954046;13240.139390939557;13375.264360460269;13412.530561430303;13503.932480337731;13523.729525409437;264004;268821;269456;270650;271292;48727.269090963666;49147;49165;49213.261801073015;49257.26114108291;1183.6153250193722;1206.5361489153595;1230.8153776933532;1232.870548592385;1233.8766123387588;24841.875790621652;25419.74580254248;25425.745742542338;25441.363965901;25448.872755636843;39113.217735645696;39744.2051158981;43544.34683479687;43964.34053489264;44061;244674;248027;252702;253063;253293;29537;29858;29883.70116298896;29967.70032299649;30077.248068798453;38075;38650.80674596722;38671.71958303547;38968;39280.607193927695;31592.842035789676;34846.825765871006;35463.82268088643;36133;36283;32240;32442.83778581092;32588.83705581457;32628.34743305073;32694.67305326916;33084.834575826964;35194.120146995505;36626.63373366339;36730.081747955446;36948.815255923546;26554.336141596614;29017.854910725313;29178.854105729337;29302.853485732434;29435.411291773617;22444.88777556102;22482.213122540634;22503.324900253017;22584.88707556452;22714.772852271264 05:32:48 INFO - 2015-11-01 05:32:48,661 DEBUG : BROWSER_OUTPUT: |2;jquery.html;296.63662014032826;298.4463819614615;299.94151140527595;306.8220432149352;307.6246978686003;12867.742645147091;13266.204027758342;14922.253887305633;15597.688046239069;16140.192990350479;10628.202884783634;10946.124310055196;11021;13153.539626113088;15551.688966220669;3500.527428797118;4020.738651987626;4025.657819085381;4033.495813023372;4047.4131250968594;3009.9247518812094;3120.9687903120907;3862.5364956205153;4069.9593004069875;4244.172386384656;4252.468441444819;4274.615284624383;4278.657707383401;4299.247631664462;4308.18144552534;4169.353750168699;4274.059706864485;4274.337477690948;4280.807363668611;4321.0493691388;3597.5143355646915;3600.9099772505897;3636.818159092035;3640.0353906214873;3648.1973965727498;11904.523819047228;11980.34108124053;12154.513819447211;12204.840540148673;12285.508579656893;1592.678077195936;1712.152484520158;1715.468204856486;1717.7079896417515;1814.8185181481879;8615.913840861636;8635.611397487128;8717.912820871774;8834.072422395684;8891.599878005505;1342.9261390623512;1362.495876525682;1374.6425929258364;1381.1781989716103;1383.2392184298697;51504.48495515034;53830.46169538294;54338;54630;55485.44514554843;5781.913271300849;5817.040188368872;5859.150423188614;5896.262967129023;5935.465808077208;6610.603363798187;6667.533272670964;6669.966650166815;6695.1965764107645;6714;4929.7781599828095;5012.398512178489;5016.3446062799185;5021.171506701354;5023.342297041967;5408.45915408456;5409.134538473825;5475.0418676731415;5476.315460567429;5508.3114610673665;2628.868556572164;2636.8417894926365;2639.1818536253822;2645.4973555024485;2668.893244270246;913.7213149989184;918.1552971266451;923.7228831350568;923.9029901860208;987.160913223754;338.8018009464491;339.95750531183603;377.70916394376724;378.487149911871;388.25261371859057;9298.90701092994;9641.325107242426;9740.707778766648;9803.264755143393;9923.454210018519;344.09159818080286;360.9729270304685;378.7481324918953;382.2412511165335;409.03263781157347;5082.847514574569;5106.693598384109;5177.663451875616;5220.973895130576;5260.184671375943;445216;446734;450089;455500;463738;60476;61377;61965.38034619596;62502.37497625056;62537.68731156315;404.4378314143343;405.2745585402156;405.6673527707252;409.20818216750683;409.86884197056656;8841.513716745641;8881.777955551162;8894.731843379897;8907.955460222658;8977.10228977097;29746.702532974392;29811.552826707182;29863.850680747328;29921.251968700086;29966.400671986874;41753;41866.79066604647;42028.36957445702;42155;42937.57062429336;5299.417064122867;5558.055130627884;5596.86007849807;5609.635373700697;5617.606767526234;9995.70012899614;10562.04941555233;10592.152627789912;10643.840342395026;10655.733606659896;7922.7227047053075;7971;8299.419040667095;9096.363254572116;9165.083491650781;8659.48043117415;8815.074417186102;8817.823643526965;9104.17916416706;9158.175764181256;8927.910720892707;9123.452592844451;9343.813123737624;9373.1564159226;9432;5553.389127195925;5554.583406244467;5617.522510586646;5625.88748225025;5640.717964101696;9088.54557272147;9293.535323233677;9337.71986840396;9386.202172815387;9386.530673466435 05:32:48 INFO - 2015-11-01 05:32:48,662 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1148.5176225985097;1489.664825414282;1577.952661420157;1594.6172918499556;1611.3474043012577;6343.619382837027;6503.187101612299;6800.863982720342;7001.754938577151;7024.613646249454;6920.307969203077;6936.271691472399;6984.546004509703;6987.30126987301;7019.333163349486;1972.4871533401276;1986.682130859063;1987.7316562264054;1996.820286174244;1998.9000549972443;2009.6884982827612;2020.171729590868;2037.1240366642337;2050.425880753384;2070.8550401471903;1939.4278687787066;1953.4627977306213;1953.687410014398;1965.3219639224444;1971.4381401300632;1976.7331410259574;1995.750531183602;2008.68865325874;2011.6580181369056;2013.7986201379817;1933.7002764571514;1945.085809669453;1954.7556555430572;1956.3935180094074;1967.8032196780207;6161.199044124235;6880.65596720162;6908.550944188662;6928.72285108595;6946.895796563055;3819.9809000955097;4188.350805625133;4240.703150779415;4281.186574550826;4282.678799090049;2597.285746419731;2623.22614828626;2658.8138830281887;2666.5066962611977;2672.812903096784;782.0576205672209;803.9678412863478;810.1372038778682;820.7496713502379;823.000054933253;9003;9104.499252541107;9140.634374625008;9149.54252287383;9190.678326258549;3871.6515513603913;3878.6703130234246;3930.0960779020415;3936;3938.665213456888;8079.798005049804;8104.189581041966;8109.067457242375;8125.878111828328;8140.185981401813;4354.912901741947;4373.103513779667;4399.428074350314;4399.84600538986;4400.889977750582;3950.762954222756;3977.900552486211;3990.182012687392;3992.580779018161;4007.39889016644;3134.467140586106;3178.760283489441;3181.1569933967517;3189.888353907602;3218.4045951499047;984.2618036472645;1020.2603112743202;1023.2325755683238;1023.6673081248624;1023.9129673977646;1177.264209868832;1178.1046404732294;1192.0106311761217;1216.1061619709683;1220.371508673034;6559.934400656028;6584.209894812653;6588.439982601437;6606.108175396356;6673.799786006428;346.107043826931;349.2595697122117;352.68082385441215;353.92036791721654;354.3692227834459;5258.316418865523;5285.339332583427;5287.339082614673;5324.494173053554;5347.41178470368;7426.183119856812;7623.428242881806;7933.920660793318;8137.95931020353;8139.38954578409;8034.357251419872;8038.919610803934;8061.072976607648;8070.435069545193;8100;6259.405356491217;6393.552451328455;6464.288928217892;6478.222613286436;6539.182602174728;6496.382843629847;6509.967450162719;6530.8040758777315;6575.112359831362;6584.868302634016;7156.606386648576;7343.44924130703;7381.11426628808;7446.590437525988;7447.962760186165;7306.525075870051;7475.962620186864;7593.088829340514;7666.6166691664075;7689.3464055555905;6128.938710612837;6212.844678883064;6217.129601855653;6257.2491301044165;6274.592151510137;6425.06836508713;6584.8353791155605;6635.668216589248;6639.170103737033;6663.8667226654225;6138.723757431016;6230.376962303914;6272.717727702173;6281.497480201664;6288.371162883675;6088.391160883876;6104.145419641165;6180.196574445473;6189.907151392643;6248.0940263660605;6147.477464415575;6224;6225.097360882737;6284.591501552384;6287.371262873676;5638.633488823213;5689.487946084872;5749.080147176432;5756.16535602327;5759.481646651821;5726.112452569859;5791;5799.217105690846;5821.738021788945;5850.444207800252 05:32:48 INFO - 2015-11-01 05:32:48,666 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.8730983747476;281.95347767618347;282.3689054962159;285.8285028982609;290.7223601460605;5406.162044883049;5474.151506516491;5491.697956612385;5513.72431378431;5559.805406810762;5167;5237.659552129109;5258.079836028699;5301.814436494714;5426.8914621707645;4191.287481128215;4206.894827629319;4207.474065741782;4233.936490952623;4235.894102647428;4245.448091748069;4247.193033323674;4250.0862314602355;4253.893652658693;4259.723117997336;4063.0654949361665;4091.488563929509;4148.2947898857265;4196.055887425336;4199.9580004200025;4188.874333769962;4189.49726032878;4199.55904630014;4201.432806571104;4234.153169366108;3624.800635965021;3631.5279013728045;3635.4910312556262;3643.143861192644;3648.945265821015;5272.6836389816735;5281.287026251445;5290.709011004393;5301.125314323132;5307.681539107666;4539.409876716006;4635.397398338228;4685.203515402356;4743.02767932573;4749.548792864673;5725.885482290372;5743.856403589902;5752.252207213078;5756.453136952025;5771.538276937835;3809.676177524914;3868.9806550967346;3896.376579747227;3910.432987216838;3919.451276821247;5927.2590926134235;5985.820425387245;5996.730147143389;5996.8500787480225;6012.999999999956;3890.533136023695;3954.070793363557;3954.54522729884;3962.9405558916637;3997.2605068062503;4018.296798060386;4024.657904078186;4057.4928133983253;4064.4716186895516;4067.2272268268935;4663.696859704109;4664.323673067454;4685.156671799109;4723.716577005322;4732.574068333866;5708.628939118944;5711.571632127607;5740.598158128891;5760.510356619734;5766.04860198071;1396.427464739452;1422.9359678814271;1423.7935499352536;1438.719449707297;1444.4655477473193;901.0583939782942;909.4588719711761;910.4082346474844;916.5554705967601;947.9952600236954;5426.430224826416;5428.457154284619;5433.972830135903;5442.591805614595;5458.699771512525;5923.466887980103;5966.373530779292;5967.582269241198;5981.342052374235;5990.371011043865;5206.193040078794;5333.253344531769;5346.91979620306;5433.429489903503;5454.372747134051;3254.4792833146585;3282.343531293751;3289.7697161198485;3298.5546951161764;3306.88425905097;6024.728887200086;6055.7274922628585;6100.69496525172;6102.816915492543;6129.540284478682;6021.849453763603;6133.0800379942475;6167.383261673796;6172.074188871705;6217.782377616762;6017.157597936205;6045.818625441244;6054.909176362358;6061.727222275008;6063.514918806573;6021.307549631673;6022.849428764316;6032.125341825498;6032.638041717511;6054;5876.412358764261;5887.028640274307;5888.558358123072;5891.617044892068;5907.822765317047;5883.764649414146;6064.545159113172;6070.696465176635;6079.240094988127;6093.756249750138;3958.802059897051;3968.940465892956;3969.64273215412;3972.980135099306;3977.980110099431;5982.282126144891;5994.460498555151;6007.219061521974;6011.428914253139;6057.515398768176;5652.576056795675;5760.337561180518;5832.12518122285;5837.182794408871;5848.912266315923;5789.56578256624;5804.65172089676;5840.970795145997;5849.1226316052935;5884.411558844253;5668.546516278605;5680.431956804452;5682.261306030189;5699.23060386859;5730.598858080061;5691.223000074708;5805.071188609802;5823.126531020381;5829.679367634821;5869.090291004901;5703.600747947769;5710.029295019774;5719.084946408555;5726.856828579319;5734.770609175753 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: |5;yui.html;650.1612919334059;687.5977553131418;692.5567636712505;700.9065857262674;709.705472229025;11662.06703463723;12348.259104453738;12401;12404.069694772894;12422.565210217645;11673.1828771986;11767.646970590875;11768.117391195652;11807.645770626874;11867.050635949125;632.7216024949031;648.8929326661096;788.9921100789005;809.7044578728751;812.0620683110986;637.3435361577582;797.6291024673526;802.4663598706853;818.7707441916243;820.5733018830234;831.1397703377006;857.3869683176528;857.5026484638895;858.3047731337637;866.2809867809702;678.1895634716516;689.300360134464;840.6595328891808;845.2012847858776;859.4886042804552;634.4670476799464;635.5043066408163;635.7647670361949;635.9109724638554;636.3541005879036;11050.171237157245;11115;11175.21773475857;11208.887911120866;11270.943645281803;10454.581816727321;10506.527206275736;10646.414447205401;11142.387168705718;11240.49417776202;7994.880076798852;8223.450730273635;8272;8533.615987280587;8852.645894164225;2969.9703002970127;3025.7125573070525;3063.2801291696433;3090.8763649453995;3120.188750924753;45206.095878082255;46508.767456162845;46541.76729116367;46547.53452465466;46582.76708616469;8211.876821847676;8253.546054966915;8289.129641387688;8398.41211115216;8455.154484551618;17745.378911738284;17757.289708411517;17763.911180444014;17773.377931772327;17815.643687126445;6502.44729198014;6566.835829104215;6582.868342633121;6698.66506674674;6827.761028363983;3247.382997230519;3267.330197309546;3287.342531493711;3319.4321997801085;3343.2310568569364;2651.549236629739;2711.240852561286;2718.184544636601;2718.9184324470298;2723.264718525987;382.94638750574944;388.4328879835472;392.01212943383086;393.41381341800513;393.8582110440239;506.5213373362211;515.3223511082914;550.9944900551023;560.2940295228042;563.4759673503681;6842.144731908512;7142.392896603847;7566.281203285679;7724.227577242344;7834.334081603013;370.55348305292057;469.9459562150328;504.5106246940462;526.5050852198997;586.3608666553478;3169.3344397676283;3377.071305390988;3524.718022558189;3548.9822550887598;3565.2965854969552;53308;53391.19913201305;53402.73298633482;53876.73061634667;53941.460585393645;46153;46730.299045514344;46759;47039;47156.292655610196;41953.16093678171;42151.57848421538;42487.57512424836;42548;43343.34984975228;6421.422072013354;6491.675416229265;6579.506537009648;6636.668166591748;6661.700223489857;29726.405471890874;30375.848120759256;30423.847880760455;32618.673813261565;33029.17427064342;40550.39174412327;40908.1818363637;41377.1724565501;42492.78753606212;42572;6802.523823332517;6841.863162736618;6852.789353808667;6915.308469153045;7003.404710599452;9910.702678919644;10066.748331291776;10124.59501619927;10149.695509134737;10198.796024079329;9558.044195580664;9617.51912404363;9624.807503850025;9633.036696330311;9638.084381983701;9447.149756521945;9557.23542116643;9572.9042709572;9578.521073946415;9607;9146.359754817098;9355.812883742423;9371.203447707021;9383.296252781205;9445;8006.919930800617;8173.34613230952;8609.65561377538;8615.3107751381;8687.478751274944;8200.584409463814;8303.709370172015;8330.958345208235;8536.74389768308;8558.614862331335 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: __startTimestamp1446384768654__endTimestamp 05:32:48 INFO - 2015-11-01 05:32:48,668 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4853.56 Median:4992.78 stddev:507.18 (10.2%) stddev-sans-first:483.35 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: Values: 2833.9 2913.0 2919.3 2925.3 2926.5 4717.0 4852.7 4853.7 4941.4 4992.8 4825.3 4836.3 4885.0 4895.7 4921.9 4513.6 4574.9 4584.9 4679.1 4698.6 4625.2 4635.2 4648.1 4684.6 4700.9 4403.3 4431.7 4510.0 4548.9 4572.9 4541.6 4555.0 4591.3 4619.3 4655.6 4515.2 4544.4 4557.9 4564.2 4608.4 4645.5 4720.4 4729.3 4777.0 4812.3 5133.3 5195.2 5199.7 5216.4 5255.4 5225.6 5240.6 5291.2 5296.2 5297.3 4728.4 4763.1 4780.6 4826.0 4895.1 5263.9 5315.6 5326.9 5358.8 5376.9 5107.6 5124.5 5151.7 5161.1 5207.8 5080.3 5099.7 5171.2 5202.0 5255.9 5198.3 5199.6 5206.7 5241.6 5279.3 5180.9 5210.2 5224.5 5230.1 5246.0 3938.8 3940.8 4007.7 4020.3 4055.7 3650.3 3679.8 3687.3 3695.8 3741.5 4809.0 4814.5 4859.2 4871.3 4900.4 5110.2 5130.8 5234.2 5246.1 5261.6 4844.6 4857.6 4878.5 4935.8 4952.7 4552.9 4592.5 4626.3 4641.9 4644.2 5025.3 5043.8 5227.6 5235.5 5312.3 5233.4 5258.5 5267.1 5291.4 5296.1 5226.5 5271.2 5304.7 5317.0 5349.0 4986.1 5020.7 5060.8 5117.0 5167.8 5214.0 5236.9 5271.6 5282.4 5295.0 4955.2 5086.4 5140.0 5145.8 5211.2 4935.1 4962.2 4993.7 5049.1 5081.4 5000.0 5012.2 5035.2 5046.6 5056.8 5132.6 5139.2 5179.9 5185.0 5187.4 4777.1 4841.7 4908.3 4962.7 5065.0 05:32:48 INFO - 2015-11-01 05:32:48,669 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,670 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41716.79 Median:29870.85 stddev:65684.29 (219.9%) stddev-sans-first:65795.65 05:32:48 INFO - 2015-11-01 05:32:48,671 DEBUG : BROWSER_OUTPUT: Values: 503.1 507.5 510.8 515.7 535.0 27912.0 28997.3 35695.3 36219.0 36422.8 38928.8 39028.2 39084.4 39322.6 39341.8 7378.8 8230.2 8377.0 8401.5 8409.7 7456.3 9943.2 10096.3 10135.6 10180.2 9923.7 10066.9 10106.1 10112.1 10126.3 7598.2 7771.5 9995.8 10008.2 10030.2 9729.5 9861.3 9865.9 9876.9 9893.5 35042.3 35438.5 35471.5 35526.8 35637.6 2587.1 2624.0 2636.5 2703.6 2735.2 24635.4 25285.0 25486.7 26042.6 26125.2 2154.5 2166.6 2180.6 2190.1 2288.6 230428.0 235972.0 237197.0 237246.0 238456.0 51304.5 52600.7 59279.0 66337.3 67389.7 62965.0 64206.0 64446.4 64486.7 64489.4 15552.5 15735.9 15752.6 15838.0 15891.7 11699.4 11792.6 11825.6 11829.5 11852.5 19995.1 20202.9 20248.3 20253.2 20373.9 8496.1 8706.9 8735.3 8736.3 8801.5 824.7 912.0 937.8 994.2 1027.5 25299.7 25469.5 25597.0 25781.7 25786.2 927.6 948.4 955.5 1006.3 1046.0 13240.1 13375.3 13412.5 13503.9 13523.7 264004.0 268821.0 269456.0 270650.0 271292.0 48727.3 49147.0 49165.0 49213.3 49257.3 1183.6 1206.5 1230.8 1232.9 1233.9 24841.9 25419.7 25425.7 25441.4 25448.9 39113.2 39744.2 43544.3 43964.3 44061.0 244674.0 248027.0 252702.0 253063.0 253293.0 29537.0 29858.0 29883.7 29967.7 30077.2 38075.0 38650.8 38671.7 38968.0 39280.6 31592.8 34846.8 35463.8 36133.0 36283.0 32240.0 32442.8 32588.8 32628.3 32694.7 33084.8 35194.1 36626.6 36730.1 36948.8 26554.3 29017.9 29178.9 29302.9 29435.4 22444.9 22482.2 22503.3 22584.9 22714.8 05:32:48 INFO - 2015-11-01 05:32:48,672 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,672 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22772.90 Median:448411.50 stddev:74146.93 (16.5%) stddev-sans-first:74335.72 05:32:48 INFO - 2015-11-01 05:32:48,673 DEBUG : BROWSER_OUTPUT: Values: 296.6 298.4 299.9 306.8 307.6 12867.7 13266.2 14922.3 15597.7 16140.2 10628.2 10946.1 11021.0 13153.5 15551.7 3500.5 4020.7 4025.7 4033.5 4047.4 3009.9 3121.0 3862.5 4070.0 4244.2 4252.5 4274.6 4278.7 4299.2 4308.2 4169.4 4274.1 4274.3 4280.8 4321.0 3597.5 3600.9 3636.8 3640.0 3648.2 11904.5 11980.3 12154.5 12204.8 12285.5 1592.7 1712.2 1715.5 1717.7 1814.8 8615.9 8635.6 8717.9 8834.1 8891.6 1342.9 1362.5 1374.6 1381.2 1383.2 51504.5 53830.5 54338.0 54630.0 55485.4 5781.9 5817.0 5859.2 5896.3 5935.5 6610.6 6667.5 6670.0 6695.2 6714.0 4929.8 5012.4 5016.3 5021.2 5023.3 5408.5 5409.1 5475.0 5476.3 5508.3 2628.9 2636.8 2639.2 2645.5 2668.9 913.7 918.2 923.7 923.9 987.2 338.8 340.0 377.7 378.5 388.3 9298.9 9641.3 9740.7 9803.3 9923.5 344.1 361.0 378.7 382.2 409.0 5082.8 5106.7 5177.7 5221.0 5260.2 445216.0 446734.0 450089.0 455500.0 463738.0 60476.0 61377.0 61965.4 62502.4 62537.7 404.4 405.3 405.7 409.2 409.9 8841.5 8881.8 8894.7 8908.0 8977.1 29746.7 29811.6 29863.9 29921.3 29966.4 41753.0 41866.8 42028.4 42155.0 42937.6 5299.4 5558.1 5596.9 5609.6 5617.6 9995.7 10562.0 10592.2 10643.8 10655.7 7922.7 7971.0 8299.4 9096.4 9165.1 8659.5 8815.1 8817.8 9104.2 9158.2 8927.9 9123.5 9343.8 9373.2 9432.0 5553.4 5554.6 5617.5 5625.9 5640.7 9088.5 9293.5 9337.7 9386.2 9386.5 05:32:48 INFO - 2015-11-01 05:32:48,673 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,673 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4816.78 Median:6116.54 stddev:2487.05 (40.7%) stddev-sans-first:2478.73 05:32:48 INFO - 2015-11-01 05:32:48,674 DEBUG : BROWSER_OUTPUT: Values: 1148.5 1489.7 1578.0 1594.6 1611.3 6343.6 6503.2 6800.9 7001.8 7024.6 6920.3 6936.3 6984.5 6987.3 7019.3 1972.5 1986.7 1987.7 1996.8 1998.9 2009.7 2020.2 2037.1 2050.4 2070.9 1939.4 1953.5 1953.7 1965.3 1971.4 1976.7 1995.8 2008.7 2011.7 2013.8 1933.7 1945.1 1954.8 1956.4 1967.8 6161.2 6880.7 6908.6 6928.7 6946.9 3820.0 4188.4 4240.7 4281.2 4282.7 2597.3 2623.2 2658.8 2666.5 2672.8 782.1 804.0 810.1 820.7 823.0 9003.0 9104.5 9140.6 9149.5 9190.7 3871.7 3878.7 3930.1 3936.0 3938.7 8079.8 8104.2 8109.1 8125.9 8140.2 4354.9 4373.1 4399.4 4399.8 4400.9 3950.8 3977.9 3990.2 3992.6 4007.4 3134.5 3178.8 3181.2 3189.9 3218.4 984.3 1020.3 1023.2 1023.7 1023.9 1177.3 1178.1 1192.0 1216.1 1220.4 6559.9 6584.2 6588.4 6606.1 6673.8 346.1 349.3 352.7 353.9 354.4 5258.3 5285.3 5287.3 5324.5 5347.4 7426.2 7623.4 7933.9 8138.0 8139.4 8034.4 8038.9 8061.1 8070.4 8100.0 6259.4 6393.6 6464.3 6478.2 6539.2 6496.4 6510.0 6530.8 6575.1 6584.9 7156.6 7343.4 7381.1 7446.6 7448.0 7306.5 7476.0 7593.1 7666.6 7689.3 6128.9 6212.8 6217.1 6257.2 6274.6 6425.1 6584.8 6635.7 6639.2 6663.9 6138.7 6230.4 6272.7 6281.5 6288.4 6088.4 6104.1 6180.2 6189.9 6248.1 6147.5 6224.0 6225.1 6284.6 6287.4 5638.6 5689.5 5749.1 5756.2 5759.5 5726.1 5791.0 5799.2 5821.7 5850.4 05:32:48 INFO - 2015-11-01 05:32:48,675 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,675 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4803.88 Median:5466.43 stddev:1461.40 (26.7%) stddev-sans-first:1425.43 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: Values: 275.9 282.0 282.4 285.8 290.7 5406.2 5474.2 5491.7 5513.7 5559.8 5167.0 5237.7 5258.1 5301.8 5426.9 4191.3 4206.9 4207.5 4233.9 4235.9 4245.4 4247.2 4250.1 4253.9 4259.7 4063.1 4091.5 4148.3 4196.1 4200.0 4188.9 4189.5 4199.6 4201.4 4234.2 3624.8 3631.5 3635.5 3643.1 3648.9 5272.7 5281.3 5290.7 5301.1 5307.7 4539.4 4635.4 4685.2 4743.0 4749.5 5725.9 5743.9 5752.3 5756.5 5771.5 3809.7 3869.0 3896.4 3910.4 3919.5 5927.3 5985.8 5996.7 5996.9 6013.0 3890.5 3954.1 3954.5 3962.9 3997.3 4018.3 4024.7 4057.5 4064.5 4067.2 4663.7 4664.3 4685.2 4723.7 4732.6 5708.6 5711.6 5740.6 5760.5 5766.0 1396.4 1422.9 1423.8 1438.7 1444.5 901.1 909.5 910.4 916.6 948.0 5426.4 5428.5 5434.0 5442.6 5458.7 5923.5 5966.4 5967.6 5981.3 5990.4 5206.2 5333.3 5346.9 5433.4 5454.4 3254.5 3282.3 3289.8 3298.6 3306.9 6024.7 6055.7 6100.7 6102.8 6129.5 6021.8 6133.1 6167.4 6172.1 6217.8 6017.2 6045.8 6054.9 6061.7 6063.5 6021.3 6022.8 6032.1 6032.6 6054.0 5876.4 5887.0 5888.6 5891.6 5907.8 5883.8 6064.5 6070.7 6079.2 6093.8 3958.8 3968.9 3969.6 3973.0 3978.0 5982.3 5994.5 6007.2 6011.4 6057.5 5652.6 5760.3 5832.1 5837.2 5848.9 5789.6 5804.7 5841.0 5849.1 5884.4 5668.5 5680.4 5682.3 5699.2 5730.6 5691.2 5805.1 5823.1 5829.7 5869.1 5703.6 5710.0 5719.1 5726.9 5734.8 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12324.44 Median:555.64 stddev:14928.26 (2686.7%) stddev-sans-first:14944.39 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: Values: 650.2 687.6 692.6 700.9 709.7 11662.1 12348.3 12401.0 12404.1 12422.6 11673.2 11767.6 11768.1 11807.6 11867.1 632.7 648.9 789.0 809.7 812.1 637.3 797.6 802.5 818.8 820.6 831.1 857.4 857.5 858.3 866.3 678.2 689.3 840.7 845.2 859.5 634.5 635.5 635.8 635.9 636.4 11050.2 11115.0 11175.2 11208.9 11270.9 10454.6 10506.5 10646.4 11142.4 11240.5 7994.9 8223.5 8272.0 8533.6 8852.6 2970.0 3025.7 3063.3 3090.9 3120.2 45206.1 46508.8 46541.8 46547.5 46582.8 8211.9 8253.5 8289.1 8398.4 8455.2 17745.4 17757.3 17763.9 17773.4 17815.6 6502.4 6566.8 6582.9 6698.7 6827.8 3247.4 3267.3 3287.3 3319.4 3343.2 2651.5 2711.2 2718.2 2718.9 2723.3 382.9 388.4 392.0 393.4 393.9 506.5 515.3 551.0 560.3 563.5 6842.1 7142.4 7566.3 7724.2 7834.3 370.6 469.9 504.5 526.5 586.4 3169.3 3377.1 3524.7 3549.0 3565.3 53308.0 53391.2 53402.7 53876.7 53941.5 46153.0 46730.3 46759.0 47039.0 47156.3 41953.2 42151.6 42487.6 42548.0 43343.3 6421.4 6491.7 6579.5 6636.7 6661.7 29726.4 30375.8 30423.8 32618.7 33029.2 40550.4 40908.2 41377.2 42492.8 42572.0 6802.5 6841.9 6852.8 6915.3 7003.4 9910.7 10066.7 10124.6 10149.7 10198.8 9558.0 9617.5 9624.8 9633.0 9638.1 9447.1 9557.2 9572.9 9578.5 9607.0 9146.4 9355.8 9371.2 9383.3 9445.0 8006.9 8173.3 8609.7 8615.3 8687.5 8200.6 8303.7 8331.0 8536.7 8558.6 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:32:48 INFO - 2015-11-01 05:32:48,676 DEBUG : BROWSER_OUTPUT: 05:32:49 INFO - 2015-11-01 05:32:49,381 INFO : Browser exited with error code: 0 05:32:49 INFO - 2015-11-01 05:32:49,412 INFO : Completed test dromaeo_css (00:18:35) 05:32:49 INFO - 2015-11-01 05:32:49,412 INFO : Starting test kraken 05:32:49 INFO - 2015-11-01 05:32:49,412 DEBUG : operating with platform_type : mac_ 05:32:49 INFO - 2015-11-01 05:32:49,412 INFO : Initialising browser for kraken test... 05:32:49 INFO - 2015-11-01 05:32:49,427 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp6cN3p4/profile http://localhost:49261/getInfo.html 05:32:51 INFO - 2015-11-01 05:32:51,773 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:32:51 INFO - 2015-11-01 05:32:51,773 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:32:51 INFO - 2015-11-01 05:32:51,774 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:32:51 INFO - 2015-11-01 05:32:51,774 DEBUG : BROWSER_OUTPUT: __metrics 05:32:51 INFO - 2015-11-01 05:32:51,789 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:52 INFO - 2015-11-01 05:32:52,565 INFO : Browser initialized. 05:32:52 INFO - 2015-11-01 05:32:52,566 INFO : Running cycle 1/1 for kraken test... 05:32:52 INFO - 2015-11-01 05:32:52,566 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp6cN3p4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:33:04 INFO - 2015-11-01 05:33:04,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 220663808 05:33:04 INFO - 2015-11-01 05:33:04,555 DEBUG : BROWSER_OUTPUT: 05:33:07 INFO - 2015-11-01 05:33:07,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:07 INFO - 2015-11-01 05:33:07,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 278265856 05:33:07 INFO - 2015-11-01 05:33:07,857 DEBUG : BROWSER_OUTPUT: 05:33:10 INFO - 2015-11-01 05:33:10,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-dft) 05:33:11 INFO - 2015-11-01 05:33:11,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 291835904 05:33:11 INFO - 2015-11-01 05:33:11,325 DEBUG : BROWSER_OUTPUT: 05:33:14 INFO - 2015-11-01 05:33:14,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-fft) 05:33:15 INFO - 2015-11-01 05:33:15,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 275173376 05:33:15 INFO - 2015-11-01 05:33:15,100 DEBUG : BROWSER_OUTPUT: 05:33:17 INFO - 2015-11-01 05:33:17,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator) 05:33:17 INFO - 2015-11-01 05:33:17,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 276283392 05:33:17 INFO - 2015-11-01 05:33:17,848 DEBUG : BROWSER_OUTPUT: 05:33:20 INFO - 2015-11-01 05:33:20,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:20 INFO - 2015-11-01 05:33:20,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 277729280 05:33:20 INFO - 2015-11-01 05:33:20,767 DEBUG : BROWSER_OUTPUT: 05:33:24 INFO - 2015-11-01 05:33:24,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:24 INFO - 2015-11-01 05:33:24,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 275714048 05:33:24 INFO - 2015-11-01 05:33:24,679 DEBUG : BROWSER_OUTPUT: 05:33:28 INFO - 2015-11-01 05:33:28,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:28 INFO - 2015-11-01 05:33:28,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 278564864 05:33:28 INFO - 2015-11-01 05:33:28,716 DEBUG : BROWSER_OUTPUT: 05:33:31 INFO - 2015-11-01 05:33:31,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial) 05:33:32 INFO - 2015-11-01 05:33:32,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 278056960 05:33:32 INFO - 2015-11-01 05:33:32,462 DEBUG : BROWSER_OUTPUT: 05:33:34 INFO - 2015-11-01 05:33:34,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:34 INFO - 2015-11-01 05:33:34,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 314544128 05:33:34 INFO - 2015-11-01 05:33:34,719 DEBUG : BROWSER_OUTPUT: 05:33:36 INFO - 2015-11-01 05:33:36,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:37 INFO - 2015-11-01 05:33:37,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 311504896 05:33:37 INFO - 2015-11-01 05:33:37,271 DEBUG : BROWSER_OUTPUT: 05:33:39 INFO - 2015-11-01 05:33:39,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:40 INFO - 2015-11-01 05:33:40,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 320958464 05:33:40 INFO - 2015-11-01 05:33:40,107 DEBUG : BROWSER_OUTPUT: 05:33:42 INFO - 2015-11-01 05:33:42,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:43 INFO - 2015-11-01 05:33:43,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 322613248 05:33:43 INFO - 2015-11-01 05:33:43,552 DEBUG : BROWSER_OUTPUT: 05:33:46 INFO - 2015-11-01 05:33:46,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:46 INFO - 2015-11-01 05:33:46,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 321736704 05:33:46 INFO - 2015-11-01 05:33:46,949 DEBUG : BROWSER_OUTPUT: 05:33:48 INFO - 2015-11-01 05:33:48,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49261/tests/kraken/driver.html?testName=ai-astar) 05:33:49 INFO - 2015-11-01 05:33:49,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 381644800 05:33:49 INFO - 2015-11-01 05:33:49,036 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:33:49 INFO - 2015-11-01 05:33:49,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:33:49 INFO - 2015-11-01 05:33:49,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;107;116;122;120;119;123;119;120;120 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;145;171;183;142;166;165;147;184;143 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |2;audio-dft;178;179;180;181;182;180;175;178;182;180 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;86;99;98;80;79;77;89;93;74 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;112;148;99;100;99;141;103;99;140 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;136;136;136;129;130;130;129;135;131 05:33:49 INFO - 2015-11-01 05:33:49,037 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;164;144;141;141;141;148;141;141;141 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;117;118;114;114;119;118;113;113;119 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;68;65;66;66;69;78;67;65 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;72;73;74;74;77;78;75;74;74 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;94;98;98;95;96;95;95;101;100 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;153;155;153;147;149;144;145;139;149 05:33:49 INFO - 2015-11-01 05:33:49,038 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;172;169;164;165;153;163;172;168;164 05:33:49 INFO - 2015-11-01 05:33:49,039 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;80;77;82;81;80;78;78;79 05:33:49 INFO - 2015-11-01 05:33:49,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:33:49 INFO - 2015-11-01 05:33:49,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:33:49 INFO - 2015-11-01 05:33:49,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,943 05:33:49 INFO - 2015-11-01 05:33:49,039 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1446384829034__endTimestamp 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:118.40 Median:120.00 stddev:4.45 (3.7%) stddev-sans-first:4.72 05:33:49 INFO - 2015-11-01 05:33:49,040 DEBUG : BROWSER_OUTPUT: Values: 118.0 107.0 116.0 122.0 120.0 119.0 123.0 119.0 120.0 120.0 05:33:49 INFO - 2015-11-01 05:33:49,041 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:161.40 Median:167.00 stddev:16.12 (9.7%) stddev-sans-first:16.92 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: Values: 168.0 145.0 171.0 183.0 142.0 166.0 165.0 147.0 184.0 143.0 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:179.50 Median:180.00 stddev:2.12 (1.2%) stddev-sans-first:2.18 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: Values: 178.0 179.0 180.0 181.0 182.0 180.0 175.0 178.0 182.0 180.0 05:33:49 INFO - 2015-11-01 05:33:49,042 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.00 Median:87.50 stddev:8.71 (9.9%) stddev-sans-first:9.23 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 99.0 98.0 80.0 79.0 77.0 89.0 93.0 74.0 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.00 Median:144.50 stddev:19.92 (13.8%) stddev-sans-first:21.01 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 148.0 99.0 100.0 99.0 141.0 103.0 99.0 140.0 05:33:49 INFO - 2015-11-01 05:33:49,043 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:132.80 Median:135.50 stddev:3.22 (2.4%) stddev-sans-first:3.21 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: Values: 136.0 136.0 136.0 136.0 129.0 130.0 130.0 129.0 135.0 131.0 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.40 Median:141.50 stddev:7.24 (5.1%) stddev-sans-first:7.63 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: Values: 142.0 164.0 144.0 141.0 141.0 141.0 148.0 141.0 141.0 141.0 05:33:49 INFO - 2015-11-01 05:33:49,044 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.90 Median:117.50 stddev:2.51 (2.1%) stddev-sans-first:2.57 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: Values: 114.0 117.0 118.0 114.0 114.0 119.0 118.0 113.0 113.0 119.0 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:4.23 (6.4%) stddev-sans-first:4.22 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 68.0 65.0 66.0 66.0 69.0 78.0 67.0 65.0 05:33:49 INFO - 2015-11-01 05:33:49,045 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:74.00 stddev:2.10 (2.8%) stddev-sans-first:1.88 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 74.0 74.0 77.0 78.0 75.0 74.0 74.0 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:95.50 stddev:2.35 (2.5%) stddev-sans-first:2.47 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 98.0 98.0 95.0 96.0 95.0 95.0 101.0 100.0 05:33:49 INFO - 2015-11-01 05:33:49,046 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:149.00 stddev:5.46 (3.7%) stddev-sans-first:5.09 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: Values: 140.0 153.0 155.0 153.0 147.0 149.0 144.0 145.0 139.0 149.0 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:5.54 (3.3%) stddev-sans-first:5.81 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: Values: 163.0 172.0 169.0 164.0 165.0 153.0 163.0 172.0 168.0 164.0 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:79.50 stddev:2.55 (3.2%) stddev-sans-first:1.76 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 80.0 77.0 82.0 81.0 80.0 78.0 78.0 79.0 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:33:49 INFO - 2015-11-01 05:33:49,048 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-01 05:33:49,734 INFO : Browser exited with error code: 0 05:33:49 INFO - 2015-11-01 05:33:49,787 INFO : Completed test kraken (00:01:00) 05:33:49 INFO - 2015-11-01 05:33:49,787 INFO : Starting test v8_7 05:33:49 INFO - 2015-11-01 05:33:49,787 DEBUG : operating with platform_type : mac_ 05:33:49 INFO - 2015-11-01 05:33:49,787 INFO : Initialising browser for v8_7 test... 05:33:49 INFO - 2015-11-01 05:33:49,801 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpcJlMml/profile http://localhost:49261/getInfo.html 05:33:52 INFO - 2015-11-01 05:33:52,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:33:52 INFO - 2015-11-01 05:33:52,106 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:33:52 INFO - 2015-11-01 05:33:52,106 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:33:52 INFO - 2015-11-01 05:33:52,106 DEBUG : BROWSER_OUTPUT: __metrics 05:33:52 INFO - 2015-11-01 05:33:52,123 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:52 INFO - 2015-11-01 05:33:52,857 INFO : Browser initialized. 05:33:52 INFO - 2015-11-01 05:33:52,857 INFO : Running cycle 1/1 for v8_7 test... 05:33:52 INFO - 2015-11-01 05:33:52,857 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpcJlMml/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:34:04 INFO - 2015-11-01 05:34:04,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 220663808 05:34:04 INFO - 2015-11-01 05:34:04,859 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/v8_7/run.html (next: http://localhost:49261/tests/v8_7/run.html) 05:34:27 INFO - 2015-11-01 05:34:27,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 715534336 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:34:27 INFO - 2015-11-01 05:34:27,990 DEBUG : BROWSER_OUTPUT: |0;Richards;185.2881230313137 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;220.40996253030636 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.01083032490976 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6477.419354838709 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2285.388127853881 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |5;Earley;1006.0362173038229 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |6;Boyer;14126.760563380281 05:34:27 INFO - 2015-11-01 05:34:27,991 DEBUG : BROWSER_OUTPUT: |7;RegExp;32741.935483870966 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: |8;Splay;861.3264427217915 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6458.064516129032 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: __startTimestamp1446384867988__endTimestamp 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,992 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.29 Median:185.29 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: Values: 185.3 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,993 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:220.41 Median:220.41 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,994 DEBUG : BROWSER_OUTPUT: Values: 220.4 05:34:27 INFO - 2015-11-01 05:34:27,994 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,994 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.01 Median:361.01 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,995 DEBUG : BROWSER_OUTPUT: Values: 361.0 05:34:27 INFO - 2015-11-01 05:34:27,995 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6477.42 Median:6477.42 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: Values: 6477.4 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2285.39 Median:2285.39 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: Values: 2285.4 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1006.04 Median:1006.04 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: Values: 1006.0 05:34:27 INFO - 2015-11-01 05:34:27,996 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14126.76 Median:14126.76 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: Values: 14126.8 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32741.94 Median:32741.94 stddev:0.00 (0.0%) 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: Values: 32741.9 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: 05:34:27 INFO - 2015-11-01 05:34:27,997 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:861.33 Median:861.33 stddev:0.00 (0.0%) 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: Values: 861.3 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6458.06 Median:6458.06 stddev:0.00 (0.0%) 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: Values: 6458.1 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:34:28 INFO - 2015-11-01 05:34:27,998 DEBUG : BROWSER_OUTPUT: 05:34:28 INFO - 2015-11-01 05:34:28,716 INFO : Browser exited with error code: 0 05:34:28 INFO - 2015-11-01 05:34:28,738 INFO : Completed test v8_7 (00:00:38) 05:34:29 INFO - 2015-11-01 05:34:29,240 INFO : Completed test suite (00:20:15) 05:34:29 INFO - 2015-11-01 05:34:29,241 DEBUG : Working with test: dromaeo_css 05:34:29 INFO - 2015-11-01 05:34:29,241 DEBUG : Generating results file: dromaeo_css 05:34:29 INFO - 2015-11-01 05:34:29,241 DEBUG : Working with test: kraken 05:34:29 INFO - 2015-11-01 05:34:29,242 DEBUG : Generating results file: kraken 05:34:29 INFO - 2015-11-01 05:34:29,242 INFO : javascript benchmark 05:34:29 INFO - 2015-11-01 05:34:29,242 DEBUG : Working with test: v8_7 05:34:29 INFO - 2015-11-01 05:34:29,242 DEBUG : Generating results file: v8_7 05:34:29 INFO - 2015-11-01 05:34:29,242 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:29 INFO - 2015-11-01 05:34:29,291 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:34:29 INFO - 2015-11-01 05:34:29,291 DEBUG : process_Request line: dromaeo_css 5939.22 graph.html#tests=[[72,1,55]] 05:34:29 INFO - 2015-11-01 05:34:29,291 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:29 INFO - 2015-11-01 05:34:29,320 DEBUG : process_Request line: kraken 1682.70 graph.html#tests=[[232,1,55]] 05:34:29 INFO - 2015-11-01 05:34:29,320 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:29 INFO - 2015-11-01 05:34:29,416 DEBUG : process_Request line: v8_7 16017.41 graph.html#tests=[[230,1,55]] 05:34:29 INFO - 2015-11-01 05:34:29,416 INFO : javascript benchmark 05:34:29 INFO - 2015-11-01 05:34:29,418 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [296.63662014032826, 298.4463819614615, 299.94151140527595, 306.8220432149352, 307.6246978686003, 12867.742645147091, 13266.204027758342, 14922.253887305633, 15597.688046239069, 16140.192990350479, 10628.202884783634, 10946.124310055196, 11021.0, 13153.539626113088, 15551.688966220669, 3500.527428797118, 4020.738651987626, 4025.657819085381, 4033.495813023372, 4047.4131250968594, 3009.9247518812094, 3120.9687903120907, 3862.5364956205153, 4069.9593004069875, 4244.172386384656, 4252.468441444819, 4274.615284624383, 4278.657707383401, 4299.247631664462, 4308.18144552534, 4169.353750168699, 4274.059706864485, 4274.337477690948, 4280.807363668611, 4321.0493691388, 3597.5143355646915, 3600.9099772505897, 3636.818159092035, 3640.0353906214873, 3648.1973965727498, 11904.523819047228, 11980.34108124053, 12154.513819447211, 12204.840540148673, 12285.508579656893, 1592.678077195936, 1712.152484520158, 1715.468204856486, 1717.7079896417515, 1814.8185181481879, 8615.913840861636, 8635.611397487128, 8717.912820871774, 8834.072422395684, 8891.599878005505, 1342.9261390623512, 1362.495876525682, 1374.6425929258364, 1381.1781989716103, 1383.2392184298697, 51504.48495515034, 53830.46169538294, 54338.0, 54630.0, 55485.44514554843, 5781.913271300849, 5817.040188368872, 5859.150423188614, 5896.262967129023, 5935.465808077208, 6610.603363798187, 6667.533272670964, 6669.966650166815, 6695.1965764107645, 6714.0, 4929.7781599828095, 5012.398512178489, 5016.3446062799185, 5021.171506701354, 5023.342297041967, 5408.45915408456, 5409.134538473825, 5475.0418676731415, 5476.315460567429, 5508.3114610673665, 2628.868556572164, 2636.8417894926365, 2639.1818536253822, 2645.4973555024485, 2668.893244270246, 913.7213149989184, 918.1552971266451, 923.7228831350568, 923.9029901860208, 987.160913223754, 338.8018009464491, 339.95750531183603, 377.70916394376724, 378.487149911871, 388.25261371859057, 9298.90701092994, 9641.325107242426, 9740.707778766648, 9803.264755143393, 9923.454210018519, 344.09159818080286, 360.9729270304685, 378.7481324918953, 382.2412511165335, 409.03263781157347, 5082.847514574569, 5106.693598384109, 5177.663451875616, 5220.973895130576, 5260.184671375943, 445216.0, 446734.0, 450089.0, 455500.0, 463738.0, 60476.0, 61377.0, 61965.38034619596, 62502.37497625056, 62537.68731156315, 404.4378314143343, 405.2745585402156, 405.6673527707252, 409.20818216750683, 409.86884197056656, 8841.513716745641, 8881.777955551162, 8894.731843379897, 8907.955460222658, 8977.10228977097, 29746.702532974392, 29811.552826707182, 29863.850680747328, 29921.251968700086, 29966.400671986874, 41753.0, 41866.79066604647, 42028.36957445702, 42155.0, 42937.57062429336, 5299.417064122867, 5558.055130627884, 5596.86007849807, 5609.635373700697, 5617.606767526234, 9995.70012899614, 10562.04941555233, 10592.152627789912, 10643.840342395026, 10655.733606659896, 7922.7227047053075, 7971.0, 8299.419040667095, 9096.363254572116, 9165.083491650781, 8659.48043117415, 8815.074417186102, 8817.823643526965, 9104.17916416706, 9158.175764181256, 8927.910720892707, 9123.452592844451, 9343.813123737624, 9373.1564159226, 9432.0, 5553.389127195925, 5554.583406244467, 5617.522510586646, 5625.88748225025, 5640.717964101696, 9088.54557272147, 9293.535323233677, 9337.71986840396, 9386.202172815387, 9386.530673466435], "dojo.html": [2833.8866445342187, 2913.0241369141336, 2919.2993681516427, 2925.254060214645, 2926.531754919213, 4716.985848042678, 4852.660313778037, 4853.684510506814, 4941.431735350431, 4992.7753251103695, 4825.276208568716, 4836.274558816171, 4884.951150488494, 4895.730734809584, 4921.852344429664, 4513.571210734975, 4574.8627541173655, 4584.862454126382, 4679.064187162581, 4698.64760142989, 4625.213713668684, 4635.235186194274, 4648.070385922812, 4684.578387945085, 4700.858974230779, 4403.251447253974, 4431.667624928111, 4510.030343476168, 4548.8862778430475, 4572.862814115599, 4541.568550987651, 4554.954450455486, 4591.265397536378, 4619.307103934403, 4655.580997710188, 4515.209838278321, 4544.363789069533, 4557.908841823145, 4564.246899261618, 4608.446986361624, 4645.512221216757, 4720.409948756405, 4729.26696362061, 4777.020710754287, 4812.254100614376, 5133.255677926717, 5195.246689230041, 5199.740012999335, 5216.426193118754, 5255.448177941299, 5225.608079394023, 5240.633155679104, 5291.1798671206025, 5296.232046353296, 5297.337832770903, 4728.38530990969, 4763.118823017753, 4780.569748722632, 4825.95174048255, 4895.0944075345815, 5263.921041184385, 5315.574754019669, 5326.893462130735, 5358.812441564526, 5376.91934620981, 5107.61692873036, 5124.5131712487255, 5151.665141765773, 5161.071007218661, 5207.817726379559, 5080.314157588678, 5099.69401835891, 5171.198464238049, 5201.973990130025, 5255.947440525622, 5198.298229739013, 5199.584033277329, 5206.713630750345, 5241.554467870197, 5279.260903473517, 5180.922286165711, 5210.21846722987, 5224.50367215114, 5230.137027390438, 5246.0, 3938.78336691479, 3940.842366305373, 4007.699422543321, 4020.276350256982, 4055.6755459563165, 3650.288193802236, 3679.7976111314133, 3687.3362794697214, 3695.7597756145765, 3741.5323084614424, 4809.0, 4814.470408255089, 4859.246816743411, 4871.34236878017, 4900.362952816111, 5110.156824124052, 5130.769115389817, 5234.18870075139, 5246.134387826042, 5261.552768014762, 4844.636652251095, 4857.587105096107, 4878.536539028786, 4935.75321233944, 4952.678075925125, 4552.931706024412, 4592.517785632527, 4626.259798432235, 4641.883952901205, 4644.187267228222, 5025.346704928336, 5043.798248070036, 5227.555657769132, 5235.4764523548865, 5312.282841816305, 5233.424323324355, 5258.50044245796, 5267.051930652366, 5291.417944026231, 5296.073187192149, 5226.529612334908, 5271.235670827785, 5304.681719096867, 5316.973415133054, 5348.973255133699, 4986.12742770021, 5020.698758074527, 5060.772265248146, 5117.0, 5167.793288268427, 5214.0, 5236.947630523646, 5271.551918087006, 5282.392524859691, 5295.046891559557, 4955.1823949048, 5086.3896332440345, 5140.0, 5145.768440420115, 5211.1922651989, 4935.062338155739, 4962.181240095344, 4993.675411098267, 5049.141645920129, 5081.415637201769, 4999.975000124976, 5012.172991456368, 5035.194368900959, 5046.596272298134, 5056.84829455117, 5132.5893928486375, 5139.203423469368, 5179.896402072013, 5185.040767458032, 5187.403448603308, 4777.140114779373, 4841.685290456109, 4908.312836203006, 4962.652614316963, 5065.012322597058], "mootools.html": [1148.5176225985097, 1489.664825414282, 1577.952661420157, 1594.6172918499556, 1611.3474043012577, 6343.619382837027, 6503.187101612299, 6800.863982720342, 7001.754938577151, 7024.613646249454, 6920.307969203077, 6936.271691472399, 6984.546004509703, 6987.30126987301, 7019.333163349486, 1972.4871533401276, 1986.682130859063, 1987.7316562264054, 1996.820286174244, 1998.9000549972443, 2009.6884982827612, 2020.171729590868, 2037.1240366642337, 2050.425880753384, 2070.8550401471903, 1939.4278687787066, 1953.4627977306213, 1953.687410014398, 1965.3219639224444, 1971.4381401300632, 1976.7331410259574, 1995.750531183602, 2008.68865325874, 2011.6580181369056, 2013.7986201379817, 1933.7002764571514, 1945.085809669453, 1954.7556555430572, 1956.3935180094074, 1967.8032196780207, 6161.199044124235, 6880.65596720162, 6908.550944188662, 6928.72285108595, 6946.895796563055, 3819.9809000955097, 4188.350805625133, 4240.703150779415, 4281.186574550826, 4282.678799090049, 2597.285746419731, 2623.22614828626, 2658.8138830281887, 2666.5066962611977, 2672.812903096784, 782.0576205672209, 803.9678412863478, 810.1372038778682, 820.7496713502379, 823.000054933253, 9003.0, 9104.499252541107, 9140.634374625008, 9149.54252287383, 9190.678326258549, 3871.6515513603913, 3878.6703130234246, 3930.0960779020415, 3936.0, 3938.665213456888, 8079.798005049804, 8104.189581041966, 8109.067457242375, 8125.878111828328, 8140.185981401813, 4354.912901741947, 4373.103513779667, 4399.428074350314, 4399.84600538986, 4400.889977750582, 3950.762954222756, 3977.900552486211, 3990.182012687392, 3992.580779018161, 4007.39889016644, 3134.467140586106, 3178.760283489441, 3181.1569933967517, 3189.888353907602, 3218.4045951499047, 984.2618036472645, 1020.2603112743202, 1023.2325755683238, 1023.6673081248624, 1023.9129673977646, 1177.264209868832, 1178.1046404732294, 1192.0106311761217, 1216.1061619709683, 1220.371508673034, 6559.934400656028, 6584.209894812653, 6588.439982601437, 6606.108175396356, 6673.799786006428, 346.107043826931, 349.2595697122117, 352.68082385441215, 353.92036791721654, 354.3692227834459, 5258.316418865523, 5285.339332583427, 5287.339082614673, 5324.494173053554, 5347.41178470368, 7426.183119856812, 7623.428242881806, 7933.920660793318, 8137.95931020353, 8139.38954578409, 8034.357251419872, 8038.919610803934, 8061.072976607648, 8070.435069545193, 8100.0, 6259.405356491217, 6393.552451328455, 6464.288928217892, 6478.222613286436, 6539.182602174728, 6496.382843629847, 6509.967450162719, 6530.8040758777315, 6575.112359831362, 6584.868302634016, 7156.606386648576, 7343.44924130703, 7381.11426628808, 7446.590437525988, 7447.962760186165, 7306.525075870051, 7475.962620186864, 7593.088829340514, 7666.6166691664075, 7689.3464055555905, 6128.938710612837, 6212.844678883064, 6217.129601855653, 6257.2491301044165, 6274.592151510137, 6425.06836508713, 6584.8353791155605, 6635.668216589248, 6639.170103737033, 6663.8667226654225, 6138.723757431016, 6230.376962303914, 6272.717727702173, 6281.497480201664, 6288.371162883675, 6088.391160883876, 6104.145419641165, 6180.196574445473, 6189.907151392643, 6248.0940263660605, 6147.477464415575, 6224.0, 6225.097360882737, 6284.591501552384, 6287.371262873676, 5638.633488823213, 5689.487946084872, 5749.080147176432, 5756.16535602327, 5759.481646651821, 5726.112452569859, 5791.0, 5799.217105690846, 5821.738021788945, 5850.444207800252], "ext.html": [503.0567685589519, 507.46969416959274, 510.80078769279964, 515.7215103843924, 534.9625526213161, 27912.0, 28997.27506812331, 35695.2860942781, 36219.0, 36422.8178859106, 38928.80535597325, 39028.219435611274, 39084.41373379402, 39322.60677393225, 39341.803290983575, 7378.815529611749, 8230.176982301768, 8377.0, 8401.453905496153, 8409.747707568782, 7456.291652293024, 9943.154831839267, 10096.29325947184, 10135.581018657394, 10180.185585153207, 9923.652672156475, 10066.899331006705, 10106.09045185933, 10112.140468060225, 10126.29115961883, 7598.20218877021, 7771.455998080137, 9995.75010624733, 10008.249381296395, 10030.197584193247, 9729.464879431629, 9861.260405469618, 9865.852012219822, 9876.90123098767, 9893.4558599277, 35042.29915401703, 35438.468422973674, 35471.4679279811, 35526.82236588826, 35637.643623563694, 2587.120379071106, 2623.973760262392, 2636.525425423423, 2703.553913604253, 2735.1967252874506, 24635.38411539708, 25285.0, 25486.74513254862, 26042.609360859602, 26125.216243512536, 2154.450615093141, 2166.6425039868404, 2180.5965896309235, 2190.113004233288, 2288.645259984705, 230428.0, 235972.0, 237197.0, 237246.0, 238456.0, 51304.48695513072, 52600.736996315536, 59279.0, 66337.33662663311, 67389.66305168443, 62965.0, 64206.0, 64446.35553644497, 64486.6775666128, 64489.35510644833, 15552.533423997298, 15735.921320393325, 15752.606184845241, 15838.0, 15891.682166356608, 11699.415029248503, 11792.587259445878, 11825.645230643095, 11829.526818927146, 11852.525898964117, 19995.100220490112, 20202.89898550527, 20248.29130980438, 20253.189872405233, 20373.898130509548, 8496.107908669625, 8706.869396959051, 8735.25750311218, 8736.344774141964, 8801.471911685192, 824.6866190847439, 911.977200569991, 937.840567103594, 994.1549682769732, 1027.5427434791595, 25299.74700252974, 25469.490610188062, 25597.0, 25781.74218257831, 25786.226413207634, 927.638221093774, 948.393028461785, 955.4506158958627, 1006.2855372685475, 1045.954045954046, 13240.139390939557, 13375.264360460269, 13412.530561430303, 13503.932480337731, 13523.729525409437, 264004.0, 268821.0, 269456.0, 270650.0, 271292.0, 48727.269090963666, 49147.0, 49165.0, 49213.261801073015, 49257.26114108291, 1183.6153250193722, 1206.5361489153595, 1230.8153776933532, 1232.870548592385, 1233.8766123387588, 24841.875790621652, 25419.74580254248, 25425.745742542338, 25441.363965901, 25448.872755636843, 39113.217735645696, 39744.2051158981, 43544.34683479687, 43964.34053489264, 44061.0, 244674.0, 248027.0, 252702.0, 253063.0, 253293.0, 29537.0, 29858.0, 29883.70116298896, 29967.70032299649, 30077.248068798453, 38075.0, 38650.80674596722, 38671.71958303547, 38968.0, 39280.607193927695, 31592.842035789676, 34846.825765871006, 35463.82268088643, 36133.0, 36283.0, 32240.0, 32442.83778581092, 32588.83705581457, 32628.34743305073, 32694.67305326916, 33084.834575826964, 35194.120146995505, 36626.63373366339, 36730.081747955446, 36948.815255923546, 26554.336141596614, 29017.854910725313, 29178.854105729337, 29302.853485732434, 29435.411291773617, 22444.88777556102, 22482.213122540634, 22503.324900253017, 22584.88707556452, 22714.772852271264], "prototype.html": [275.8730983747476, 281.95347767618347, 282.3689054962159, 285.8285028982609, 290.7223601460605, 5406.162044883049, 5474.151506516491, 5491.697956612385, 5513.72431378431, 5559.805406810762, 5167.0, 5237.659552129109, 5258.079836028699, 5301.814436494714, 5426.8914621707645, 4191.287481128215, 4206.894827629319, 4207.474065741782, 4233.936490952623, 4235.894102647428, 4245.448091748069, 4247.193033323674, 4250.0862314602355, 4253.893652658693, 4259.723117997336, 4063.0654949361665, 4091.488563929509, 4148.2947898857265, 4196.055887425336, 4199.9580004200025, 4188.874333769962, 4189.49726032878, 4199.55904630014, 4201.432806571104, 4234.153169366108, 3624.800635965021, 3631.5279013728045, 3635.4910312556262, 3643.143861192644, 3648.945265821015, 5272.6836389816735, 5281.287026251445, 5290.709011004393, 5301.125314323132, 5307.681539107666, 4539.409876716006, 4635.397398338228, 4685.203515402356, 4743.02767932573, 4749.548792864673, 5725.885482290372, 5743.856403589902, 5752.252207213078, 5756.453136952025, 5771.538276937835, 3809.676177524914, 3868.9806550967346, 3896.376579747227, 3910.432987216838, 3919.451276821247, 5927.2590926134235, 5985.820425387245, 5996.730147143389, 5996.8500787480225, 6012.999999999956, 3890.533136023695, 3954.070793363557, 3954.54522729884, 3962.9405558916637, 3997.2605068062503, 4018.296798060386, 4024.657904078186, 4057.4928133983253, 4064.4716186895516, 4067.2272268268935, 4663.696859704109, 4664.323673067454, 4685.156671799109, 4723.716577005322, 4732.574068333866, 5708.628939118944, 5711.571632127607, 5740.598158128891, 5760.510356619734, 5766.04860198071, 1396.427464739452, 1422.9359678814271, 1423.7935499352536, 1438.719449707297, 1444.4655477473193, 901.0583939782942, 909.4588719711761, 910.4082346474844, 916.5554705967601, 947.9952600236954, 5426.430224826416, 5428.457154284619, 5433.972830135903, 5442.591805614595, 5458.699771512525, 5923.466887980103, 5966.373530779292, 5967.582269241198, 5981.342052374235, 5990.371011043865, 5206.193040078794, 5333.253344531769, 5346.91979620306, 5433.429489903503, 5454.372747134051, 3254.4792833146585, 3282.343531293751, 3289.7697161198485, 3298.5546951161764, 3306.88425905097, 6024.728887200086, 6055.7274922628585, 6100.69496525172, 6102.816915492543, 6129.540284478682, 6021.849453763603, 6133.0800379942475, 6167.383261673796, 6172.074188871705, 6217.782377616762, 6017.157597936205, 6045.818625441244, 6054.909176362358, 6061.727222275008, 6063.514918806573, 6021.307549631673, 6022.849428764316, 6032.125341825498, 6032.638041717511, 6054.0, 5876.412358764261, 5887.028640274307, 5888.558358123072, 5891.617044892068, 5907.822765317047, 5883.764649414146, 6064.545159113172, 6070.696465176635, 6079.240094988127, 6093.756249750138, 3958.802059897051, 3968.940465892956, 3969.64273215412, 3972.980135099306, 3977.980110099431, 5982.282126144891, 5994.460498555151, 6007.219061521974, 6011.428914253139, 6057.515398768176, 5652.576056795675, 5760.337561180518, 5832.12518122285, 5837.182794408871, 5848.912266315923, 5789.56578256624, 5804.65172089676, 5840.970795145997, 5849.1226316052935, 5884.411558844253, 5668.546516278605, 5680.431956804452, 5682.261306030189, 5699.23060386859, 5730.598858080061, 5691.223000074708, 5805.071188609802, 5823.126531020381, 5829.679367634821, 5869.090291004901, 5703.600747947769, 5710.029295019774, 5719.084946408555, 5726.856828579319, 5734.770609175753], "yui.html": [650.1612919334059, 687.5977553131418, 692.5567636712505, 700.9065857262674, 709.705472229025, 11662.06703463723, 12348.259104453738, 12401.0, 12404.069694772894, 12422.565210217645, 11673.1828771986, 11767.646970590875, 11768.117391195652, 11807.645770626874, 11867.050635949125, 632.7216024949031, 648.8929326661096, 788.9921100789005, 809.7044578728751, 812.0620683110986, 637.3435361577582, 797.6291024673526, 802.4663598706853, 818.7707441916243, 820.5733018830234, 831.1397703377006, 857.3869683176528, 857.5026484638895, 858.3047731337637, 866.2809867809702, 678.1895634716516, 689.300360134464, 840.6595328891808, 845.2012847858776, 859.4886042804552, 634.4670476799464, 635.5043066408163, 635.7647670361949, 635.9109724638554, 636.3541005879036, 11050.171237157245, 11115.0, 11175.21773475857, 11208.887911120866, 11270.943645281803, 10454.581816727321, 10506.527206275736, 10646.414447205401, 11142.387168705718, 11240.49417776202, 7994.880076798852, 8223.450730273635, 8272.0, 8533.615987280587, 8852.645894164225, 2969.9703002970127, 3025.7125573070525, 3063.2801291696433, 3090.8763649453995, 3120.188750924753, 45206.095878082255, 46508.767456162845, 46541.76729116367, 46547.53452465466, 46582.76708616469, 8211.876821847676, 8253.546054966915, 8289.129641387688, 8398.41211115216, 8455.154484551618, 17745.378911738284, 17757.289708411517, 17763.911180444014, 17773.377931772327, 17815.643687126445, 6502.44729198014, 6566.835829104215, 6582.868342633121, 6698.66506674674, 6827.761028363983, 3247.382997230519, 3267.330197309546, 3287.342531493711, 3319.4321997801085, 3343.2310568569364, 2651.549236629739, 2711.240852561286, 2718.184544636601, 2718.9184324470298, 2723.264718525987, 382.94638750574944, 388.4328879835472, 392.01212943383086, 393.41381341800513, 393.8582110440239, 506.5213373362211, 515.3223511082914, 550.9944900551023, 560.2940295228042, 563.4759673503681, 6842.144731908512, 7142.392896603847, 7566.281203285679, 7724.227577242344, 7834.334081603013, 370.55348305292057, 469.9459562150328, 504.5106246940462, 526.5050852198997, 586.3608666553478, 3169.3344397676283, 3377.071305390988, 3524.718022558189, 3548.9822550887598, 3565.2965854969552, 53308.0, 53391.19913201305, 53402.73298633482, 53876.73061634667, 53941.460585393645, 46153.0, 46730.299045514344, 46759.0, 47039.0, 47156.292655610196, 41953.16093678171, 42151.57848421538, 42487.57512424836, 42548.0, 43343.34984975228, 6421.422072013354, 6491.675416229265, 6579.506537009648, 6636.668166591748, 6661.700223489857, 29726.405471890874, 30375.848120759256, 30423.847880760455, 32618.673813261565, 33029.17427064342, 40550.39174412327, 40908.1818363637, 41377.1724565501, 42492.78753606212, 42572.0, 6802.523823332517, 6841.863162736618, 6852.789353808667, 6915.308469153045, 7003.404710599452, 9910.702678919644, 10066.748331291776, 10124.59501619927, 10149.695509134737, 10198.796024079329, 9558.044195580664, 9617.51912404363, 9624.807503850025, 9633.036696330311, 9638.084381983701, 9447.149756521945, 9557.23542116643, 9572.9042709572, 9578.521073946415, 9607.0, 9146.359754817098, 9355.812883742423, 9371.203447707021, 9383.296252781205, 9445.0, 8006.919930800617, 8173.34613230952, 8609.65561377538, 8615.3107751381, 8687.478751274944, 8200.584409463814, 8303.709370172015, 8330.958345208235, 8536.74389768308, 8558.614862331335]}, "summary": {"suite": 5939.219474279888, "subtests": {"jquery.html": {"filtered": 5815.913731500809, "value": 5815.913731500809}, "dojo.html": {"filtered": 4822.1244235388385, "value": 4822.1244235388385}, "mootools.html": {"filtered": 3874.9537257723578, "value": 3874.9537257723578}, "ext.html": {"filtered": 17193.534441016076, "value": 17193.534441016076}, "prototype.html": {"filtered": 4316.2606151656555, "value": 4316.2606151656555}, "yui.html": {"filtered": 5441.72745920637, "value": 5441.72745920637}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1446383654, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151101030343", "branch": "Firefox", "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98"}}, {"talos_counters": {}, "results": {"audio-dft": [178.0, 179.0, 180.0, 181.0, 182.0, 180.0, 175.0, 178.0, 182.0, 180.0], "ai-astar": [118.0, 107.0, 116.0, 122.0, 120.0, 119.0, 123.0, 119.0, 120.0, 120.0], "imaging-gaussian-blur": [136.0, 136.0, 136.0, 136.0, 129.0, 130.0, 130.0, 129.0, 135.0, 131.0], "audio-beat-detection": [168.0, 145.0, 171.0, 183.0, 142.0, 166.0, 165.0, 147.0, 184.0, 143.0], "json-stringify-tinderbox": [71.0, 72.0, 73.0, 74.0, 74.0, 77.0, 78.0, 75.0, 74.0, 74.0], "stanford-crypto-pbkdf2": [163.0, 172.0, 169.0, 164.0, 165.0, 153.0, 163.0, 172.0, 168.0, 164.0], "json-parse-financial": [63.0, 64.0, 68.0, 65.0, 66.0, 66.0, 69.0, 78.0, 67.0, 65.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 80.0, 77.0, 82.0, 81.0, 80.0, 78.0, 78.0, 79.0], "audio-fft": [85.0, 86.0, 99.0, 98.0, 80.0, 79.0, 77.0, 89.0, 93.0, 74.0], "imaging-darkroom": [142.0, 164.0, 144.0, 141.0, 141.0, 141.0, 148.0, 141.0, 141.0, 141.0], "stanford-crypto-ccm": [140.0, 153.0, 155.0, 153.0, 147.0, 149.0, 144.0, 145.0, 139.0, 149.0], "audio-oscillator": [109.0, 112.0, 148.0, 99.0, 100.0, 99.0, 141.0, 103.0, 99.0, 140.0], "stanford-crypto-aes": [96.0, 94.0, 98.0, 98.0, 95.0, 96.0, 95.0, 95.0, 101.0, 100.0], "imaging-desaturate": [114.0, 117.0, 118.0, 114.0, 114.0, 119.0, 118.0, 113.0, 113.0, 119.0]}, "summary": {"suite": 1682.6999999999998, "subtests": {"audio-fft": {"filtered": 86.0, "value": 86.0}, "stanford-crypto-pbkdf2": {"filtered": 165.3, "value": 165.3}, "audio-beat-detection": {"filtered": 161.4, "value": 161.4}, "stanford-crypto-ccm": {"filtered": 147.4, "value": 147.4}, "imaging-darkroom": {"filtered": 144.4, "value": 144.4}, "json-parse-financial": {"filtered": 67.1, "value": 67.1}, "audio-oscillator": {"filtered": 115.0, "value": 115.0}, "ai-astar": {"filtered": 118.4, "value": 118.4}, "audio-dft": {"filtered": 179.5, "value": 179.5}, "stanford-crypto-sha256-iterative": {"filtered": 78.5, "value": 78.5}, "json-stringify-tinderbox": {"filtered": 74.2, "value": 74.2}, "imaging-gaussian-blur": {"filtered": 132.8, "value": 132.8}, "stanford-crypto-aes": {"filtered": 96.8, "value": 96.8}, "imaging-desaturate": {"filtered": 115.9, "value": 115.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1446383654, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151101030343", "branch": "Firefox", "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98"}}, {"talos_counters": {}, "results": {"DeltaBlue": [220.40996253030636], "Encrypt": [361.01083032490976], "NavierStokes": [6458.064516129032], "Decrypt": [6477.419354838709], "Splay": [861.3264427217915], "Richards": [185.2881230313137], "RegExp": [32741.935483870966], "Earley": [1006.0362173038229], "Boyer": [14126.760563380281], "RayTrace": [2285.388127853881]}, "summary": {"suite": 16017.414403712877, "subtests": {"DeltaBlue": {"filtered": 299.977366, "value": 299.977366}, "Encrypt": {"filtered": 737.32137, "value": 737.32137}, "NavierStokes": {"filtered": 229.79020979020973, "value": 229.79020979020973}, "Decrypt": {"filtered": 41.093680278884456, "value": 41.093680278884456}, "Splay": {"filtered": 94.61105099999997, "value": 94.61105099999997}, "RegExp": {"filtered": 27.823187192118223, "value": 27.823187192118223}, "Richards": {"filtered": 190.52489399999993, "value": 190.52489399999993}, "Earley": {"filtered": 662.4642219999998, "value": 662.4642219999998}, "Boyer": {"filtered": 47.17734097706878, "value": 47.17734097706878}, "RayTrace": {"filtered": 323.79139060939053, "value": 323.79139060939053}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1446383654, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151101030343", "branch": "Firefox", "revision": "96377bdbcdf3e444a22aeaa677da696243b00d98"}}] 05:34:29 INFO - RETURN: dromaeo_css: 5939.22 05:34:29 INFO - RETURN: kraken: 1682.70 05:34:29 INFO - RETURN: v8_7: 16017.41 05:34:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16017.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1682.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5939.22"}}} 05:34:29 INFO - Return code: 0 05:34:29 INFO - # TBPL SUCCESS # 05:34:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:29 INFO - 2015-11-01 05:34:29.520 screenresolution[1661:10011] starting screenresolution argv=screenresolution get 05:34:29 INFO - 2015-11-01 05:34:29.523 screenresolution[1661:10011] Display 0: 1600x1200x32@60 05:34:29 INFO - 2015-11-01 05:34:29.529 screenresolution[1662:10014] starting screenresolution argv=screenresolution list 05:34:29 INFO - Available Modes on Display 0 05:34:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:29 INFO - Intel HD Graphics 3000: 05:34:29 INFO - Chipset Model: Intel HD Graphics 3000 05:34:29 INFO - Type: GPU 05:34:29 INFO - Bus: Built-In 05:34:29 INFO - VRAM (Total): 512 MB 05:34:29 INFO - VRAM (Dynamic, Max): 10 05:34:29 INFO - Vendor: Intel (0x8086) 05:34:29 INFO - Device ID: 0x0116 05:34:29 INFO - Revision ID: 0x0009 05:34:29 INFO - Displays: 05:34:29 INFO - Display: 05:34:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:29 INFO - Display Serial Number: 1600x1200 60 05:34:29 INFO - Main Display: Yes 05:34:29 INFO - Mirror: Off 05:34:29 INFO - Online: Yes 05:34:29 INFO - Rotation: Supported 05:34:29 INFO - Return code: 0 05:34:29 INFO - Running post-action listener: _resource_record_post_action 05:34:29 INFO - Running post-run listener: _resource_record_post_run 05:34:30 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 38753280; Write bytes: 689199104; Read time: 4790; Write time: 51806 05:34:30 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 334234112; Write bytes: 336920576; Read time: 34281; Write time: 6448 05:34:30 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 37835776; Write bytes: 341915648; Read time: 4312; Write time: 44322 05:34:30 INFO - Running post-run listener: _upload_blobber_files 05:34:30 INFO - Blob upload gear active. 05:34:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:34:30 INFO - Copying logs to upload dir... 05:34:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1341.494839 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-01 05:34:30.948012) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-01 05:34:30.951930) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010528 build_url: 'https://queue.taskcluster.net/v1/task/ucGctgn-QEaRgDZ_ipnkAA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-01 05:34:30.978387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:34:30.978753) ========= 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.ei8v3U3Qch/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.eERX6v5Ndc/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005325 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-01 05:34:31.028590) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-11-01 05:34:31.028930) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-11-01 05:34:32.839145) ========= ========= Total master_lag: 0.23 =========