builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0054 starttime: 1446753040.88 results: success (0) buildid: 20151105102536 builduid: a3f02c5e30134e359f8dc6214a1f9746 revision: 14fe585860cabf63c59dbaabe942e2a621f7e9ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:40.876878) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:40.877403) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:40.878411) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.006075 basedir: '/builds/slave/test' ========= master_lag: 0.54 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.421607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.421904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.525822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.526078) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.038914 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.615204) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.615466) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.621480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.621931) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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-05 11:50:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.4M=0s 2015-11-05 11:50:41 (65.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178131 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.843991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.844278) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.066869 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.949822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:41.950200) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14fe585860cabf63c59dbaabe942e2a621f7e9ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14fe585860cabf63c59dbaabe942e2a621f7e9ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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-05 11:50:42,051 truncating revision to first 12 chars 2015-11-05 11:50:42,051 Setting DEBUG logging. 2015-11-05 11:50:42,051 attempt 1/10 2015-11-05 11:50:42,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/14fe585860ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 11:50:42,314 unpacking tar archive at: mozilla-inbound-14fe585860ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771834 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:42.750521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:42.750877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:42.766903) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:42.767202) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 11:50:42.767630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-05 11:50:42.767921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:50:43 INFO - MultiFileLogger online at 20151105 11:50:43 in /builds/slave/test 11:50:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:50:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:43 INFO - {'append_to_log': False, 11:50:43 INFO - 'base_work_dir': '/builds/slave/test', 11:50:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:50:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:43 INFO - 'branch': 'Mozilla-Inbound', 11:50:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:43 INFO - 'config_files': ('talos/mac_config.py',), 11:50:43 INFO - 'default_actions': ('clobber', 11:50:43 INFO - 'read-buildbot-config', 11:50:43 INFO - 'download-and-extract', 11:50:43 INFO - 'populate-webroot', 11:50:43 INFO - 'create-virtualenv', 11:50:43 INFO - 'install', 11:50:43 INFO - 'run-tests'), 11:50:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:43 INFO - 'download_minidump_stackwalk': True, 11:50:43 INFO - 'download_symbols': 'ondemand', 11:50:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:43 INFO - 'installer_path': 'installer.exe', 11:50:43 INFO - 'log_level': 'info', 11:50:43 INFO - 'log_name': 'talos', 11:50:43 INFO - 'log_to_console': True, 11:50:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:50:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:50:43 INFO - 'opt_config_files': (), 11:50:43 INFO - 'pip_index': False, 11:50:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:43 INFO - 'cmd': ('bash', 11:50:43 INFO - '-c', 11:50:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:43 INFO - 'enabled': True, 11:50:43 INFO - 'halt_on_failure': False, 11:50:43 INFO - 'name': 'check_screen_resolution'},), 11:50:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:43 INFO - 'cmd': ('bash', 11:50:43 INFO - '-c', 11:50:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:43 INFO - 'enabled': True, 11:50:43 INFO - 'halt_on_failure': False, 11:50:43 INFO - 'name': 'check_screen_resolution'},), 11:50:43 INFO - 'run_cmd_checks_enabled': True, 11:50:43 INFO - 'sps_profile': False, 11:50:43 INFO - 'sps_profile_interval': 0, 11:50:43 INFO - 'suite': 'dromaeojs-e10s', 11:50:43 INFO - 'system_bits': '64', 11:50:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:43 INFO - 'title': 't-yosemite-r5-0054', 11:50:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:43 INFO - 'use_talos_json': True, 11:50:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:43 INFO - 'work_dir': 'build'} 11:50:43 INFO - ##### 11:50:43 INFO - ##### Running clobber step. 11:50:43 INFO - ##### 11:50:43 INFO - Running pre-action listener: _resource_record_pre_action 11:50:43 INFO - Running main action method: clobber 11:50:43 INFO - rmtree: /builds/slave/test/build 11:50:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:47 INFO - Running post-action listener: _resource_record_post_action 11:50:47 INFO - ##### 11:50:47 INFO - ##### Running read-buildbot-config step. 11:50:47 INFO - ##### 11:50:47 INFO - Running pre-action listener: _resource_record_pre_action 11:50:47 INFO - Running main action method: read_buildbot_config 11:50:47 INFO - Using buildbot properties: 11:50:47 INFO - { 11:50:47 INFO - "properties": { 11:50:47 INFO - "buildnumber": 22, 11:50:47 INFO - "product": "firefox", 11:50:47 INFO - "script_repo_revision": "production", 11:50:47 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 11:50:47 INFO - "repository": "", 11:50:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 11:50:47 INFO - "buildid": "20151105102536", 11:50:47 INFO - "slavename": "t-yosemite-r5-0054", 11:50:47 INFO - "pgo_build": "False", 11:50:47 INFO - "basedir": "/builds/slave/test", 11:50:47 INFO - "project": "", 11:50:47 INFO - "platform": "yosemite", 11:50:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:50:47 INFO - "slavebuilddir": "test", 11:50:47 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 11:50:47 INFO - "branch": "mozilla-inbound", 11:50:47 INFO - "repo_path": "integration/mozilla-inbound", 11:50:47 INFO - "stage_platform": "macosx64", 11:50:47 INFO - "builduid": "a3f02c5e30134e359f8dc6214a1f9746", 11:50:47 INFO - "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea" 11:50:47 INFO - }, 11:50:47 INFO - "sourcestamp": { 11:50:47 INFO - "repository": "", 11:50:47 INFO - "hasPatch": false, 11:50:47 INFO - "project": "", 11:50:47 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:50:47 INFO - "changes": [ 11:50:47 INFO - { 11:50:47 INFO - "category": null, 11:50:47 INFO - "files": [ 11:50:47 INFO - { 11:50:47 INFO - "url": null, 11:50:47 INFO - "name": "https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:50:47 INFO - } 11:50:47 INFO - ], 11:50:47 INFO - "repository": "", 11:50:47 INFO - "rev": "14fe585860cabf63c59dbaabe942e2a621f7e9ea", 11:50:47 INFO - "who": "mchang@mozilla.com", 11:50:47 INFO - "when": 1446752968, 11:50:47 INFO - "number": 6626371, 11:50:47 INFO - "comments": "Bug 1221697 - Add a telemetry probe for time-to-composite. r=kats", 11:50:47 INFO - "project": "", 11:50:47 INFO - "at": "Thu 05 Nov 2015 11:49:28", 11:50:47 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:50:47 INFO - "revlink": "", 11:50:47 INFO - "properties": [ 11:50:47 INFO - [ 11:50:47 INFO - "buildid", 11:50:47 INFO - "20151105102536", 11:50:47 INFO - "Change" 11:50:47 INFO - ], 11:50:47 INFO - [ 11:50:47 INFO - "builduid", 11:50:47 INFO - "a3f02c5e30134e359f8dc6214a1f9746", 11:50:47 INFO - "Change" 11:50:47 INFO - ], 11:50:47 INFO - [ 11:50:47 INFO - "pgo_build", 11:50:47 INFO - "False", 11:50:47 INFO - "Change" 11:50:47 INFO - ] 11:50:47 INFO - ], 11:50:47 INFO - "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea" 11:50:47 INFO - } 11:50:47 INFO - ], 11:50:47 INFO - "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea" 11:50:47 INFO - } 11:50:47 INFO - } 11:50:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:50:47 INFO - Running post-action listener: _resource_record_post_action 11:50:47 INFO - ##### 11:50:47 INFO - ##### Running download-and-extract step. 11:50:47 INFO - ##### 11:50:47 INFO - Running pre-action listener: _resource_record_pre_action 11:50:47 INFO - Running main action method: download_and_extract 11:50:47 INFO - mkdir: /builds/slave/test/build/tests 11:50:47 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')]} 11:50:47 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/test_packages.json 11:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/test_packages.json 11:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:50:48 INFO - Downloaded 1149 bytes. 11:50:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:50:49 INFO - Using the following test package requirements: 11:50:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:50:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:50:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'jsshell-mac.zip'], 11:50:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:50:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:50:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:50:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:50:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:50:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:50:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:50:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:50:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:49 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:50:54 INFO - Downloaded 17460874 bytes. 11:50:54 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 11:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:50:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:50:59 INFO - Return code: 0 11:50:59 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 11:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:59 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:51:05 INFO - Downloaded 17460874 bytes. 11:51:05 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 11:51:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:51:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:51:10 INFO - Return code: 0 11:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:10 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:51:12 INFO - Downloaded 11131450 bytes. 11:51:12 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 11:51:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:51:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:51:12 INFO - Return code: 0 11:51: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')]} 11:51:12 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:51:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:51:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:51:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:51:17 INFO - Downloaded 108680507 bytes. 11:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:51:17 INFO - mkdir: /builds/slave/test/properties 11:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:17 INFO - Contents: 11:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:51:17 INFO - Running post-action listener: _resource_record_post_action 11:51:17 INFO - Running post-action listener: set_extra_try_arguments 11:51:17 INFO - ##### 11:51:17 INFO - ##### Running populate-webroot step. 11:51:17 INFO - ##### 11:51:17 INFO - Running pre-action listener: _resource_record_pre_action 11:51:17 INFO - Running main action method: populate_webroot 11:51:17 INFO - Guessing talos json url... 11:51:17 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')]} 11:51:17 INFO - https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 11:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 11:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 11:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 11:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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 11:51:18 INFO - Downloaded 111 bytes. 11:51:18 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 11:51:18 INFO - Contents: 11:51:18 INFO - 20151105102536 11:51:18 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/14fe585860cabf63c59dbaabe942e2a621f7e9ea 11:51: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')]} 11:51:18 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/14fe585860/testing/talos/talos.json 11:51:18 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/14fe585860/testing/talos/talos.json to /builds/slave/test/build/talos.json 11:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/14fe585860/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 11:51:19 INFO - Downloaded 4264 bytes. 11:51:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:51:19 INFO - '../fennec_ids.txt'], 11:51:19 INFO - 'tests': ['tcheck2']}, 11:51:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:19 INFO - '--tppagecycles', 11:51:19 INFO - '7'], 11:51:19 INFO - 'tests': ['tsvgm']}}, 11:51:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:51:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:51:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:51:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'tests': ['damp', 'tps']}, 11:51:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['damp', 'tps']}, 11:51:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:19 INFO - 'other': {'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'other_l64': {'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'other_nol64': {'tests': ['a11yr', 11:51:19 INFO - 'ts_paint', 11:51:19 INFO - 'tpaint', 11:51:19 INFO - 'sessionrestore', 11:51:19 INFO - 'sessionrestore_no_auto_restore']}, 11:51:19 INFO - 'svgr': {'tests': ['tsvgx', 11:51:19 INFO - 'tsvgr_opacity', 11:51:19 INFO - 'tart', 11:51:19 INFO - 'tscrollx', 11:51:19 INFO - 'cart']}, 11:51:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['tsvgx', 11:51:19 INFO - 'tsvgr_opacity', 11:51:19 INFO - 'tart', 11:51:19 INFO - 'tscrollx', 11:51:19 INFO - 'cart']}, 11:51:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'tests': ['tp5o']}, 11:51:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'talos_options': ['--e10s'], 11:51:19 INFO - 'tests': ['tp5o']}, 11:51:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'talos_options': ['--xperf_path', 11:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:19 INFO - 'tests': ['tp5n']}, 11:51:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:19 INFO - 'talos_options': ['--e10s', 11:51:19 INFO - '--xperf_path', 11:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 11:51:19 INFO - 'C:/slave/talos-data/talos/xperf.config'], 11:51:19 INFO - 'tests': ['tp5n']}}, 11:51:19 INFO - 'talos.zip': {'path': '', 11:51:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:19 INFO - Running post-action listener: _resource_record_post_action 11:51:19 INFO - ##### 11:51:19 INFO - ##### Running create-virtualenv step. 11:51:19 INFO - ##### 11:51:19 INFO - Running pre-action listener: _resource_record_pre_action 11:51:19 INFO - Running main action method: create_virtualenv 11:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:19 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 11:51:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:19 INFO - Using real prefix '/tools/python27' 11:51:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:24 INFO - Installing pip.................done. 11:51:24 INFO - Return code: 0 11:51:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:24 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:24 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 11:51:24 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 11:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:24 INFO - 'HOME': '/Users/cltbld', 11:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:24 INFO - 'LOGNAME': 'cltbld', 11:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:24 INFO - 'MOZ_NO_REMOTE': '1', 11:51:24 INFO - 'NO_EM_RESTART': '1', 11:51:24 INFO - 'PAGER': '/bin/cat', 11:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:24 INFO - 'PWD': '/builds/slave/test', 11:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:24 INFO - 'SHELL': '/bin/bash', 11:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:24 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:24 INFO - 'USER': 'cltbld', 11:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:24 INFO - 'XPC_FLAGS': '0x0', 11:51:24 INFO - 'XPC_SERVICE_NAME': '0', 11:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:25 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 11:51:25 INFO - Cleaning up... 11:51:25 INFO - Return code: 0 11:51:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:25 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:25 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 11:51:25 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 11:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:25 INFO - 'HOME': '/Users/cltbld', 11:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:25 INFO - 'LOGNAME': 'cltbld', 11:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:25 INFO - 'MOZ_NO_REMOTE': '1', 11:51:25 INFO - 'NO_EM_RESTART': '1', 11:51:25 INFO - 'PAGER': '/bin/cat', 11:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:25 INFO - 'PWD': '/builds/slave/test', 11:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:25 INFO - 'SHELL': '/bin/bash', 11:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:25 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:25 INFO - 'USER': 'cltbld', 11:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:25 INFO - 'XPC_FLAGS': '0x0', 11:51:25 INFO - 'XPC_SERVICE_NAME': '0', 11:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:25 INFO - Downloading/unpacking psutil>=0.7.1 11:51:25 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 11:51:25 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 11:51:25 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 11:51:25 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 11:51:25 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 11:51:25 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 11:51:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:51:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:28 INFO - Installing collected packages: psutil 11:51:28 INFO - Running setup.py install for psutil 11:51:28 INFO - building 'psutil._psutil_osx' extension 11:51:28 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 11:51:29 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 11:51:30 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 11:51:30 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 11:51:30 INFO - building 'psutil._psutil_posix' extension 11:51:30 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 11:51:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:51:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:51:30 INFO - ^ 11:51:30 INFO - 1 warning generated. 11:51:30 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 11:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:30 INFO - Successfully installed psutil 11:51:30 INFO - Cleaning up... 11:51:30 INFO - Return code: 0 11:51:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:51:30 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')]} 11:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:30 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')]} 11:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:30 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:30 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 11:51:30 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 11:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:30 INFO - 'HOME': '/Users/cltbld', 11:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:30 INFO - 'LOGNAME': 'cltbld', 11:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:30 INFO - 'MOZ_NO_REMOTE': '1', 11:51:30 INFO - 'NO_EM_RESTART': '1', 11:51:30 INFO - 'PAGER': '/bin/cat', 11:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:30 INFO - 'PWD': '/builds/slave/test', 11:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:30 INFO - 'SHELL': '/bin/bash', 11:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:30 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:30 INFO - 'USER': 'cltbld', 11:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:30 INFO - 'XPC_FLAGS': '0x0', 11:51:30 INFO - 'XPC_SERVICE_NAME': '0', 11:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:51:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:51:33 INFO - Installing collected packages: mozsystemmonitor 11:51:33 INFO - Running setup.py install for mozsystemmonitor 11:51:33 INFO - Successfully installed mozsystemmonitor 11:51:33 INFO - Cleaning up... 11:51:33 INFO - Return code: 0 11:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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', '--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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:33 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 11:51:33 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 11:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:33 INFO - 'HOME': '/Users/cltbld', 11:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:33 INFO - 'LOGNAME': 'cltbld', 11:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:33 INFO - 'MOZ_NO_REMOTE': '1', 11:51:33 INFO - 'NO_EM_RESTART': '1', 11:51:33 INFO - 'PAGER': '/bin/cat', 11:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:33 INFO - 'PWD': '/builds/slave/test', 11:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:33 INFO - 'SHELL': '/bin/bash', 11:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:33 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:33 INFO - 'USER': 'cltbld', 11:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:33 INFO - 'XPC_FLAGS': '0x0', 11:51:33 INFO - 'XPC_SERVICE_NAME': '0', 11:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:51:34 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 11:51:34 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 11:51:34 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 11:51:34 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 11:51:34 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 11:51:34 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 11:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51:37 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 11:51:37 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 11:51:37 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 11:51:37 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 11:51:37 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 11:51:37 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 11:51:37 INFO - Downloading docopt-0.6.1.tar.gz 11:51:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:38 INFO - Running setup.py install for blobuploader 11:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:38 INFO - Running setup.py install for requests 11:51:38 INFO - Running setup.py install for docopt 11:51:38 INFO - Successfully installed blobuploader requests docopt 11:51:38 INFO - Cleaning up... 11:51:39 INFO - Return code: 0 11:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:39 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:39 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 11:51:39 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 11:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:39 INFO - 'HOME': '/Users/cltbld', 11:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:39 INFO - 'LOGNAME': 'cltbld', 11:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:39 INFO - 'MOZ_NO_REMOTE': '1', 11:51:39 INFO - 'NO_EM_RESTART': '1', 11:51:39 INFO - 'PAGER': '/bin/cat', 11:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:39 INFO - 'PWD': '/builds/slave/test', 11:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:39 INFO - 'SHELL': '/bin/bash', 11:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:39 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:39 INFO - 'USER': 'cltbld', 11:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:39 INFO - 'XPC_FLAGS': '0x0', 11:51:39 INFO - 'XPC_SERVICE_NAME': '0', 11:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-u__fdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-fz7mP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-eydnCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-k5IOSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-mBJRxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Qci7nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-MHLYhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-9SEJRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-DhcryB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-KS_tV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-npXiB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-YujP_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-8G7YsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:40 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-1wevxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:41 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Y1DT4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:41 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-8polPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:41 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-_RejSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:41 INFO - Running setup.py install for manifestparser 11:51:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:41 INFO - Running setup.py install for mozcrash 11:51:41 INFO - Running setup.py install for mozdebug 11:51:41 INFO - Running setup.py install for mozdevice 11:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Running setup.py install for mozfile 11:51:42 INFO - Running setup.py install for mozhttpd 11:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Running setup.py install for mozinfo 11:51:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Running setup.py install for mozInstall 11:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Running setup.py install for mozleak 11:51:42 INFO - Running setup.py install for mozlog 11:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Running setup.py install for moznetwork 11:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Running setup.py install for mozprocess 11:51:43 INFO - Running setup.py install for mozprofile 11:51:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Running setup.py install for mozrunner 11:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for mozscreenshot 11:51:44 INFO - Running setup.py install for moztest 11:51:44 INFO - Running setup.py install for mozversion 11:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:44 INFO - Cleaning up... 11:51:44 INFO - Return code: 0 11:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:44 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:44 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 11:51:44 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 11:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:44 INFO - 'HOME': '/Users/cltbld', 11:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:44 INFO - 'LOGNAME': 'cltbld', 11:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:44 INFO - 'MOZ_NO_REMOTE': '1', 11:51:44 INFO - 'NO_EM_RESTART': '1', 11:51:44 INFO - 'PAGER': '/bin/cat', 11:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:44 INFO - 'PWD': '/builds/slave/test', 11:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:44 INFO - 'SHELL': '/bin/bash', 11:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:44 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:44 INFO - 'USER': 'cltbld', 11:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:44 INFO - 'XPC_FLAGS': '0x0', 11:51:44 INFO - 'XPC_SERVICE_NAME': '0', 11:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:44 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-BmxwMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-lOJOUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-5txvte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-XQRWTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-tAAB0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-NJb2U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-u8wFqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-oeEJ7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:45 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)) 11:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:45 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-BzPlrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-aZSFsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-IcLysC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-3rcMgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-4zsMlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-6qd3BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-4duGOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:46 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)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:46 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-sBcLP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:47 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-1sdgcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:49 INFO - Downloading blessings-1.5.1.tar.gz 11:51:49 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 11:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:49 INFO - Installing collected packages: blessings 11:51:49 INFO - Running setup.py install for blessings 11:51:49 INFO - Successfully installed blessings 11:51:49 INFO - Cleaning up... 11:51:50 INFO - Return code: 0 11:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:50 INFO - Reading from file tmpfile_stdout 11:51:50 INFO - Current package versions: 11:51:50 INFO - blessings == 1.5.1 11:51:50 INFO - blobuploader == 1.2.4 11:51:50 INFO - docopt == 0.6.1 11:51:50 INFO - manifestparser == 1.1 11:51:50 INFO - mozInstall == 1.12 11:51:50 INFO - mozcrash == 0.16 11:51:50 INFO - mozdebug == 0.1 11:51:50 INFO - mozdevice == 0.47 11:51:50 INFO - mozfile == 1.2 11:51:50 INFO - mozhttpd == 0.7 11:51:50 INFO - mozinfo == 0.9 11:51:50 INFO - mozleak == 0.1 11:51:50 INFO - mozlog == 3.0 11:51:50 INFO - moznetwork == 0.27 11:51:50 INFO - mozprocess == 0.22 11:51:50 INFO - mozprofile == 0.27 11:51:50 INFO - mozrunner == 6.11 11:51:50 INFO - mozscreenshot == 0.1 11:51:50 INFO - mozsystemmonitor == 0.0 11:51:50 INFO - moztest == 0.7 11:51:50 INFO - mozversion == 1.4 11:51:50 INFO - psutil == 3.1.1 11:51:50 INFO - requests == 1.2.3 11:51:50 INFO - wsgiref == 0.1.2 11:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:50 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 0x1036e7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103754228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, '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.GfBXB1cNaz/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.94YUgdxYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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 11:51:50 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 11:51:50 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 11:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:50 INFO - 'HOME': '/Users/cltbld', 11:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:50 INFO - 'LOGNAME': 'cltbld', 11:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:50 INFO - 'MOZ_NO_REMOTE': '1', 11:51:50 INFO - 'NO_EM_RESTART': '1', 11:51:50 INFO - 'PAGER': '/bin/cat', 11:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:50 INFO - 'PWD': '/builds/slave/test', 11:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:50 INFO - 'SHELL': '/bin/bash', 11:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:51:50 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:50 INFO - 'USER': 'cltbld', 11:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:50 INFO - 'XPC_FLAGS': '0x0', 11:51:50 INFO - 'XPC_SERVICE_NAME': '0', 11:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 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)) 11:51:50 INFO - Cleaning up... 11:51:50 INFO - Return code: 0 11:51:50 INFO - Running post-action listener: _resource_record_post_action 11:51:50 INFO - Running post-action listener: _start_resource_monitoring 11:51:50 INFO - Starting resource monitoring. 11:51:50 INFO - ##### 11:51:50 INFO - ##### Running install step. 11:51:50 INFO - ##### 11:51:50 INFO - Running pre-action listener: _resource_record_pre_action 11:51:50 INFO - Running main action method: install 11:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:51 INFO - Reading from file tmpfile_stdout 11:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:51 INFO - Reading from file tmpfile_stdout 11:51:51 INFO - Output received: 11:51:51 INFO - Usage: mozinstall [options] installer 11:51:51 INFO - Options: 11:51:51 INFO - -h, --help show this help message and exit 11:51:51 INFO - -d DEST, --destination=DEST 11:51:51 INFO - Directory to install application into. [default: 11:51:51 INFO - "/builds/slave/test"] 11:51:51 INFO - --app=APP Application being installed. [default: firefox] 11:51:51 INFO - mkdir: /builds/slave/test/build/application 11:51:51 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'] 11:51:51 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 11:52:31 INFO - Reading from file tmpfile_stdout 11:52:31 INFO - Output received: 11:52:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:52:31 INFO - Running post-action listener: _resource_record_post_action 11:52:31 INFO - ##### 11:52:31 INFO - ##### Running run-tests step. 11:52:31 INFO - ##### 11:52:31 INFO - Running pre-action listener: _resource_record_pre_action 11:52:31 INFO - Running main action method: run_tests 11:52:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:52:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:52:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:52:31 INFO - 2015-11-05 11:52:31.320 screenresolution[1630:8041] starting screenresolution argv=screenresolution get 11:52:31 INFO - 2015-11-05 11:52:31.323 screenresolution[1630:8041] Display 0: 1600x1200x32@60 11:52:31 INFO - 2015-11-05 11:52:31.330 screenresolution[1631:8043] starting screenresolution argv=screenresolution list 11:52:31 INFO - Available Modes on Display 0 11:52:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:52:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:52:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:52:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:52:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:52:31 INFO - Intel HD Graphics 3000: 11:52:31 INFO - Chipset Model: Intel HD Graphics 3000 11:52:31 INFO - Type: GPU 11:52:31 INFO - Bus: Built-In 11:52:31 INFO - VRAM (Total): 512 MB 11:52:31 INFO - VRAM (Dynamic, Max): 10 11:52:31 INFO - Vendor: Intel (0x8086) 11:52:31 INFO - Device ID: 0x0116 11:52:31 INFO - Revision ID: 0x0009 11:52:31 INFO - Displays: 11:52:31 INFO - Display: 11:52:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:52:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:52:31 INFO - Display Serial Number: 1600x1200 60 11:52:31 INFO - Main Display: Yes 11:52:31 INFO - Mirror: Off 11:52:31 INFO - Online: Yes 11:52:31 INFO - Rotation: Supported 11:52:31 INFO - Return code: 0 11:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:31 INFO - Python 2.7.3 11:52:31 INFO - Return code: 0 11:52:31 INFO - grabbing minidump binary from tooltool 11:52:31 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')]} 11:52:31 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 0x10369c9f0>, '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 0x1033fbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:31 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 11:52:31 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 11:52:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:31 INFO - Return code: 0 11:52:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:52:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:52:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] in /builds/slave/test/build 11:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0054 --webServer localhost 11:52:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfBXB1cNaz/Render', 11:52:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:31 INFO - 'HOME': '/Users/cltbld', 11:52:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:31 INFO - 'LOGNAME': 'cltbld', 11:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:31 INFO - 'MOZ_NO_REMOTE': '1', 11:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:31 INFO - 'NO_EM_RESTART': '1', 11:52:31 INFO - 'PAGER': '/bin/cat', 11:52:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:31 INFO - 'PWD': '/builds/slave/test', 11:52:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:31 INFO - 'SHELL': '/bin/bash', 11:52:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94YUgdxYRH/Listeners', 11:52:31 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 11:52:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:31 INFO - 'USER': 'cltbld', 11:52:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:31 INFO - 'XPC_FLAGS': '0x0', 11:52:31 INFO - 'XPC_SERVICE_NAME': '0', 11:52:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:52:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] with output_timeout 3600 11:52:32 INFO - mozversion INFO | application_buildid: 20151105102536 11:52:32 INFO - mozversion INFO | application_changeset: 14fe585860cabf63c59dbaabe942e2a621f7e9ea 11:52:32 INFO - mozversion INFO | application_display_name: Nightly 11:52:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:32 INFO - mozversion INFO | application_name: Firefox 11:52:32 INFO - mozversion INFO | application_remotingname: firefox 11:52:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:52:32 INFO - mozversion INFO | application_vendor: Mozilla 11:52:32 INFO - mozversion INFO | application_version: 45.0a1 11:52:32 INFO - mozversion INFO | platform_buildid: 20151105102536 11:52:32 INFO - mozversion INFO | platform_changeset: 14fe585860cabf63c59dbaabe942e2a621f7e9ea 11:52:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:52:32 INFO - mozversion INFO | platform_version: 45.0a1 11:52:32 INFO - 2015-11-05 11:52:32,123 DEBUG : using testdate: 1446753152 11:52:32 INFO - 2015-11-05 11:52:32,123 DEBUG : actual date: 1446753152 11:52:32 INFO - 2015-11-05 11:52:32,173 INFO : starting webserver on 'localhost:49264' 11:52:32 INFO - 2015-11-05 11:52:32,175 INFO : Starting test suite t-yosemite-r5-0054.e 11:52:32 INFO - 2015-11-05 11:52:32,175 INFO : Starting test dromaeo_css 11:52:32 INFO - 2015-11-05 11:52:32,175 DEBUG : operating with platform_type : mac_ 11:52:32 INFO - 2015-11-05 11:52:32,176 INFO : Initialising browser for dromaeo_css test... 11:52:32 INFO - 2015-11-05 11:52:32,202 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpE3UOuS/profile http://localhost:49264/getInfo.html 11:52:35 INFO - 2015-11-05 11:52:35,916 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:52:35 INFO - 2015-11-05 11:52:35,916 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:52:35 INFO - 2015-11-05 11:52:35,916 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:52:35 INFO - 2015-11-05 11:52:35,916 DEBUG : BROWSER_OUTPUT: __metrics 11:52:36 INFO - 2015-11-05 11:52:36,597 INFO : Browser initialized. 11:52:36 INFO - 2015-11-05 11:52:36,597 INFO : Running cycle 1/1 for dromaeo_css test... 11:52:36 INFO - 2015-11-05 11:52:36,598 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpE3UOuS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:52:48 INFO - 2015-11-05 11:52:48,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 233574400 11:52:48 INFO - 2015-11-05 11:52:48,676 DEBUG : BROWSER_OUTPUT: 11:53:38 INFO - 2015-11-05 11:53:38,553 DEBUG : BROWSER_OUTPUT: 1446753218552 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] 11:55:49 INFO - 2015-11-05 11:55:49,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 11:55:51 INFO - 2015-11-05 11:55:51,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 260014080 11:55:51 INFO - 2015-11-05 11:55:51,029 DEBUG : BROWSER_OUTPUT: 11:58:53 INFO - 2015-11-05 11:58:53,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 11:58:53 INFO - 2015-11-05 11:58:53,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 267034624 11:58:53 INFO - 2015-11-05 11:58:53,739 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-05 12:01:55,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 12:01:56 INFO - 2015-11-05 12:01:56,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 271265792 12:01:56 INFO - 2015-11-05 12:01:56,080 DEBUG : BROWSER_OUTPUT: 12:04:57 INFO - 2015-11-05 12:04:57,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 12:04:58 INFO - 2015-11-05 12:04:58,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 275402752 12:04:58 INFO - 2015-11-05 12:04:58,340 DEBUG : BROWSER_OUTPUT: 12:08:00 INFO - 2015-11-05 12:08:00,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 12:08:01 INFO - 2015-11-05 12:08:01,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 279449600 12:08:01 INFO - 2015-11-05 12:08:01,598 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 12:11:04 INFO - 2015-11-05 12:11:04,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 284491776 12:11:04 INFO - 2015-11-05 12:11:04,338 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,339 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:11:04 INFO - 2015-11-05 12:11:04,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:11:04 INFO - 2015-11-05 12:11:04,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:11:04 INFO - 2015-11-05 12:11:04,340 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:11:04 INFO - 2015-11-05 12:11:04,341 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2804.495190865644;2821.590869323948;2838.971610283898;2880.9855950720257;2888.1913064341993;4815.807367705292;4817.349657796197;4827.275908613709;4865.8540243792695;4908.484609116036;4648.581627653519;4704.694194877331;4799.136155492019;4845.975770121145;4874.9268760968525;4307.719998200115;4367.257566213735;4466.5980061794435;4492.730436173823;4590.655700822435;4405.515393306734;4449.733016019033;4467.10657868426;4467.821287148527;4569.81720731172;4269.103488267468;4436.689431739779;4459.866204013885;4536.160810250098;4558.977205113986;4315.633171180453;4398.186335527906;4412.801423935931;4423.734575925455;4459.665525085599;4382.561743825624;4412.360207769888;4437;4443.755593442359;4490.663200259961;4539.750313732743;4633.652476064309;4667.743274119922;4726.503717109688;4784.425868895755;5026.195808670595;5048.7223202723835;5061.595072394236;5070.797168113271;5076.82231121909;5131.255967884673;5153.948460515422;5194.194899790538;5200;5251.054810134175;4715.669903106784;4738.715677059387;4766.976165119152;4807.903841923142;4813.7352445615825;5202.453742356998;5245.501677340647;5265.76304066318;5324.361076670824;5344.931013797256;5060.2662613920775;5076.771545280471;5078.339815823919;5084.211947148198;5110.386753589593;5005.324281221989;5073.847784566469;5079.3650793650795;5191.195364718475;5211.166213405837;5034.597232221414;5051.3433253676785;5052.722100284446;5065.214891691794;5104.387473503203;5024.422191447957;5033.496650334937;5040.823571174991;5050.419201791768;5064.34163558735;3893.8637147699696;3947.684185265172;3987.3420885554137;4006.539247986519;4037.7173597848455;3600.945985810215;3622.3298689742483;3639.4176931690804;3684.060564556021;3738.925221495609;4733.384659994247;4765.475797662254;4794.328793968847;4801.5438533339275;4894.510548945077;4934.5312195341385;5049.798008079636;5052.343195384577;5061.164907790173;5126.256692779526;4726.621870250372;4733.077049975291;4755.500672429414;4802.879928001758;4808.903821923542;4457.086297309044;4517.141743068806;4533.410656614685;4558.29346451294;4659.58063774262;5233.215017747369;5241.764120614505;5247.947520524746;5305.257263983045;5314.5748340132695;4924.581410579997;5065.493450654905;5149.356330458692;5171.3277273954145;5233.921491177559;5218.347706536683;5262.500062494057;5263.447338029452;5266.710330931683;5267.894642107213;5064.063148317573;5066;5114.667546609458;5149.201873709581;5150.793968241228;5005.299258103942;5184.844454666366;5219.739013049409;5234.502722241381;5290.259363689163;5044.167712327425;5075.086484432837;5123.846284611468;5138.434772175133;5138.511841375063;5032.270320803536;5032.471590482946;5096.51583099605;5109.821156259662;5157.045946499909;4749.192637251745;4802.951970480251;4863.197572400514;4922.3600931880055;4969.254611808257;5042.29407882904;5080.085584594808;5086.872828179326;5106.897862042664;5123.077845987758;4808.8797780055775;4961.280614310833;4988.027334669705;4991.725455100004;5006.249062640487 12:11:04 INFO - 2015-11-05 12:11:04,345 DEBUG : BROWSER_OUTPUT: |1;ext.html;487.51492265196123;499.2137383620796;509.65852878571354;511.2969666708276;516.9405518365387;35417.64582354176;36330.818345908236;36535.26929461416;36547.817260913725;36549.26901461969;38490.4226436603;39025.41461878074;39096.609033909655;39123.21753564927;39164.21671566567;8228.62971166299;8313.95843020784;8398.580070996457;8400;8416.579171041454;7960.800979975489;8215.055268644122;8241.505509669409;8340.541270230135;8344.332453403713;8284.958575207145;8322.417430779848;8351.540665263408;8386.622601982925;8392.664293428255;8309.916900830975;8327;8343.582820858963;8421;8442.831143377129;8254.257116859511;8285.62714677841;8326.750197494084;8329.000519937586;8340.124286949844;35090;35653.07816140248;35717.64282357169;35822;35937.82031089828;2406.350285422926;2568.8397963796415;2585.5992321190247;2810.094863074986;2842.3036356092684;24108.638370424458;24901.128460503976;25142.748572514225;25353.239402817944;25717.871410642827;2140.2295173737443;2161.556880839424;2166.393409845246;2184.6613774864923;2192.583409152272;234030;236502;238826;238969;239354.8032259845;46509;52848.73575632097;53116.46883531193;53642;53721.73139134357;43900;60884.69557652184;62784;63745.53781235362;63804.68097659482;13276.269805160615;13284.933575332061;13328.466861325633;13381.799273010913;13542.187468751907;9807.656732014346;9859.063388978178;9865.950670246602;9947.403155810529;10027.598896044077;17506.387276445264;17518;17572.824271757374;17797.911010444866;17839.197236124404;7834.647440865175;8152.755417337489;8156;8175.468594541336;8221;819.7376839411451;854.448880472092;856.8817692910686;962.932594718363;967.4717366415168;25302.873485632455;25550.361240969123;25644.615330770055;25693.3576660585;25901.09346172875;924.7040946896929;971.2861047130353;1016.3952448293254;1049.8057859296055;1057.2018126314583;13144.211347319191;13308.667283317995;13859.861401385857;14434.843414414823;14662.78005829892;285866;292324;295115;296148;296173;49449.75275123601;49711.50288497069;49720.75139624351;49748.253776193385;49765;1220.200768496636;1223.9388030598434;1235.6849003504049;1246.8628450870397;1251.7684228417772;26253.474930501667;26626.600600990612;26689.33276668099;26740.7325926746;26780.330491737863;42479.575204248795;43552.56447435612;43557.78221108874;43628.34557481704;44073;248444;249756;251255;251366;252605;27662.170134895987;28251.717482824908;28458.43083138367;28481.572776407957;28616.284592885346;34390.14024649404;34573.13567160841;34727.4790878132;35615;36815.26369472649;31010.844945775127;31103.377932441676;31727.68272317247;31821.363572727954;32180.517292241104;31050.689493105685;31368.529472057482;31617;31617.683823161475;31810.204744881565;31144.22139446532;31987.520187196744;32461;32613.18467038343;32619.673803262613;26940;28044.298892527033;28099.57850632283;28170;28532.42935141327;21427.46431339229;21523;21607.783922161205;21611.243606474327;21648 12:11:04 INFO - 2015-11-05 12:11:04,346 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.61717575739414;295.779644165097;300.7864416264451;306.7775862499688;308.9443900097982;10501.212409069312;10838.512266947986;15260.23698815059;15693.52919412418;15893.2848021839;8966.641334346617;9199.954000230005;10201.54093065812;10331.63839265626;10419.114375278092;3855.306044911915;3946.3093958557283;3949.3878448840474;4001.319775638134;4007.6793856491413;2971.24233320503;3974.3243648579664;3980.2039592081555;4013.2776100301935;4016;2993.191838203684;3081.630204375478;3895.6299151580556;3959.9406008909746;4161.833526658945;4202.579742025803;4230.682698797587;4238.21593005295;4251.532331443539;4271.700980931336;3562.287542491512;3574.8391322390553;3585.731070169748;3616.8734094306574;3621.130928577149;11173.944130279297;11581.18931674783;11598.130140239517;11743.354115523643;11774.116941229357;1622.2051194914525;1645.2102990564597;1655.0235361136988;1685.162554362079;1712.3065158610782;8479;8496.150384961516;8649;8653.610587523577;8751.168638979287;1303.2571434282463;1385.6743665238662;1390.221475973448;1406.6624010237572;1466.3474753734592;48992.755036224946;49172.262416063786;49904.251436228486;49914.750426248;50111.24833127543;5662;5676;5681.062624666966;5753.85615359611;5785.623934444247;6422.807315780534;6450.774222902176;6451.612903225821;6530.444912182517;6533.314002029813;4656.301554766812;4662.7668616569035;4679.625629949596;4701.153792317347;4753.1444340019125;4911.852644420673;4942.950570494321;4972.776225069881;4990.476000019946;5005.124103281911;2572.15119010726;2576.4460640962284;2590.8834102465435;2611.686597608299;2627.1724406811795;917.4586993673764;920.4477313611914;922.9769255768659;927.958241879117;991.7371896447447;398.3626198083044;402.7140730081616;404.92913740095366;410.6201763368872;416.64376957701336;8708.216260536583;10355.378677279386;10395.16838652906;10541.420221887869;10770.515326810313;406.3620116417256;413.6236025217098;413.7682897577366;433.63189138268183;437.6236436664466;5422.078246698071;5576.247206627135;5580.525655319262;5590.273264475592;5633.943660563424;326677;333133;512533;516919;549985;61125.69437152786;61801.690991544754;61803.690981545704;62254;63694.40763980845;384.34085543292827;387.2835254778637;387.67822707152993;391.8432626949243;392.9037385840487;8507.447015943944;8837.513936733541;8900.332475064266;8913.777155570902;8915.910840891507;32059.198520037186;32569.185770354983;32603.510947336283;32644.83677581597;33213;42767.35848962206;42816.57183428126;43424.78287608542;43586.34620480759;43962.78018609886;6619.635920024445;6675.966620166868;6786.083878676315;6856.177258728984;6870.793876183722;9847.162991145833;10333.844992325272;10373.429461379697;10430.68707938763;10470.895291046992;8947.776305592412;9012.504312262889;9038.819223615623;9083.818323633623;9135.725928222164;7529.811754705957;8708.216260536583;8737.650493980169;8743.081976392386;8968.730938071869;8427.8735818964;9057.18485336323;9102.408343457653;9142.58858351389;9224.861627075465;6428.228612566522;6547.508936829661;6839.008343790023;6849.349311815369;6902.723891044503;8283.917160828314;8394.832103358021;8479.15208479147;8737.257333126756;9320.673776417792 12:11:04 INFO - 2015-11-05 12:11:04,349 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1473.0940471609963;1550.6743583847392;1626.642138729479;1637.8280280570536;1649.430946323518;6146.200993870791;6246.9062964055465;6867.210270818858;6970.965145174273;7058.364747172754;6539.77110801122;6703.698333574988;6819.931800681991;6825.453963682906;6836.282190370014;1936.8741031832956;1981.1382048808814;1995.9301424450075;2006.3278801601482;2011.5373464103266;1975.0618456233317;1988.8607797454183;2002.539415934336;2008.7288216090788;2009.919603215877;1914.301280032785;1921.6156768646256;1947;1953.3651563242004;1961.0880940362729;1950.2296592845817;1956.8238858502662;1961.2841312920682;1963.4796778853545;1987.76146862376;1880.8307252347354;1902.7526421565246;1905.07603812151;1938.844892408604;1971.7831038585743;6765.729370825161;6783.932160678429;6784.76253331136;6803.557768745065;6852;4136.648384887289;4142.71001029928;4153.314703073989;4194.412782210493;4209.852655157055;2448.7306396296394;2510.598304271308;2542.3389918621106;2544.3384719972755;2559.3345730110304;730.1347902735275;735.0517831996718;747.3610063395827;768.0092680442223;786.1784435265162;8885.2447541959;8899.866502002475;8981.236594889442;8981.955090224506;9023.909760902372;3635.94546081809;3677.9080522987138;3685.9631403686158;3701.1117331840164;3708.6847617952235;7793;7810.375169986388;7844.176361482077;7869.409794265453;7913.287804097658;4180.456540649696;4206.8737937861915;4217.493900731932;4241.957580424156;4253.957460425356;3395.966040339614;3577.3381924343557;3723.255348930225;3841.327767640652;3901.1612503311926;3167.9683203168133;3169.6830316968117;3182.8885988990273;3202.823844688518;3231.079142444392;1026.984595231072;1031.8452232165234;1032.4682788363998;1032.7934413117407;1045.3675526306627;876.6318146378536;887.3965703321803;980.9068138526828;1167.1538134852165;1167.6321958583019;6323.30443651198;6342.746290148342;6392.680365981775;6402.487800976004;6403.615783053032;319.63561539844596;319.65636940289284;323.4985772053308;323.6310406978494;324.9285157265398;4964.875878103004;5054.241863720471;5103.8468845934685;5114.488551144856;5169.250458683545;7787.415943804237;7871.17352677972;7885.1326354101;7932.246436588515;7942.285194332538;7654.272844079804;7767.611619419006;7803.570803605856;7891.329237014803;7896.7236146734585;6218.689065546704;6254.9687251563455;6269.404406581459;6336.873262534724;6356.078368636522;5955.493783028491;6021.126936594257;6039.728212230548;6054.455099041107;6104.633721976696;6919.135108111486;7103.041089452858;7176.7846964591145;7212.927870721225;7215.71137154508;7240.927590724025;7283.490155689051;7301.707931682886;7336.523125996793;7339.229380914927;5487.670739755467;5528.115501519737;5757.7121143941795;5902.822915312548;5917.349091600006;6119.724612392542;6448.129502517288;6474.546781725234;6514.902276465951;6519.771807986698;5975.641461512323;6074.578292301125;6080.300765412034;6086.513078953762;6110.1445797587485;5948.524118070457;6036.7283472244735;6041.395860413923;6052.122442245762;6081.361457047124;6033.487153591994;6043.2748070231855;6046.90929636047;6089.665068421279;6117.632942023492;5524.640898341595;5574.136008918624;5640.294963129609;5649.548036157015;5650.378458369494;5509.228707980806;5534.7786088556;5561.304836895388;5605.80379686709;5609.074502707171 12:11:04 INFO - 2015-11-05 12:11:04,350 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.31261876380904;274.5744096650192;280.0576061552874;280.7417176197897;280.841324651572;5384.273123128377;5394.406615272317;5486.478784515474;5487.204355368469;5505.889882202354;5232.45059268777;5285.814996475124;5314.76083576239;5407;5428.728563571825;4071.1043570414463;4072.022714548502;4073.8981525461804;4102.2410853992105;4117.279476091672;4054.0878302382025;4074.8777536673797;4097.385392191165;4101.425800387948;4124.649404800595;3905.882823515285;4009.4587230723914;4021.095253567953;4075.9388609170887;4093.3041382964966;3979.960200397988;3981.7411868228473;4004.559498455182;4038;4051.7974101294963;3428.365752335801;3429.742769292313;3430;3439.8968030959113;3468.4623883298127;5162.92255616166;5177.534021938006;5207.3490813648295;5236.528712415901;5242.6330156889035;4481.708688935209;4518.728876267402;4567.2920697291975;4568.269076947706;4570.428696412949;5529.917051244234;5646.57650676201;5673.290838645169;5691.772329106872;5699.344575373843;3747.475353450519;3753.3244016077097;3761.4545890845948;3764;3801.8099095045136;5914.763409463616;5922.911156332659;5952.791652292149;5953.553483488712;6000.069989151732;3791.7724936503346;3816.5610954740005;3826.9043273918373;3854.9036274093373;3877.2051729395407;3769.4345848122452;3784.299904517618;3856.151646637735;3881;3959.40608908666;4499.505054444008;4506.684532082722;4512.05246898155;4544.454665440102;4573.81704731807;5599.720013999284;5602.85992850182;5638.802641907513;5659.660420374791;5672.149177623307;1366.5422083601907;1394.7210557888463;1395.483671041721;1396.72065586881;1408.499982506216;858.274757829633;876.8684697295457;884.4162852517308;893.1604291965662;894.186290475677;5335.039692855324;5355.892882142335;5356.384015838151;5383.973080134574;5412.485813847678;5875.089361149029;5889;5944.048952167719;5950.8809823803285;5954.868574970742;5325;5342.038433082005;5359.598030147755;5401.432849550819;5402.540784033323;3160.762942779255;3246.464333385012;3268.10127215013;3288.177955511122;3291.2759192977505;5972.25346831646;6006.099085137177;6017.69911504423;6019.909701354483;6038.849028774316;5987.9101813472835;6004.759809607567;6071.635701857903;6072.878542429126;6079.148919151322;5830.416958304136;5955.821325360246;5970.5223582114195;6018;6028.638281703112;5969.641821490724;5998.1002849572915;6016.2479690038745;6026.156338112755;6026.306974697791;5819.94180058194;5867.32525759526;5867.735951882261;5905.557083218861;5911.793087241926;6106.358832322542;6106.847328816815;6109.69451527413;6120.571559990936;6121.84695382619;3712.387456069718;3796.810159491959;3817.4655548223827;3824.770513769183;3852.980735096419;5767.3367562729145;5787.39232380594;5874.148248504029;5880.617759845596;5881.206037184926;5705.572082093942;5720.771169153188;5741.282339707536;5773.451522105393;5811.360750317546;5729.71351432435;5730.197772311796;5744.569157313302;5770.076787713946;5774.711264436845;5426.972865135649;5558.777648894161;5647.20939068539;5649.435056494318;5654.6889921054735;5685.772569097356;5744.138379243147;5754.108113242454;5757.5681823864215;5758.2514273144225;5516.862078447911;5582.385937546947;5588.6646801192055;5598.1602759586385;5605.523530499953 12:11:04 INFO - 2015-11-05 12:11:04,352 DEBUG : BROWSER_OUTPUT: |5;yui.html;560.887822435513;622.2284367384444;656.8719099775543;689.5759108148488;696.8188271049527;12106.636800895976;12135;12164.513419463223;12290.63128106156;12292.938535307321;10732.839007414896;10789.946050269757;10793.568257269719;12313.445894934726;12569.874301256985;786.7797016835281;790.2018960849526;791.9683212671487;801.8556659801234;802.1216767639426;782.7338704840353;782.9138794732603;782.949108307961;784.4234487651571;791.9841603167933;783.9255270749298;796.6972550430828;806.3589446390105;812.0174588747593;813.6379311206485;793.5199204481293;799.360511590728;800.0799081056773;800.5396896784372;806.701520437436;581.137011537866;582.1558739827267;583.1806312131462;583.422411812307;583.6731430398991;11998.220115692453;12073.637790866289;12163;12169.634910952685;12268.38658067102;8372.288355489729;8383.916160838375;8392.874106888401;8590.742277731679;8831.77920551985;7827.921720782776;8074.273315401642;8133.2680058794995;8350.290225330855;8551.187637174458;2571.537123317802;2620.5283049051163;2644.167087367473;2733.685626152998;2772.029789573653;34481.310373792636;35007.64992350095;37489.25021499582;41359.58640413587;42234.57765422337;6063.393660633901;6085.78542214356;6171.290301615282;6206.317305096436;6237.625742455467;10440.843387349196;10455.581776728997;10475.790484190273;10567.260291779501;10591.629292974863;5397.78408863641;5630.352509461464;5639.943600563942;5668.57485688575;5683.175939488834;3166.509191075387;3294.1929227338974;3321.2029113013186;3404.0468668772783;3431.107911942913;2364.3261670423844;2367.502824406894;2398.676178715851;2401.579723548372;2403.639454081902;354.4010622048729;357.871166380103;363.3115246607664;367.2581385601071;367.2654690618763;407.4967415242173;441.6422697614942;459.00625146557996;491.54286513542036;537.7741348633583;6390.904136437957;6909.654517274116;6949;7048.259932707095;7100.7869763907165;397.82098055874394;416.9228692691801;473.3136951420454;473.6826326361277;486.29730040092437;3139.894306511136;3225.145336485833;3304.1739565108724;3313.4201514734823;3466;53247;53470;53554;53617.731911340976;53655.731721341144;44644.107117857464;44694.77652611716;45003.324950125774;45259.32111018337;45645.771771140935;40259.39610905839;40322;40954;41060.97347566275;41735.58264417377;7109.82225444368;7145.606991615511;7187.532810367309;7392.44556658242;7534.35957943581;31438.37123257568;31611.525827113073;31837.68162318347;32211.516827247142;32289;40716.592834072464;41530.58469415267;41996.16007679891;42731.78634106934;42912.35631465468;6694.129763130956;6697.430718388991;6722.697478613376;6727.865442691216;6867.107276054081;9215.76960575991;9656.420614763138;9722.270829687943;10314.174866010851;10347.896521034694;9015.188633023059;9272.119148680864;9422.246220302497;9591.136797688241;9727.708168754949;9259.583318750538;9512.2865785065;9674.75813104678;9683.806323873623;9744.366616169926;8933;9163.908360916572;9193.816123677356;9231.815363692824;9234.492102934402;7941.722039728582;8056.355491560544;8149.6332665031405;8390.874136887829;8481.491110533389;7939.880901786362;7940.205979402244;7992.240737129963;8154.673813047411;8380.413371063967 12:11:04 INFO - 2015-11-05 12:11:04,352 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:11:04 INFO - 2015-11-05 12:11:04,352 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:11:04 INFO - 2015-11-05 12:11:04,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 12:11:04 INFO - 2015-11-05 12:11:04,352 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: __startTimestamp1446754264338__endTimestamp 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,353 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4779.82 Median:4961.28 stddev:508.90 (10.3%) stddev-sans-first:486.29 12:11:04 INFO - 2015-11-05 12:11:04,355 DEBUG : BROWSER_OUTPUT: Values: 2804.5 2821.6 2839.0 2881.0 2888.2 4815.8 4817.3 4827.3 4865.9 4908.5 4648.6 4704.7 4799.1 4846.0 4874.9 4307.7 4367.3 4466.6 4492.7 4590.7 4405.5 4449.7 4467.1 4467.8 4569.8 4269.1 4436.7 4459.9 4536.2 4559.0 4315.6 4398.2 4412.8 4423.7 4459.7 4382.6 4412.4 4437.0 4443.8 4490.7 4539.8 4633.7 4667.7 4726.5 4784.4 5026.2 5048.7 5061.6 5070.8 5076.8 5131.3 5153.9 5194.2 5200.0 5251.1 4715.7 4738.7 4767.0 4807.9 4813.7 5202.5 5245.5 5265.8 5324.4 5344.9 5060.3 5076.8 5078.3 5084.2 5110.4 5005.3 5073.8 5079.4 5191.2 5211.2 5034.6 5051.3 5052.7 5065.2 5104.4 5024.4 5033.5 5040.8 5050.4 5064.3 3893.9 3947.7 3987.3 4006.5 4037.7 3600.9 3622.3 3639.4 3684.1 3738.9 4733.4 4765.5 4794.3 4801.5 4894.5 4934.5 5049.8 5052.3 5061.2 5126.3 4726.6 4733.1 4755.5 4802.9 4808.9 4457.1 4517.1 4533.4 4558.3 4659.6 5233.2 5241.8 5247.9 5305.3 5314.6 4924.6 5065.5 5149.4 5171.3 5233.9 5218.3 5262.5 5263.4 5266.7 5267.9 5064.1 5066.0 5114.7 5149.2 5150.8 5005.3 5184.8 5219.7 5234.5 5290.3 5044.2 5075.1 5123.8 5138.4 5138.5 5032.3 5032.5 5096.5 5109.8 5157.0 4749.2 4803.0 4863.2 4922.4 4969.3 5042.3 5080.1 5086.9 5106.9 5123.1 4808.9 4961.3 4988.0 4991.7 5006.2 12:11:04 INFO - 2015-11-05 12:11:04,355 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,355 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41524.11 Median:32320.76 stddev:68373.77 (211.5%) stddev-sans-first:68496.15 12:11:04 INFO - 2015-11-05 12:11:04,356 DEBUG : BROWSER_OUTPUT: Values: 487.5 499.2 509.7 511.3 516.9 35417.6 36330.8 36535.3 36547.8 36549.3 38490.4 39025.4 39096.6 39123.2 39164.2 8228.6 8314.0 8398.6 8400.0 8416.6 7960.8 8215.1 8241.5 8340.5 8344.3 8285.0 8322.4 8351.5 8386.6 8392.7 8309.9 8327.0 8343.6 8421.0 8442.8 8254.3 8285.6 8326.8 8329.0 8340.1 35090.0 35653.1 35717.6 35822.0 35937.8 2406.4 2568.8 2585.6 2810.1 2842.3 24108.6 24901.1 25142.7 25353.2 25717.9 2140.2 2161.6 2166.4 2184.7 2192.6 234030.0 236502.0 238826.0 238969.0 239354.8 46509.0 52848.7 53116.5 53642.0 53721.7 43900.0 60884.7 62784.0 63745.5 63804.7 13276.3 13284.9 13328.5 13381.8 13542.2 9807.7 9859.1 9866.0 9947.4 10027.6 17506.4 17518.0 17572.8 17797.9 17839.2 7834.6 8152.8 8156.0 8175.5 8221.0 819.7 854.4 856.9 962.9 967.5 25302.9 25550.4 25644.6 25693.4 25901.1 924.7 971.3 1016.4 1049.8 1057.2 13144.2 13308.7 13859.9 14434.8 14662.8 285866.0 292324.0 295115.0 296148.0 296173.0 49449.8 49711.5 49720.8 49748.3 49765.0 1220.2 1223.9 1235.7 1246.9 1251.8 26253.5 26626.6 26689.3 26740.7 26780.3 42479.6 43552.6 43557.8 43628.3 44073.0 248444.0 249756.0 251255.0 251366.0 252605.0 27662.2 28251.7 28458.4 28481.6 28616.3 34390.1 34573.1 34727.5 35615.0 36815.3 31010.8 31103.4 31727.7 31821.4 32180.5 31050.7 31368.5 31617.0 31617.7 31810.2 31144.2 31987.5 32461.0 32613.2 32619.7 26940.0 28044.3 28099.6 28170.0 28532.4 21427.5 21523.0 21607.8 21611.2 21648.0 12:11:04 INFO - 2015-11-05 12:11:04,356 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,356 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22550.78 Median:22011.98 stddev:75190.02 (341.6%) stddev-sans-first:75382.38 12:11:04 INFO - 2015-11-05 12:11:04,358 DEBUG : BROWSER_OUTPUT: Values: 295.6 295.8 300.8 306.8 308.9 10501.2 10838.5 15260.2 15693.5 15893.3 8966.6 9200.0 10201.5 10331.6 10419.1 3855.3 3946.3 3949.4 4001.3 4007.7 2971.2 3974.3 3980.2 4013.3 4016.0 2993.2 3081.6 3895.6 3959.9 4161.8 4202.6 4230.7 4238.2 4251.5 4271.7 3562.3 3574.8 3585.7 3616.9 3621.1 11173.9 11581.2 11598.1 11743.4 11774.1 1622.2 1645.2 1655.0 1685.2 1712.3 8479.0 8496.2 8649.0 8653.6 8751.2 1303.3 1385.7 1390.2 1406.7 1466.3 48992.8 49172.3 49904.3 49914.8 50111.2 5662.0 5676.0 5681.1 5753.9 5785.6 6422.8 6450.8 6451.6 6530.4 6533.3 4656.3 4662.8 4679.6 4701.2 4753.1 4911.9 4943.0 4972.8 4990.5 5005.1 2572.2 2576.4 2590.9 2611.7 2627.2 917.5 920.4 923.0 928.0 991.7 398.4 402.7 404.9 410.6 416.6 8708.2 10355.4 10395.2 10541.4 10770.5 406.4 413.6 413.8 433.6 437.6 5422.1 5576.2 5580.5 5590.3 5633.9 326677.0 333133.0 512533.0 516919.0 549985.0 61125.7 61801.7 61803.7 62254.0 63694.4 384.3 387.3 387.7 391.8 392.9 8507.4 8837.5 8900.3 8913.8 8915.9 32059.2 32569.2 32603.5 32644.8 33213.0 42767.4 42816.6 43424.8 43586.3 43962.8 6619.6 6676.0 6786.1 6856.2 6870.8 9847.2 10333.8 10373.4 10430.7 10470.9 8947.8 9012.5 9038.8 9083.8 9135.7 7529.8 8708.2 8737.7 8743.1 8968.7 8427.9 9057.2 9102.4 9142.6 9224.9 6428.2 6547.5 6839.0 6849.3 6902.7 8283.9 8394.8 8479.2 8737.3 9320.7 12:11:04 INFO - 2015-11-05 12:11:04,358 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,358 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4676.35 Median:5910.09 stddev:2421.84 (41.0%) stddev-sans-first:2416.67 12:11:04 INFO - 2015-11-05 12:11:04,359 DEBUG : BROWSER_OUTPUT: Values: 1473.1 1550.7 1626.6 1637.8 1649.4 6146.2 6246.9 6867.2 6971.0 7058.4 6539.8 6703.7 6819.9 6825.5 6836.3 1936.9 1981.1 1995.9 2006.3 2011.5 1975.1 1988.9 2002.5 2008.7 2009.9 1914.3 1921.6 1947.0 1953.4 1961.1 1950.2 1956.8 1961.3 1963.5 1987.8 1880.8 1902.8 1905.1 1938.8 1971.8 6765.7 6783.9 6784.8 6803.6 6852.0 4136.6 4142.7 4153.3 4194.4 4209.9 2448.7 2510.6 2542.3 2544.3 2559.3 730.1 735.1 747.4 768.0 786.2 8885.2 8899.9 8981.2 8982.0 9023.9 3635.9 3677.9 3686.0 3701.1 3708.7 7793.0 7810.4 7844.2 7869.4 7913.3 4180.5 4206.9 4217.5 4242.0 4254.0 3396.0 3577.3 3723.3 3841.3 3901.2 3168.0 3169.7 3182.9 3202.8 3231.1 1027.0 1031.8 1032.5 1032.8 1045.4 876.6 887.4 980.9 1167.2 1167.6 6323.3 6342.7 6392.7 6402.5 6403.6 319.6 319.7 323.5 323.6 324.9 4964.9 5054.2 5103.8 5114.5 5169.3 7787.4 7871.2 7885.1 7932.2 7942.3 7654.3 7767.6 7803.6 7891.3 7896.7 6218.7 6255.0 6269.4 6336.9 6356.1 5955.5 6021.1 6039.7 6054.5 6104.6 6919.1 7103.0 7176.8 7212.9 7215.7 7240.9 7283.5 7301.7 7336.5 7339.2 5487.7 5528.1 5757.7 5902.8 5917.3 6119.7 6448.1 6474.5 6514.9 6519.8 5975.6 6074.6 6080.3 6086.5 6110.1 5948.5 6036.7 6041.4 6052.1 6081.4 6033.5 6043.3 6046.9 6089.7 6117.6 5524.6 5574.1 5640.3 5649.5 5650.4 5509.2 5534.8 5561.3 5605.8 5609.1 12:11:04 INFO - 2015-11-05 12:11:04,360 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,360 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4719.57 Median:5419.73 stddev:1466.41 (27.1%) stddev-sans-first:1432.05 12:11:04 INFO - 2015-11-05 12:11:04,360 DEBUG : BROWSER_OUTPUT: Values: 273.3 274.6 280.1 280.7 280.8 5384.3 5394.4 5486.5 5487.2 5505.9 5232.5 5285.8 5314.8 5407.0 5428.7 4071.1 4072.0 4073.9 4102.2 4117.3 4054.1 4074.9 4097.4 4101.4 4124.6 3905.9 4009.5 4021.1 4075.9 4093.3 3980.0 3981.7 4004.6 4038.0 4051.8 3428.4 3429.7 3430.0 3439.9 3468.5 5162.9 5177.5 5207.3 5236.5 5242.6 4481.7 4518.7 4567.3 4568.3 4570.4 5529.9 5646.6 5673.3 5691.8 5699.3 3747.5 3753.3 3761.5 3764.0 3801.8 5914.8 5922.9 5952.8 5953.6 6000.1 3791.8 3816.6 3826.9 3854.9 3877.2 3769.4 3784.3 3856.2 3881.0 3959.4 4499.5 4506.7 4512.1 4544.5 4573.8 5599.7 5602.9 5638.8 5659.7 5672.1 1366.5 1394.7 1395.5 1396.7 1408.5 858.3 876.9 884.4 893.2 894.2 5335.0 5355.9 5356.4 5384.0 5412.5 5875.1 5889.0 5944.0 5950.9 5954.9 5325.0 5342.0 5359.6 5401.4 5402.5 3160.8 3246.5 3268.1 3288.2 3291.3 5972.3 6006.1 6017.7 6019.9 6038.8 5987.9 6004.8 6071.6 6072.9 6079.1 5830.4 5955.8 5970.5 6018.0 6028.6 5969.6 5998.1 6016.2 6026.2 6026.3 5819.9 5867.3 5867.7 5905.6 5911.8 6106.4 6106.8 6109.7 6120.6 6121.8 3712.4 3796.8 3817.5 3824.8 3853.0 5767.3 5787.4 5874.1 5880.6 5881.2 5705.6 5720.8 5741.3 5773.5 5811.4 5729.7 5730.2 5744.6 5770.1 5774.7 5427.0 5558.8 5647.2 5649.4 5654.7 5685.8 5744.1 5754.1 5757.6 5758.3 5516.9 5582.4 5588.7 5598.2 5605.5 12:11:04 INFO - 2015-11-05 12:11:04,360 DEBUG : BROWSER_OUTPUT: 12:11:04 INFO - 2015-11-05 12:11:04,362 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11629.27 Median:5654.26 stddev:14339.84 (253.6%) stddev-sans-first:14355.98 12:11:04 INFO - 2015-11-05 12:11:04,362 DEBUG : BROWSER_OUTPUT: Values: 560.9 622.2 656.9 689.6 696.8 12106.6 12135.0 12164.5 12290.6 12292.9 10732.8 10789.9 10793.6 12313.4 12569.9 786.8 790.2 792.0 801.9 802.1 782.7 782.9 782.9 784.4 792.0 783.9 796.7 806.4 812.0 813.6 793.5 799.4 800.1 800.5 806.7 581.1 582.2 583.2 583.4 583.7 11998.2 12073.6 12163.0 12169.6 12268.4 8372.3 8383.9 8392.9 8590.7 8831.8 7827.9 8074.3 8133.3 8350.3 8551.2 2571.5 2620.5 2644.2 2733.7 2772.0 34481.3 35007.6 37489.3 41359.6 42234.6 6063.4 6085.8 6171.3 6206.3 6237.6 10440.8 10455.6 10475.8 10567.3 10591.6 5397.8 5630.4 5639.9 5668.6 5683.2 3166.5 3294.2 3321.2 3404.0 3431.1 2364.3 2367.5 2398.7 2401.6 2403.6 354.4 357.9 363.3 367.3 367.3 407.5 441.6 459.0 491.5 537.8 6390.9 6909.7 6949.0 7048.3 7100.8 397.8 416.9 473.3 473.7 486.3 3139.9 3225.1 3304.2 3313.4 3466.0 53247.0 53470.0 53554.0 53617.7 53655.7 44644.1 44694.8 45003.3 45259.3 45645.8 40259.4 40322.0 40954.0 41061.0 41735.6 7109.8 7145.6 7187.5 7392.4 7534.4 31438.4 31611.5 31837.7 32211.5 32289.0 40716.6 41530.6 41996.2 42731.8 42912.4 6694.1 6697.4 6722.7 6727.9 6867.1 9215.8 9656.4 9722.3 10314.2 10347.9 9015.2 9272.1 9422.2 9591.1 9727.7 9259.6 9512.3 9674.8 9683.8 9744.4 8933.0 9163.9 9193.8 9231.8 9234.5 7941.7 8056.4 8149.6 8390.9 8481.5 7939.9 7940.2 7992.2 8154.7 8380.4 12:11:04 INFO - 2015-11-05 12:11:04,362 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:11:04 INFO - 2015-11-05 12:11:04,362 DEBUG : BROWSER_OUTPUT: 12:11:05 INFO - 2015-11-05 12:11:05,226 INFO : Browser exited with error code: 0 12:11:05 INFO - 2015-11-05 12:11:05,258 INFO : Completed test dromaeo_css (00:18:33) 12:11:05 INFO - 2015-11-05 12:11:05,258 INFO : Starting test kraken 12:11:05 INFO - 2015-11-05 12:11:05,258 DEBUG : operating with platform_type : mac_ 12:11:05 INFO - 2015-11-05 12:11:05,258 INFO : Initialising browser for kraken test... 12:11:05 INFO - 2015-11-05 12:11:05,273 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpnn6oAB/profile http://localhost:49264/getInfo.html 12:11:08 INFO - 2015-11-05 12:11:08,415 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:11:08 INFO - 2015-11-05 12:11:08,416 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:11:08 INFO - 2015-11-05 12:11:08,416 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:11:08 INFO - 2015-11-05 12:11:08,416 DEBUG : BROWSER_OUTPUT: __metrics 12:11:09 INFO - 2015-11-05 12:11:09,120 INFO : Browser initialized. 12:11:09 INFO - 2015-11-05 12:11:09,121 INFO : Running cycle 1/1 for kraken test... 12:11:09 INFO - 2015-11-05 12:11:09,121 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpnn6oAB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:11:21 INFO - 2015-11-05 12:11:21,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 232927232 12:11:21 INFO - 2015-11-05 12:11:21,172 DEBUG : BROWSER_OUTPUT: 12:11:23 INFO - 2015-11-05 12:11:23,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:24 INFO - 2015-11-05 12:11:24,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 252170240 12:11:24 INFO - 2015-11-05 12:11:24,586 DEBUG : BROWSER_OUTPUT: 12:11:27 INFO - 2015-11-05 12:11:27,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 12:11:28 INFO - 2015-11-05 12:11:28,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 260239360 12:11:28 INFO - 2015-11-05 12:11:28,113 DEBUG : BROWSER_OUTPUT: 12:11:31 INFO - 2015-11-05 12:11:31,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 12:11:31 INFO - 2015-11-05 12:11:31,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 260079616 12:11:31 INFO - 2015-11-05 12:11:31,878 DEBUG : BROWSER_OUTPUT: 12:11:34 INFO - 2015-11-05 12:11:34,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 12:11:34 INFO - 2015-11-05 12:11:34,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 260341760 12:11:34 INFO - 2015-11-05 12:11:34,620 DEBUG : BROWSER_OUTPUT: 12:11:36 INFO - 2015-11-05 12:11:36,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:37 INFO - 2015-11-05 12:11:37,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 260677632 12:11:37 INFO - 2015-11-05 12:11:37,520 DEBUG : BROWSER_OUTPUT: 12:11:40 INFO - 2015-11-05 12:11:40,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:41 INFO - 2015-11-05 12:11:41,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 261390336 12:11:41 INFO - 2015-11-05 12:11:41,490 DEBUG : BROWSER_OUTPUT: 12:11:44 INFO - 2015-11-05 12:11:44,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:45 INFO - 2015-11-05 12:11:45,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 259166208 12:11:45 INFO - 2015-11-05 12:11:45,575 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-11-05 12:11:48,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 12:11:49 INFO - 2015-11-05 12:11:49,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 258637824 12:11:49 INFO - 2015-11-05 12:11:49,391 DEBUG : BROWSER_OUTPUT: 12:11:51 INFO - 2015-11-05 12:11:51,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:51 INFO - 2015-11-05 12:11:51,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 260460544 12:11:51 INFO - 2015-11-05 12:11:51,671 DEBUG : BROWSER_OUTPUT: 12:11:53 INFO - 2015-11-05 12:11:53,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:54 INFO - 2015-11-05 12:11:54,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 260415488 12:11:54 INFO - 2015-11-05 12:11:54,267 DEBUG : BROWSER_OUTPUT: 12:11:56 INFO - 2015-11-05 12:11:56,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:57 INFO - 2015-11-05 12:11:57,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 260935680 12:11:57 INFO - 2015-11-05 12:11:57,210 DEBUG : BROWSER_OUTPUT: 12:12:00 INFO - 2015-11-05 12:12:00,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:12:00 INFO - 2015-11-05 12:12:00,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 260759552 12:12:00 INFO - 2015-11-05 12:12:00,668 DEBUG : BROWSER_OUTPUT: 12:12:03 INFO - 2015-11-05 12:12:03,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:12:04 INFO - 2015-11-05 12:12:04,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 259096576 12:12:04 INFO - 2015-11-05 12:12:04,094 DEBUG : BROWSER_OUTPUT: 12:12:05 INFO - 2015-11-05 12:12:05,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 12:12:06 INFO - 2015-11-05 12:12:06,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 260485120 12:12:06 INFO - 2015-11-05 12:12:06,192 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;118;129;131;129;138;130;129;129;129 12:12:06 INFO - 2015-11-05 12:12:06,193 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;174;154;181;196;151;175;171;151;187;155 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;190;195;203;192;193;193;193;195;186 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;81;95;130;78;77;82;84;130;81 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;104;149;103;105;104;145;104;105;148 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;137;137;143;137;143;143;136;136;137;143 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;151;150;150;150;149;149;151;150 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;125;127;129;122;121;122;121;123;127 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;70;70;72;74;73;73;71;74;74 12:12:06 INFO - 2015-11-05 12:12:06,194 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;77;80;81;80;81;81;80;81;83 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;101;102;115;104;104;105;107;117;107 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;146;162;152;146;144;150;156;167;155 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;179;179;179;181;181;179;172;176;168 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;82;83;85;83;84;84;84;84;85 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:12:06 INFO - 2015-11-05 12:12:06,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,718 12:12:06 INFO - 2015-11-05 12:12:06,196 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:12:06 INFO - 2015-11-05 12:12:06,196 DEBUG : BROWSER_OUTPUT: __startTimestamp1446754326192__endTimestamp 12:12:06 INFO - 2015-11-05 12:12:06,196 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:12:06 INFO - 2015-11-05 12:12:06,197 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.40 Median:129.00 stddev:5.30 (4.1%) stddev-sans-first:5.09 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 129.0 131.0 129.0 138.0 130.0 129.0 129.0 129.0 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.50 Median:174.50 stddev:16.08 (9.2%) stddev-sans-first:16.98 12:12:06 INFO - 2015-11-05 12:12:06,198 DEBUG : BROWSER_OUTPUT: Values: 174.0 154.0 181.0 196.0 151.0 175.0 171.0 151.0 187.0 155.0 12:12:06 INFO - 2015-11-05 12:12:06,199 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,199 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:192.60 Median:193.00 stddev:4.88 (2.5%) stddev-sans-first:4.56 12:12:06 INFO - 2015-11-05 12:12:06,199 DEBUG : BROWSER_OUTPUT: Values: 186.0 190.0 195.0 203.0 192.0 193.0 193.0 193.0 195.0 186.0 12:12:06 INFO - 2015-11-05 12:12:06,200 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,200 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.40 Median:81.00 stddev:21.02 (26.0%) stddev-sans-first:21.54 12:12:06 INFO - 2015-11-05 12:12:06,200 DEBUG : BROWSER_OUTPUT: Values: 76.0 81.0 95.0 130.0 78.0 77.0 82.0 84.0 130.0 81.0 12:12:06 INFO - 2015-11-05 12:12:06,200 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.70 Median:105.00 stddev:21.21 (20.2%) stddev-sans-first:21.62 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: Values: 100.0 104.0 149.0 103.0 105.0 104.0 145.0 104.0 105.0 148.0 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.20 Median:140.00 stddev:3.29 (2.4%) stddev-sans-first:3.40 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 143.0 137.0 143.0 143.0 136.0 136.0 137.0 143.0 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,201 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 151.0 150.0 150.0 150.0 149.0 149.0 151.0 150.0 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.90 Median:124.00 stddev:2.88 (2.3%) stddev-sans-first:2.98 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 127.0 129.0 122.0 121.0 122.0 121.0 123.0 127.0 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:73.00 stddev:2.80 (3.8%) stddev-sans-first:1.66 12:12:06 INFO - 2015-11-05 12:12:06,202 DEBUG : BROWSER_OUTPUT: Values: 65.0 70.0 70.0 72.0 74.0 73.0 73.0 71.0 74.0 74.0 12:12:06 INFO - 2015-11-05 12:12:06,203 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,203 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:81.00 stddev:1.85 (2.3%) stddev-sans-first:1.59 12:12:06 INFO - 2015-11-05 12:12:06,203 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 80.0 81.0 80.0 81.0 81.0 80.0 81.0 83.0 12:12:06 INFO - 2015-11-05 12:12:06,203 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:106.00 Median:107.00 stddev:5.94 (5.6%) stddev-sans-first:5.56 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: Values: 98.0 101.0 102.0 115.0 104.0 104.0 105.0 107.0 117.0 107.0 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:155.50 stddev:7.35 (4.7%) stddev-sans-first:7.74 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: Values: 156.0 146.0 162.0 152.0 146.0 144.0 150.0 156.0 167.0 155.0 12:12:06 INFO - 2015-11-05 12:12:06,205 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:179.00 stddev:7.33 (4.1%) stddev-sans-first:4.40 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: Values: 158.0 179.0 179.0 179.0 181.0 181.0 179.0 172.0 176.0 168.0 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:0.97 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 83.0 85.0 83.0 84.0 84.0 84.0 84.0 85.0 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:12:06 INFO - 2015-11-05 12:12:06,206 DEBUG : BROWSER_OUTPUT: 12:12:06 INFO - 2015-11-05 12:12:06,911 INFO : Browser exited with error code: 0 12:12:06 INFO - 2015-11-05 12:12:06,965 INFO : Completed test kraken (00:01:01) 12:12:06 INFO - 2015-11-05 12:12:06,965 INFO : Starting test v8_7 12:12:06 INFO - 2015-11-05 12:12:06,965 DEBUG : operating with platform_type : mac_ 12:12:06 INFO - 2015-11-05 12:12:06,965 INFO : Initialising browser for v8_7 test... 12:12:06 INFO - 2015-11-05 12:12:06,980 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmprNDwu9/profile http://localhost:49264/getInfo.html 12:12:10 INFO - 2015-11-05 12:12:10,045 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:12:10 INFO - 2015-11-05 12:12:10,045 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:12:10 INFO - 2015-11-05 12:12:10,045 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:12:10 INFO - 2015-11-05 12:12:10,045 DEBUG : BROWSER_OUTPUT: __metrics 12:12:10 INFO - 2015-11-05 12:12:10,704 INFO : Browser initialized. 12:12:10 INFO - 2015-11-05 12:12:10,704 INFO : Running cycle 1/1 for v8_7 test... 12:12:10 INFO - 2015-11-05 12:12:10,704 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmprNDwu9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:12:22 INFO - 2015-11-05 12:12:22,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 233758720 12:12:22 INFO - 2015-11-05 12:12:22,763 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 12:12:45 INFO - 2015-11-05 12:12:45,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 254566400 12:12:45 INFO - 2015-11-05 12:12:45,575 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |0;Richards;188.07598269700958 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;235.2941176470588 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |2;Encrypt;360.1008282319049 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6500 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1344.0860215053763 12:12:45 INFO - 2015-11-05 12:12:45,576 DEBUG : BROWSER_OUTPUT: |5;Earley;879.6133567662566 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: |6;Boyer;14239.43661971831 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: |7;RegExp;32412.698412698413 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: |8;Splay;717.7476835352816 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6549.019607843137 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: __startTimestamp1446754365565__endTimestamp 12:12:45 INFO - 2015-11-05 12:12:45,577 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: Values: 188.1 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:235.29 Median:235.29 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: Values: 235.3 12:12:45 INFO - 2015-11-05 12:12:45,578 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:360.10 Median:360.10 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: Values: 360.1 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6500.00 Median:6500.00 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: Values: 6500.0 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1344.09 Median:1344.09 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,579 DEBUG : BROWSER_OUTPUT: Values: 1344.1 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:879.61 Median:879.61 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: Values: 879.6 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14239.44 Median:14239.44 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: Values: 14239.4 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,580 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32412.70 Median:32412.70 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: Values: 32412.7 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:717.75 Median:717.75 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: Values: 717.7 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6549.02 Median:6549.02 stddev:0.00 (0.0%) 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: Values: 6549.0 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:12:45 INFO - 2015-11-05 12:12:45,581 DEBUG : BROWSER_OUTPUT: 12:12:46 INFO - 2015-11-05 12:12:46,294 INFO : Browser exited with error code: 0 12:12:46 INFO - 2015-11-05 12:12:46,316 INFO : Completed test v8_7 (00:00:39) 12:12:46 INFO - 2015-11-05 12:12:46,614 INFO : Completed test suite (00:20:14) 12:12:46 INFO - 2015-11-05 12:12:46,614 DEBUG : Working with test: dromaeo_css 12:12:46 INFO - 2015-11-05 12:12:46,614 DEBUG : Generating results file: dromaeo_css 12:12:46 INFO - 2015-11-05 12:12:46,615 DEBUG : Working with test: kraken 12:12:46 INFO - 2015-11-05 12:12:46,615 DEBUG : Generating results file: kraken 12:12:46 INFO - 2015-11-05 12:12:46,615 INFO : javascript benchmark 12:12:46 INFO - 2015-11-05 12:12:46,616 DEBUG : Working with test: v8_7 12:12:46 INFO - 2015-11-05 12:12:46,616 DEBUG : Generating results file: v8_7 12:12:46 INFO - 2015-11-05 12:12:46,616 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:12:46 INFO - 2015-11-05 12:12:46,748 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 12:12:46 INFO - 2015-11-05 12:12:46,748 DEBUG : process_Request line: dromaeo_css 5767.16 graph.html#tests=[[72,63,57]] 12:12:46 INFO - 2015-11-05 12:12:46,749 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:12:46 INFO - 2015-11-05 12:12:46,869 DEBUG : process_Request line: kraken 1781.20 graph.html#tests=[[232,63,57]] 12:12:46 INFO - 2015-11-05 12:12:46,869 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:12:46 INFO - 2015-11-05 12:12:46,987 DEBUG : process_Request line: v8_7 17275.25 graph.html#tests=[[230,63,57]] 12:12:46 INFO - 2015-11-05 12:12:46,988 INFO : javascript benchmark 12:12:47 INFO - 2015-11-05 12:12:46,990 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [295.61717575739414, 295.779644165097, 300.7864416264451, 306.7775862499688, 308.9443900097982, 10501.212409069312, 10838.512266947986, 15260.23698815059, 15693.52919412418, 15893.2848021839, 8966.641334346617, 9199.954000230005, 10201.54093065812, 10331.63839265626, 10419.114375278092, 3855.306044911915, 3946.3093958557283, 3949.3878448840474, 4001.319775638134, 4007.6793856491413, 2971.24233320503, 3974.3243648579664, 3980.2039592081555, 4013.2776100301935, 4016.0, 2993.191838203684, 3081.630204375478, 3895.6299151580556, 3959.9406008909746, 4161.833526658945, 4202.579742025803, 4230.682698797587, 4238.21593005295, 4251.532331443539, 4271.700980931336, 3562.287542491512, 3574.8391322390553, 3585.731070169748, 3616.8734094306574, 3621.130928577149, 11173.944130279297, 11581.18931674783, 11598.130140239517, 11743.354115523643, 11774.116941229357, 1622.2051194914525, 1645.2102990564597, 1655.0235361136988, 1685.162554362079, 1712.3065158610782, 8479.0, 8496.150384961516, 8649.0, 8653.610587523577, 8751.168638979287, 1303.2571434282463, 1385.6743665238662, 1390.221475973448, 1406.6624010237572, 1466.3474753734592, 48992.755036224946, 49172.262416063786, 49904.251436228486, 49914.750426248, 50111.24833127543, 5662.0, 5676.0, 5681.062624666966, 5753.85615359611, 5785.623934444247, 6422.807315780534, 6450.774222902176, 6451.612903225821, 6530.444912182517, 6533.314002029813, 4656.301554766812, 4662.7668616569035, 4679.625629949596, 4701.153792317347, 4753.1444340019125, 4911.852644420673, 4942.950570494321, 4972.776225069881, 4990.476000019946, 5005.124103281911, 2572.15119010726, 2576.4460640962284, 2590.8834102465435, 2611.686597608299, 2627.1724406811795, 917.4586993673764, 920.4477313611914, 922.9769255768659, 927.958241879117, 991.7371896447447, 398.3626198083044, 402.7140730081616, 404.92913740095366, 410.6201763368872, 416.64376957701336, 8708.216260536583, 10355.378677279386, 10395.16838652906, 10541.420221887869, 10770.515326810313, 406.3620116417256, 413.6236025217098, 413.7682897577366, 433.63189138268183, 437.6236436664466, 5422.078246698071, 5576.247206627135, 5580.525655319262, 5590.273264475592, 5633.943660563424, 326677.0, 333133.0, 512533.0, 516919.0, 549985.0, 61125.69437152786, 61801.690991544754, 61803.690981545704, 62254.0, 63694.40763980845, 384.34085543292827, 387.2835254778637, 387.67822707152993, 391.8432626949243, 392.9037385840487, 8507.447015943944, 8837.513936733541, 8900.332475064266, 8913.777155570902, 8915.910840891507, 32059.198520037186, 32569.185770354983, 32603.510947336283, 32644.83677581597, 33213.0, 42767.35848962206, 42816.57183428126, 43424.78287608542, 43586.34620480759, 43962.78018609886, 6619.635920024445, 6675.966620166868, 6786.083878676315, 6856.177258728984, 6870.793876183722, 9847.162991145833, 10333.844992325272, 10373.429461379697, 10430.68707938763, 10470.895291046992, 8947.776305592412, 9012.504312262889, 9038.819223615623, 9083.818323633623, 9135.725928222164, 7529.811754705957, 8708.216260536583, 8737.650493980169, 8743.081976392386, 8968.730938071869, 8427.8735818964, 9057.18485336323, 9102.408343457653, 9142.58858351389, 9224.861627075465, 6428.228612566522, 6547.508936829661, 6839.008343790023, 6849.349311815369, 6902.723891044503, 8283.917160828314, 8394.832103358021, 8479.15208479147, 8737.257333126756, 9320.673776417792], "dojo.html": [2804.495190865644, 2821.590869323948, 2838.971610283898, 2880.9855950720257, 2888.1913064341993, 4815.807367705292, 4817.349657796197, 4827.275908613709, 4865.8540243792695, 4908.484609116036, 4648.581627653519, 4704.694194877331, 4799.136155492019, 4845.975770121145, 4874.9268760968525, 4307.719998200115, 4367.257566213735, 4466.5980061794435, 4492.730436173823, 4590.655700822435, 4405.515393306734, 4449.733016019033, 4467.10657868426, 4467.821287148527, 4569.81720731172, 4269.103488267468, 4436.689431739779, 4459.866204013885, 4536.160810250098, 4558.977205113986, 4315.633171180453, 4398.186335527906, 4412.801423935931, 4423.734575925455, 4459.665525085599, 4382.561743825624, 4412.360207769888, 4437.0, 4443.755593442359, 4490.663200259961, 4539.750313732743, 4633.652476064309, 4667.743274119922, 4726.503717109688, 4784.425868895755, 5026.195808670595, 5048.7223202723835, 5061.595072394236, 5070.797168113271, 5076.82231121909, 5131.255967884673, 5153.948460515422, 5194.194899790538, 5200.0, 5251.054810134175, 4715.669903106784, 4738.715677059387, 4766.976165119152, 4807.903841923142, 4813.7352445615825, 5202.453742356998, 5245.501677340647, 5265.76304066318, 5324.361076670824, 5344.931013797256, 5060.2662613920775, 5076.771545280471, 5078.339815823919, 5084.211947148198, 5110.386753589593, 5005.324281221989, 5073.847784566469, 5079.3650793650795, 5191.195364718475, 5211.166213405837, 5034.597232221414, 5051.3433253676785, 5052.722100284446, 5065.214891691794, 5104.387473503203, 5024.422191447957, 5033.496650334937, 5040.823571174991, 5050.419201791768, 5064.34163558735, 3893.8637147699696, 3947.684185265172, 3987.3420885554137, 4006.539247986519, 4037.7173597848455, 3600.945985810215, 3622.3298689742483, 3639.4176931690804, 3684.060564556021, 3738.925221495609, 4733.384659994247, 4765.475797662254, 4794.328793968847, 4801.5438533339275, 4894.510548945077, 4934.5312195341385, 5049.798008079636, 5052.343195384577, 5061.164907790173, 5126.256692779526, 4726.621870250372, 4733.077049975291, 4755.500672429414, 4802.879928001758, 4808.903821923542, 4457.086297309044, 4517.141743068806, 4533.410656614685, 4558.29346451294, 4659.58063774262, 5233.215017747369, 5241.764120614505, 5247.947520524746, 5305.257263983045, 5314.5748340132695, 4924.581410579997, 5065.493450654905, 5149.356330458692, 5171.3277273954145, 5233.921491177559, 5218.347706536683, 5262.500062494057, 5263.447338029452, 5266.710330931683, 5267.894642107213, 5064.063148317573, 5066.0, 5114.667546609458, 5149.201873709581, 5150.793968241228, 5005.299258103942, 5184.844454666366, 5219.739013049409, 5234.502722241381, 5290.259363689163, 5044.167712327425, 5075.086484432837, 5123.846284611468, 5138.434772175133, 5138.511841375063, 5032.270320803536, 5032.471590482946, 5096.51583099605, 5109.821156259662, 5157.045946499909, 4749.192637251745, 4802.951970480251, 4863.197572400514, 4922.3600931880055, 4969.254611808257, 5042.29407882904, 5080.085584594808, 5086.872828179326, 5106.897862042664, 5123.077845987758, 4808.8797780055775, 4961.280614310833, 4988.027334669705, 4991.725455100004, 5006.249062640487], "mootools.html": [1473.0940471609963, 1550.6743583847392, 1626.642138729479, 1637.8280280570536, 1649.430946323518, 6146.200993870791, 6246.9062964055465, 6867.210270818858, 6970.965145174273, 7058.364747172754, 6539.77110801122, 6703.698333574988, 6819.931800681991, 6825.453963682906, 6836.282190370014, 1936.8741031832956, 1981.1382048808814, 1995.9301424450075, 2006.3278801601482, 2011.5373464103266, 1975.0618456233317, 1988.8607797454183, 2002.539415934336, 2008.7288216090788, 2009.919603215877, 1914.301280032785, 1921.6156768646256, 1947.0, 1953.3651563242004, 1961.0880940362729, 1950.2296592845817, 1956.8238858502662, 1961.2841312920682, 1963.4796778853545, 1987.76146862376, 1880.8307252347354, 1902.7526421565246, 1905.07603812151, 1938.844892408604, 1971.7831038585743, 6765.729370825161, 6783.932160678429, 6784.76253331136, 6803.557768745065, 6852.0, 4136.648384887289, 4142.71001029928, 4153.314703073989, 4194.412782210493, 4209.852655157055, 2448.7306396296394, 2510.598304271308, 2542.3389918621106, 2544.3384719972755, 2559.3345730110304, 730.1347902735275, 735.0517831996718, 747.3610063395827, 768.0092680442223, 786.1784435265162, 8885.2447541959, 8899.866502002475, 8981.236594889442, 8981.955090224506, 9023.909760902372, 3635.94546081809, 3677.9080522987138, 3685.9631403686158, 3701.1117331840164, 3708.6847617952235, 7793.0, 7810.375169986388, 7844.176361482077, 7869.409794265453, 7913.287804097658, 4180.456540649696, 4206.8737937861915, 4217.493900731932, 4241.957580424156, 4253.957460425356, 3395.966040339614, 3577.3381924343557, 3723.255348930225, 3841.327767640652, 3901.1612503311926, 3167.9683203168133, 3169.6830316968117, 3182.8885988990273, 3202.823844688518, 3231.079142444392, 1026.984595231072, 1031.8452232165234, 1032.4682788363998, 1032.7934413117407, 1045.3675526306627, 876.6318146378536, 887.3965703321803, 980.9068138526828, 1167.1538134852165, 1167.6321958583019, 6323.30443651198, 6342.746290148342, 6392.680365981775, 6402.487800976004, 6403.615783053032, 319.63561539844596, 319.65636940289284, 323.4985772053308, 323.6310406978494, 324.9285157265398, 4964.875878103004, 5054.241863720471, 5103.8468845934685, 5114.488551144856, 5169.250458683545, 7787.415943804237, 7871.17352677972, 7885.1326354101, 7932.246436588515, 7942.285194332538, 7654.272844079804, 7767.611619419006, 7803.570803605856, 7891.329237014803, 7896.7236146734585, 6218.689065546704, 6254.9687251563455, 6269.404406581459, 6336.873262534724, 6356.078368636522, 5955.493783028491, 6021.126936594257, 6039.728212230548, 6054.455099041107, 6104.633721976696, 6919.135108111486, 7103.041089452858, 7176.7846964591145, 7212.927870721225, 7215.71137154508, 7240.927590724025, 7283.490155689051, 7301.707931682886, 7336.523125996793, 7339.229380914927, 5487.670739755467, 5528.115501519737, 5757.7121143941795, 5902.822915312548, 5917.349091600006, 6119.724612392542, 6448.129502517288, 6474.546781725234, 6514.902276465951, 6519.771807986698, 5975.641461512323, 6074.578292301125, 6080.300765412034, 6086.513078953762, 6110.1445797587485, 5948.524118070457, 6036.7283472244735, 6041.395860413923, 6052.122442245762, 6081.361457047124, 6033.487153591994, 6043.2748070231855, 6046.90929636047, 6089.665068421279, 6117.632942023492, 5524.640898341595, 5574.136008918624, 5640.294963129609, 5649.548036157015, 5650.378458369494, 5509.228707980806, 5534.7786088556, 5561.304836895388, 5605.80379686709, 5609.074502707171], "ext.html": [487.51492265196123, 499.2137383620796, 509.65852878571354, 511.2969666708276, 516.9405518365387, 35417.64582354176, 36330.818345908236, 36535.26929461416, 36547.817260913725, 36549.26901461969, 38490.4226436603, 39025.41461878074, 39096.609033909655, 39123.21753564927, 39164.21671566567, 8228.62971166299, 8313.95843020784, 8398.580070996457, 8400.0, 8416.579171041454, 7960.800979975489, 8215.055268644122, 8241.505509669409, 8340.541270230135, 8344.332453403713, 8284.958575207145, 8322.417430779848, 8351.540665263408, 8386.622601982925, 8392.664293428255, 8309.916900830975, 8327.0, 8343.582820858963, 8421.0, 8442.831143377129, 8254.257116859511, 8285.62714677841, 8326.750197494084, 8329.000519937586, 8340.124286949844, 35090.0, 35653.07816140248, 35717.64282357169, 35822.0, 35937.82031089828, 2406.350285422926, 2568.8397963796415, 2585.5992321190247, 2810.094863074986, 2842.3036356092684, 24108.638370424458, 24901.128460503976, 25142.748572514225, 25353.239402817944, 25717.871410642827, 2140.2295173737443, 2161.556880839424, 2166.393409845246, 2184.6613774864923, 2192.583409152272, 234030.0, 236502.0, 238826.0, 238969.0, 239354.8032259845, 46509.0, 52848.73575632097, 53116.46883531193, 53642.0, 53721.73139134357, 43900.0, 60884.69557652184, 62784.0, 63745.53781235362, 63804.68097659482, 13276.269805160615, 13284.933575332061, 13328.466861325633, 13381.799273010913, 13542.187468751907, 9807.656732014346, 9859.063388978178, 9865.950670246602, 9947.403155810529, 10027.598896044077, 17506.387276445264, 17518.0, 17572.824271757374, 17797.911010444866, 17839.197236124404, 7834.647440865175, 8152.755417337489, 8156.0, 8175.468594541336, 8221.0, 819.7376839411451, 854.448880472092, 856.8817692910686, 962.932594718363, 967.4717366415168, 25302.873485632455, 25550.361240969123, 25644.615330770055, 25693.3576660585, 25901.09346172875, 924.7040946896929, 971.2861047130353, 1016.3952448293254, 1049.8057859296055, 1057.2018126314583, 13144.211347319191, 13308.667283317995, 13859.861401385857, 14434.843414414823, 14662.78005829892, 285866.0, 292324.0, 295115.0, 296148.0, 296173.0, 49449.75275123601, 49711.50288497069, 49720.75139624351, 49748.253776193385, 49765.0, 1220.200768496636, 1223.9388030598434, 1235.6849003504049, 1246.8628450870397, 1251.7684228417772, 26253.474930501667, 26626.600600990612, 26689.33276668099, 26740.7325926746, 26780.330491737863, 42479.575204248795, 43552.56447435612, 43557.78221108874, 43628.34557481704, 44073.0, 248444.0, 249756.0, 251255.0, 251366.0, 252605.0, 27662.170134895987, 28251.717482824908, 28458.43083138367, 28481.572776407957, 28616.284592885346, 34390.14024649404, 34573.13567160841, 34727.4790878132, 35615.0, 36815.26369472649, 31010.844945775127, 31103.377932441676, 31727.68272317247, 31821.363572727954, 32180.517292241104, 31050.689493105685, 31368.529472057482, 31617.0, 31617.683823161475, 31810.204744881565, 31144.22139446532, 31987.520187196744, 32461.0, 32613.18467038343, 32619.673803262613, 26940.0, 28044.298892527033, 28099.57850632283, 28170.0, 28532.42935141327, 21427.46431339229, 21523.0, 21607.783922161205, 21611.243606474327, 21648.0], "prototype.html": [273.31261876380904, 274.5744096650192, 280.0576061552874, 280.7417176197897, 280.841324651572, 5384.273123128377, 5394.406615272317, 5486.478784515474, 5487.204355368469, 5505.889882202354, 5232.45059268777, 5285.814996475124, 5314.76083576239, 5407.0, 5428.728563571825, 4071.1043570414463, 4072.022714548502, 4073.8981525461804, 4102.2410853992105, 4117.279476091672, 4054.0878302382025, 4074.8777536673797, 4097.385392191165, 4101.425800387948, 4124.649404800595, 3905.882823515285, 4009.4587230723914, 4021.095253567953, 4075.9388609170887, 4093.3041382964966, 3979.960200397988, 3981.7411868228473, 4004.559498455182, 4038.0, 4051.7974101294963, 3428.365752335801, 3429.742769292313, 3430.0, 3439.8968030959113, 3468.4623883298127, 5162.92255616166, 5177.534021938006, 5207.3490813648295, 5236.528712415901, 5242.6330156889035, 4481.708688935209, 4518.728876267402, 4567.2920697291975, 4568.269076947706, 4570.428696412949, 5529.917051244234, 5646.57650676201, 5673.290838645169, 5691.772329106872, 5699.344575373843, 3747.475353450519, 3753.3244016077097, 3761.4545890845948, 3764.0, 3801.8099095045136, 5914.763409463616, 5922.911156332659, 5952.791652292149, 5953.553483488712, 6000.069989151732, 3791.7724936503346, 3816.5610954740005, 3826.9043273918373, 3854.9036274093373, 3877.2051729395407, 3769.4345848122452, 3784.299904517618, 3856.151646637735, 3881.0, 3959.40608908666, 4499.505054444008, 4506.684532082722, 4512.05246898155, 4544.454665440102, 4573.81704731807, 5599.720013999284, 5602.85992850182, 5638.802641907513, 5659.660420374791, 5672.149177623307, 1366.5422083601907, 1394.7210557888463, 1395.483671041721, 1396.72065586881, 1408.499982506216, 858.274757829633, 876.8684697295457, 884.4162852517308, 893.1604291965662, 894.186290475677, 5335.039692855324, 5355.892882142335, 5356.384015838151, 5383.973080134574, 5412.485813847678, 5875.089361149029, 5889.0, 5944.048952167719, 5950.8809823803285, 5954.868574970742, 5325.0, 5342.038433082005, 5359.598030147755, 5401.432849550819, 5402.540784033323, 3160.762942779255, 3246.464333385012, 3268.10127215013, 3288.177955511122, 3291.2759192977505, 5972.25346831646, 6006.099085137177, 6017.69911504423, 6019.909701354483, 6038.849028774316, 5987.9101813472835, 6004.759809607567, 6071.635701857903, 6072.878542429126, 6079.148919151322, 5830.416958304136, 5955.821325360246, 5970.5223582114195, 6018.0, 6028.638281703112, 5969.641821490724, 5998.1002849572915, 6016.2479690038745, 6026.156338112755, 6026.306974697791, 5819.94180058194, 5867.32525759526, 5867.735951882261, 5905.557083218861, 5911.793087241926, 6106.358832322542, 6106.847328816815, 6109.69451527413, 6120.571559990936, 6121.84695382619, 3712.387456069718, 3796.810159491959, 3817.4655548223827, 3824.770513769183, 3852.980735096419, 5767.3367562729145, 5787.39232380594, 5874.148248504029, 5880.617759845596, 5881.206037184926, 5705.572082093942, 5720.771169153188, 5741.282339707536, 5773.451522105393, 5811.360750317546, 5729.71351432435, 5730.197772311796, 5744.569157313302, 5770.076787713946, 5774.711264436845, 5426.972865135649, 5558.777648894161, 5647.20939068539, 5649.435056494318, 5654.6889921054735, 5685.772569097356, 5744.138379243147, 5754.108113242454, 5757.5681823864215, 5758.2514273144225, 5516.862078447911, 5582.385937546947, 5588.6646801192055, 5598.1602759586385, 5605.523530499953], "yui.html": [560.887822435513, 622.2284367384444, 656.8719099775543, 689.5759108148488, 696.8188271049527, 12106.636800895976, 12135.0, 12164.513419463223, 12290.63128106156, 12292.938535307321, 10732.839007414896, 10789.946050269757, 10793.568257269719, 12313.445894934726, 12569.874301256985, 786.7797016835281, 790.2018960849526, 791.9683212671487, 801.8556659801234, 802.1216767639426, 782.7338704840353, 782.9138794732603, 782.949108307961, 784.4234487651571, 791.9841603167933, 783.9255270749298, 796.6972550430828, 806.3589446390105, 812.0174588747593, 813.6379311206485, 793.5199204481293, 799.360511590728, 800.0799081056773, 800.5396896784372, 806.701520437436, 581.137011537866, 582.1558739827267, 583.1806312131462, 583.422411812307, 583.6731430398991, 11998.220115692453, 12073.637790866289, 12163.0, 12169.634910952685, 12268.38658067102, 8372.288355489729, 8383.916160838375, 8392.874106888401, 8590.742277731679, 8831.77920551985, 7827.921720782776, 8074.273315401642, 8133.2680058794995, 8350.290225330855, 8551.187637174458, 2571.537123317802, 2620.5283049051163, 2644.167087367473, 2733.685626152998, 2772.029789573653, 34481.310373792636, 35007.64992350095, 37489.25021499582, 41359.58640413587, 42234.57765422337, 6063.393660633901, 6085.78542214356, 6171.290301615282, 6206.317305096436, 6237.625742455467, 10440.843387349196, 10455.581776728997, 10475.790484190273, 10567.260291779501, 10591.629292974863, 5397.78408863641, 5630.352509461464, 5639.943600563942, 5668.57485688575, 5683.175939488834, 3166.509191075387, 3294.1929227338974, 3321.2029113013186, 3404.0468668772783, 3431.107911942913, 2364.3261670423844, 2367.502824406894, 2398.676178715851, 2401.579723548372, 2403.639454081902, 354.4010622048729, 357.871166380103, 363.3115246607664, 367.2581385601071, 367.2654690618763, 407.4967415242173, 441.6422697614942, 459.00625146557996, 491.54286513542036, 537.7741348633583, 6390.904136437957, 6909.654517274116, 6949.0, 7048.259932707095, 7100.7869763907165, 397.82098055874394, 416.9228692691801, 473.3136951420454, 473.6826326361277, 486.29730040092437, 3139.894306511136, 3225.145336485833, 3304.1739565108724, 3313.4201514734823, 3466.0, 53247.0, 53470.0, 53554.0, 53617.731911340976, 53655.731721341144, 44644.107117857464, 44694.77652611716, 45003.324950125774, 45259.32111018337, 45645.771771140935, 40259.39610905839, 40322.0, 40954.0, 41060.97347566275, 41735.58264417377, 7109.82225444368, 7145.606991615511, 7187.532810367309, 7392.44556658242, 7534.35957943581, 31438.37123257568, 31611.525827113073, 31837.68162318347, 32211.516827247142, 32289.0, 40716.592834072464, 41530.58469415267, 41996.16007679891, 42731.78634106934, 42912.35631465468, 6694.129763130956, 6697.430718388991, 6722.697478613376, 6727.865442691216, 6867.107276054081, 9215.76960575991, 9656.420614763138, 9722.270829687943, 10314.174866010851, 10347.896521034694, 9015.188633023059, 9272.119148680864, 9422.246220302497, 9591.136797688241, 9727.708168754949, 9259.583318750538, 9512.2865785065, 9674.75813104678, 9683.806323873623, 9744.366616169926, 8933.0, 9163.908360916572, 9193.816123677356, 9231.815363692824, 9234.492102934402, 7941.722039728582, 8056.355491560544, 8149.6332665031405, 8390.874136887829, 8481.491110533389, 7939.880901786362, 7940.205979402244, 7992.240737129963, 8154.673813047411, 8380.413371063967]}, "summary": {"suite": 5767.157038827442, "subtests": {"jquery.html": {"filtered": 5794.812215762782, "value": 5794.812215762782}, "dojo.html": {"filtered": 4747.939240186478, "value": 4747.939240186478}, "mootools.html": {"filtered": 3755.0925339591354, "value": 3755.0925339591354}, "ext.html": {"filtered": 16478.732904737877, "value": 16478.732904737877}, "prototype.html": {"filtered": 4230.065784607658, "value": 4230.065784607658}, "yui.html": {"filtered": 5108.463550309861, "value": 5108.463550309861}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1446753152, "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": "20151105102536", "branch": "Mozilla-Inbound", "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 190.0, 195.0, 203.0, 192.0, 193.0, 193.0, 193.0, 195.0, 186.0], "ai-astar": [122.0, 118.0, 129.0, 131.0, 129.0, 138.0, 130.0, 129.0, 129.0, 129.0], "imaging-gaussian-blur": [137.0, 137.0, 143.0, 137.0, 143.0, 143.0, 136.0, 136.0, 137.0, 143.0], "audio-beat-detection": [174.0, 154.0, 181.0, 196.0, 151.0, 175.0, 171.0, 151.0, 187.0, 155.0], "json-stringify-tinderbox": [77.0, 77.0, 80.0, 81.0, 80.0, 81.0, 81.0, 80.0, 81.0, 83.0], "stanford-crypto-pbkdf2": [158.0, 179.0, 179.0, 179.0, 181.0, 181.0, 179.0, 172.0, 176.0, 168.0], "json-parse-financial": [65.0, 70.0, 70.0, 72.0, 74.0, 73.0, 73.0, 71.0, 74.0, 74.0], "stanford-crypto-sha256-iterative": [80.0, 82.0, 83.0, 85.0, 83.0, 84.0, 84.0, 84.0, 84.0, 85.0], "audio-fft": [76.0, 81.0, 95.0, 130.0, 78.0, 77.0, 82.0, 84.0, 130.0, 81.0], "imaging-darkroom": [149.0, 149.0, 151.0, 150.0, 150.0, 150.0, 149.0, 149.0, 151.0, 150.0], "stanford-crypto-ccm": [156.0, 146.0, 162.0, 152.0, 146.0, 144.0, 150.0, 156.0, 167.0, 155.0], "audio-oscillator": [100.0, 104.0, 149.0, 103.0, 105.0, 104.0, 145.0, 104.0, 105.0, 148.0], "stanford-crypto-aes": [98.0, 101.0, 102.0, 115.0, 104.0, 104.0, 105.0, 107.0, 117.0, 107.0], "imaging-desaturate": [122.0, 125.0, 127.0, 129.0, 122.0, 121.0, 122.0, 121.0, 123.0, 127.0]}, "summary": {"suite": 1781.2, "subtests": {"audio-fft": {"filtered": 91.4, "value": 91.4}, "stanford-crypto-pbkdf2": {"filtered": 175.2, "value": 175.2}, "audio-beat-detection": {"filtered": 169.5, "value": 169.5}, "stanford-crypto-ccm": {"filtered": 153.4, "value": 153.4}, "imaging-darkroom": {"filtered": 149.8, "value": 149.8}, "json-parse-financial": {"filtered": 71.6, "value": 71.6}, "audio-oscillator": {"filtered": 116.7, "value": 116.7}, "ai-astar": {"filtered": 128.4, "value": 128.4}, "audio-dft": {"filtered": 192.6, "value": 192.6}, "stanford-crypto-sha256-iterative": {"filtered": 83.4, "value": 83.4}, "json-stringify-tinderbox": {"filtered": 80.1, "value": 80.1}, "imaging-gaussian-blur": {"filtered": 139.2, "value": 139.2}, "stanford-crypto-aes": {"filtered": 106.0, "value": 106.0}, "imaging-desaturate": {"filtered": 123.9, "value": 123.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1446753152, "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": "20151105102536", "branch": "Mozilla-Inbound", "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea"}}, {"talos_counters": {}, "results": {"DeltaBlue": [235.2941176470588], "Encrypt": [360.1008282319049], "NavierStokes": [6549.019607843137], "Decrypt": [6500.0], "Splay": [717.7476835352816], "Richards": [188.07598269700958], "RegExp": [32412.698412698413], "Earley": [879.6133567662566], "Boyer": [14239.43661971831], "RayTrace": [1344.0860215053763]}, "summary": {"suite": 17275.248657631084, "subtests": {"DeltaBlue": {"filtered": 281.0015, "value": 281.0015}, "Encrypt": {"filtered": 739.1846370000003, "value": 739.1846370000003}, "NavierStokes": {"filtered": 226.59880239520942, "value": 226.59880239520942}, "Decrypt": {"filtered": 40.95092307692306, "value": 40.95092307692306}, "Splay": {"filtered": 113.53711320754718, "value": 113.53711320754718}, "RegExp": {"filtered": 28.105805582761974, "value": 28.105805582761974}, "Richards": {"filtered": 187.70073399999998, "value": 187.70073399999998}, "Earley": {"filtered": 757.6772167832169, "value": 757.6772167832169}, "Boyer": {"filtered": 46.80402868447083, "value": 46.80402868447083}, "RayTrace": {"filtered": 550.5518159999998, "value": 550.5518159999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1446753152, "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": "20151105102536", "branch": "Mozilla-Inbound", "revision": "14fe585860cabf63c59dbaabe942e2a621f7e9ea"}}] 12:12:47 INFO - RETURN: dromaeo_css: 5767.16 12:12:47 INFO - RETURN: kraken: 1781.20 12:12:47 INFO - RETURN: v8_7: 17275.25 12:12:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "17275.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1781.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5767.16"}}} 12:12:47 INFO - Return code: 0 12:12:47 INFO - # TBPL SUCCESS # 12:12:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:12:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:12:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:12:47 INFO - 2015-11-05 12:12:47.097 screenresolution[1668:11145] starting screenresolution argv=screenresolution get 12:12:47 INFO - 2015-11-05 12:12:47.100 screenresolution[1668:11145] Display 0: 1600x1200x32@60 12:12:47 INFO - 2015-11-05 12:12:47.107 screenresolution[1669:11148] starting screenresolution argv=screenresolution list 12:12:47 INFO - Available Modes on Display 0 12:12:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:12:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:12:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:12:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:12:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:12:47 INFO - Intel HD Graphics 3000: 12:12:47 INFO - Chipset Model: Intel HD Graphics 3000 12:12:47 INFO - Type: GPU 12:12:47 INFO - Bus: Built-In 12:12:47 INFO - VRAM (Total): 512 MB 12:12:47 INFO - VRAM (Dynamic, Max): 10 12:12:47 INFO - Vendor: Intel (0x8086) 12:12:47 INFO - Device ID: 0x0116 12:12:47 INFO - Revision ID: 0x0009 12:12:47 INFO - Displays: 12:12:47 INFO - Display: 12:12:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:12:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:12:47 INFO - Display Serial Number: 1600x1200 60 12:12:47 INFO - Main Display: Yes 12:12:47 INFO - Mirror: Off 12:12:47 INFO - Online: Yes 12:12:47 INFO - Rotation: Supported 12:12:47 INFO - Return code: 0 12:12:47 INFO - Running post-action listener: _resource_record_post_action 12:12:47 INFO - Running post-run listener: _resource_record_post_run 12:12:48 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 38839296; Write bytes: 689571840; Read time: 4833; Write time: 70949 12:12:48 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 339606016; Write bytes: 334612480; Read time: 35388; Write time: 6079 12:12:48 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 37094400; Write bytes: 343773184; Read time: 4269; Write time: 62051 12:12:48 INFO - Running post-run listener: _upload_blobber_files 12:12:48 INFO - Blob upload gear active. 12:12:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:12:48 INFO - Copying logs to upload dir... 12:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1325.733408 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-05 12:12:48.531057) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 12:12:48.535052) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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/r-FWYr1ESuCM-ZFrQ1BBJQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009984 build_url: 'https://queue.taskcluster.net/v1/task/r-FWYr1ESuCM-ZFrQ1BBJQ/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-05 12:12:48.561062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 12:12:48.561457) ========= 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.GfBXB1cNaz/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.94YUgdxYRH/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 12:12:48.610674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 12:12:48.611007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 12:12:48.611401) ========= ========= Total master_lag: 0.79 =========