builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0105 starttime: 1447802177.06 results: success (0) buildid: 20151117132206 builduid: fdbcce7182a24f60a142e04b34c3f4bf revision: 8c3a0b58fd51c02c8aca138b0da58445becb037f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.059545) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.059953) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.060239) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.005971 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.083465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.083740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.099035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.099318) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.005753 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.360020) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.360393) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.360757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.361042) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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-17 15:16:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.5M=0s 2015-11-17 15:16:17 (29.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.582508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.582852) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.022099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.631867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:17.632245) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a0b58fd51c02c8aca138b0da58445becb037f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a0b58fd51c02c8aca138b0da58445becb037f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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-17 15:16:17,725 truncating revision to first 12 chars 2015-11-17 15:16:17,726 Setting DEBUG logging. 2015-11-17 15:16:17,726 attempt 1/10 2015-11-17 15:16:17,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3a0b58fd51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 15:16:17,999 unpacking tar archive at: mozilla-central-8c3a0b58fd51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684941 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:18.357294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:18.357609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:18.371664) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:18.371952) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:16:18.372345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-17 15:16:18.372641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:16:18 INFO - MultiFileLogger online at 20151117 15:16:18 in /builds/slave/test 15:16:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:16:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:18 INFO - {'append_to_log': False, 15:16:18 INFO - 'base_work_dir': '/builds/slave/test', 15:16:18 INFO - 'blob_upload_branch': 'Firefox', 15:16:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:18 INFO - 'branch': 'Firefox', 15:16:18 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:18 INFO - 'config_files': ('talos/mac_config.py',), 15:16:18 INFO - 'default_actions': ('clobber', 15:16:18 INFO - 'read-buildbot-config', 15:16:18 INFO - 'download-and-extract', 15:16:18 INFO - 'populate-webroot', 15:16:18 INFO - 'create-virtualenv', 15:16:18 INFO - 'install', 15:16:18 INFO - 'run-tests'), 15:16:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:18 INFO - 'download_minidump_stackwalk': True, 15:16:18 INFO - 'download_symbols': 'ondemand', 15:16:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:18 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:18 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:18 INFO - 'installer_path': 'installer.exe', 15:16:18 INFO - 'log_level': 'info', 15:16:18 INFO - 'log_name': 'talos', 15:16:18 INFO - 'log_to_console': True, 15:16:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:16:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:16:18 INFO - 'opt_config_files': (), 15:16:18 INFO - 'pip_index': False, 15:16:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:18 INFO - 'cmd': ('bash', 15:16:18 INFO - '-c', 15:16:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:18 INFO - 'enabled': True, 15:16:18 INFO - 'halt_on_failure': False, 15:16:18 INFO - 'name': 'check_screen_resolution'},), 15:16:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:18 INFO - 'cmd': ('bash', 15:16:18 INFO - '-c', 15:16:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:18 INFO - 'enabled': True, 15:16:18 INFO - 'halt_on_failure': False, 15:16:18 INFO - 'name': 'check_screen_resolution'},), 15:16:18 INFO - 'run_cmd_checks_enabled': True, 15:16:18 INFO - 'sps_profile': False, 15:16:18 INFO - 'sps_profile_interval': 0, 15:16:18 INFO - 'suite': 'dromaeojs', 15:16:18 INFO - 'system_bits': '64', 15:16:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:18 INFO - 'title': 't-yosemite-r5-0105', 15:16:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:18 INFO - 'use_talos_json': True, 15:16:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:18 INFO - 'work_dir': 'build'} 15:16:18 INFO - ##### 15:16:18 INFO - ##### Running clobber step. 15:16:18 INFO - ##### 15:16:18 INFO - Running pre-action listener: _resource_record_pre_action 15:16:18 INFO - Running main action method: clobber 15:16:18 INFO - rmtree: /builds/slave/test/build 15:16:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:21 INFO - Running post-action listener: _resource_record_post_action 15:16:21 INFO - ##### 15:16:21 INFO - ##### Running read-buildbot-config step. 15:16:21 INFO - ##### 15:16:21 INFO - Running pre-action listener: _resource_record_pre_action 15:16:21 INFO - Running main action method: read_buildbot_config 15:16:21 INFO - Using buildbot properties: 15:16:21 INFO - { 15:16:21 INFO - "properties": { 15:16:21 INFO - "buildnumber": 483, 15:16:21 INFO - "product": "firefox", 15:16:21 INFO - "script_repo_revision": "production", 15:16:21 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 15:16:21 INFO - "repository": "", 15:16:21 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 15:16:21 INFO - "buildid": "20151117132206", 15:16:21 INFO - "slavename": "t-yosemite-r5-0105", 15:16:21 INFO - "pgo_build": "False", 15:16:21 INFO - "basedir": "/builds/slave/test", 15:16:21 INFO - "project": "", 15:16:21 INFO - "platform": "yosemite", 15:16:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:16:21 INFO - "slavebuilddir": "test", 15:16:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:16:21 INFO - "branch": "mozilla-central", 15:16:21 INFO - "repo_path": "mozilla-central", 15:16:21 INFO - "stage_platform": "macosx64", 15:16:21 INFO - "builduid": "fdbcce7182a24f60a142e04b34c3f4bf", 15:16:21 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 15:16:21 INFO - }, 15:16:21 INFO - "sourcestamp": { 15:16:21 INFO - "repository": "", 15:16:21 INFO - "hasPatch": false, 15:16:21 INFO - "project": "", 15:16:21 INFO - "branch": "mozilla-central-macosx64-talos", 15:16:21 INFO - "changes": [ 15:16:21 INFO - { 15:16:21 INFO - "category": null, 15:16:21 INFO - "files": [ 15:16:21 INFO - { 15:16:21 INFO - "url": null, 15:16:21 INFO - "name": "https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:16:21 INFO - } 15:16:21 INFO - ], 15:16:21 INFO - "repository": "", 15:16:21 INFO - "rev": "8c3a0b58fd51c02c8aca138b0da58445becb037f", 15:16:21 INFO - "who": "kwierso@gmail.com", 15:16:21 INFO - "when": 1447801355, 15:16:21 INFO - "number": 6674396, 15:16:21 INFO - "comments": "Merge b2ginbound to central, a=merge", 15:16:21 INFO - "project": "", 15:16:21 INFO - "at": "Tue 17 Nov 2015 15:02:35", 15:16:21 INFO - "branch": "mozilla-central-macosx64-talos", 15:16:21 INFO - "revlink": "", 15:16:21 INFO - "properties": [ 15:16:21 INFO - [ 15:16:21 INFO - "buildid", 15:16:21 INFO - "20151117132206", 15:16:21 INFO - "Change" 15:16:21 INFO - ], 15:16:21 INFO - [ 15:16:21 INFO - "builduid", 15:16:21 INFO - "fdbcce7182a24f60a142e04b34c3f4bf", 15:16:21 INFO - "Change" 15:16:21 INFO - ], 15:16:21 INFO - [ 15:16:21 INFO - "pgo_build", 15:16:21 INFO - "False", 15:16:21 INFO - "Change" 15:16:21 INFO - ] 15:16:21 INFO - ], 15:16:21 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 15:16:21 INFO - } 15:16:21 INFO - ], 15:16:21 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 15:16:21 INFO - } 15:16:21 INFO - } 15:16:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:16:21 INFO - Running post-action listener: _resource_record_post_action 15:16:21 INFO - ##### 15:16:21 INFO - ##### Running download-and-extract step. 15:16:21 INFO - ##### 15:16:21 INFO - Running pre-action listener: _resource_record_pre_action 15:16:21 INFO - Running main action method: download_and_extract 15:16:21 INFO - mkdir: /builds/slave/test/build/tests 15:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:21 INFO - https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/test_packages.json 15:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/test_packages.json 15:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:16:22 INFO - Downloaded 1149 bytes. 15:16:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:16:22 INFO - Using the following test package requirements: 15:16:22 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:16:22 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:16:22 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'jsshell-mac.zip'], 15:16:22 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:16:22 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:16:22 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:16:22 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:16:22 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:16:22 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:16:22 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:16:22 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:16:22 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:16:22 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')]} 15:16:22 INFO - https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:23 INFO - Downloaded 17463576 bytes. 15:16:23 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 15:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:16:28 INFO - Return code: 0 15:16:28 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 15:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:28 INFO - https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:32 INFO - Downloaded 17463576 bytes. 15:16:32 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 15:16:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:16:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:16:38 INFO - Return code: 0 15:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:38 INFO - https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:39 INFO - Downloaded 11131693 bytes. 15:16:39 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 15:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:16:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:16:39 INFO - Return code: 0 15:16: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')]} 15:16:39 INFO - https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/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 15:16:44 INFO - Downloaded 108842501 bytes. 15:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:16:44 INFO - mkdir: /builds/slave/test/properties 15:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:44 INFO - Contents: 15:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:16:44 INFO - Running post-action listener: _resource_record_post_action 15:16:44 INFO - Running post-action listener: set_extra_try_arguments 15:16:44 INFO - ##### 15:16:44 INFO - ##### Running populate-webroot step. 15:16:44 INFO - ##### 15:16:44 INFO - Running pre-action listener: _resource_record_pre_action 15:16:44 INFO - Running main action method: populate_webroot 15:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:16:44 INFO - '../fennec_ids.txt'], 15:16:44 INFO - 'tests': ['tcheck2']}, 15:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:44 INFO - '--tppagecycles', 15:16:44 INFO - '7'], 15:16:44 INFO - 'tests': ['tsvgm']}}, 15:16:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:16:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:16:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['damp', 'tps']}, 15:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['damp', 'tps']}, 15:16:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:44 INFO - 'other': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'other_l64': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'other_nol64': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore']}, 15:16:44 INFO - 'svgr': {'tests': ['tsvgx', 15:16:44 INFO - 'tsvgr_opacity', 15:16:44 INFO - 'tart', 15:16:44 INFO - 'tscrollx', 15:16:44 INFO - 'cart']}, 15:16:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['tsvgx', 15:16:44 INFO - 'tsvgr_opacity', 15:16:44 INFO - 'tart', 15:16:44 INFO - 'tscrollx', 15:16:44 INFO - 'cart']}, 15:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['tp5o']}, 15:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--e10s'], 15:16:44 INFO - 'tests': ['tp5o']}, 15:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--xperf_path', 15:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:44 INFO - 'tests': ['tp5n']}, 15:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--e10s', 15:16:44 INFO - '--xperf_path', 15:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:44 INFO - 'tests': ['tp5n']}}, 15:16:44 INFO - 'talos.zip': {'path': '', 15:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:44 INFO - Running post-action listener: _resource_record_post_action 15:16:44 INFO - ##### 15:16:44 INFO - ##### Running create-virtualenv step. 15:16:44 INFO - ##### 15:16:44 INFO - Running pre-action listener: _resource_record_pre_action 15:16:44 INFO - Running main action method: create_virtualenv 15:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:44 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 15:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:44 INFO - Using real prefix '/tools/python27' 15:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:49 INFO - Installing pip.................done. 15:16:49 INFO - Return code: 0 15:16:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:16:49 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 15:16:49 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 15:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:49 INFO - 'HOME': '/Users/cltbld', 15:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:49 INFO - 'LOGNAME': 'cltbld', 15:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:49 INFO - 'MOZ_NO_REMOTE': '1', 15:16:49 INFO - 'NO_EM_RESTART': '1', 15:16:49 INFO - 'PAGER': '/bin/cat', 15:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:49 INFO - 'PWD': '/builds/slave/test', 15:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:49 INFO - 'SHELL': '/bin/bash', 15:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:16:49 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:49 INFO - 'USER': 'cltbld', 15:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:49 INFO - 'XPC_FLAGS': '0x0', 15:16:49 INFO - 'XPC_SERVICE_NAME': '0', 15:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:49 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 15:16:49 INFO - Cleaning up... 15:16:49 INFO - Return code: 0 15:16:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:16:49 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 15:16:49 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 15:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:49 INFO - 'HOME': '/Users/cltbld', 15:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:49 INFO - 'LOGNAME': 'cltbld', 15:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:49 INFO - 'MOZ_NO_REMOTE': '1', 15:16:49 INFO - 'NO_EM_RESTART': '1', 15:16:49 INFO - 'PAGER': '/bin/cat', 15:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:49 INFO - 'PWD': '/builds/slave/test', 15:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:49 INFO - 'SHELL': '/bin/bash', 15:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:16:49 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:49 INFO - 'USER': 'cltbld', 15:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:49 INFO - 'XPC_FLAGS': '0x0', 15:16:49 INFO - 'XPC_SERVICE_NAME': '0', 15:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:50 INFO - Downloading/unpacking psutil>=0.7.1 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:16:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:52 INFO - Installing collected packages: psutil 15:16:52 INFO - Running setup.py install for psutil 15:16:53 INFO - building 'psutil._psutil_osx' extension 15:16:53 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 15:16:53 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 15:16:53 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 15:16:53 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 15:16:53 INFO - building 'psutil._psutil_posix' extension 15:16:53 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 15:16:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:16:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:16:53 INFO - ^ 15:16:53 INFO - 1 warning generated. 15:16:53 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 15:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:54 INFO - Successfully installed psutil 15:16:54 INFO - Cleaning up... 15:16:54 INFO - Return code: 0 15:16:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:54 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:16:54 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 15:16:54 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 15:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:54 INFO - 'HOME': '/Users/cltbld', 15:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:54 INFO - 'LOGNAME': 'cltbld', 15:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:54 INFO - 'MOZ_NO_REMOTE': '1', 15:16:54 INFO - 'NO_EM_RESTART': '1', 15:16:54 INFO - 'PAGER': '/bin/cat', 15:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:54 INFO - 'PWD': '/builds/slave/test', 15:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:54 INFO - 'SHELL': '/bin/bash', 15:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:16:54 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:54 INFO - 'USER': 'cltbld', 15:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:54 INFO - 'XPC_FLAGS': '0x0', 15:16:54 INFO - 'XPC_SERVICE_NAME': '0', 15:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:16:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:16:57 INFO - Installing collected packages: mozsystemmonitor 15:16:57 INFO - Running setup.py install for mozsystemmonitor 15:16:57 INFO - Successfully installed mozsystemmonitor 15:16:57 INFO - Cleaning up... 15:16:57 INFO - Return code: 0 15:16:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:57 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')]} 15:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:57 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')]} 15:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:57 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:16:57 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 15:16:57 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 15:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:57 INFO - 'HOME': '/Users/cltbld', 15:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:57 INFO - 'LOGNAME': 'cltbld', 15:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:57 INFO - 'MOZ_NO_REMOTE': '1', 15:16:57 INFO - 'NO_EM_RESTART': '1', 15:16:57 INFO - 'PAGER': '/bin/cat', 15:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:57 INFO - 'PWD': '/builds/slave/test', 15:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:57 INFO - 'SHELL': '/bin/bash', 15:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:16:57 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:57 INFO - 'USER': 'cltbld', 15:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:57 INFO - 'XPC_FLAGS': '0x0', 15:16:57 INFO - 'XPC_SERVICE_NAME': '0', 15:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:00 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 15:17:00 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 15:17:00 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 15:17:00 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 15:17:00 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 15:17:00 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 15:17:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:01 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 15:17:01 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 15:17:01 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 15:17:01 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 15:17:01 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 15:17:01 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 15:17:01 INFO - Downloading docopt-0.6.1.tar.gz 15:17:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:01 INFO - Running setup.py install for blobuploader 15:17:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:02 INFO - Running setup.py install for requests 15:17:02 INFO - Running setup.py install for docopt 15:17:02 INFO - Successfully installed blobuploader requests docopt 15:17:02 INFO - Cleaning up... 15:17:02 INFO - Return code: 0 15:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:02 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:17:02 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 15:17:02 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 15:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:02 INFO - 'HOME': '/Users/cltbld', 15:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:02 INFO - 'LOGNAME': 'cltbld', 15:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:02 INFO - 'MOZ_NO_REMOTE': '1', 15:17:02 INFO - 'NO_EM_RESTART': '1', 15:17:02 INFO - 'PAGER': '/bin/cat', 15:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:02 INFO - 'PWD': '/builds/slave/test', 15:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:02 INFO - 'SHELL': '/bin/bash', 15:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:17:02 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:02 INFO - 'USER': 'cltbld', 15:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:02 INFO - 'XPC_FLAGS': '0x0', 15:17:02 INFO - 'XPC_SERVICE_NAME': '0', 15:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-4pSv0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-iE2Ykr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-DidbWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-fsnaEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-4cfVde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:03 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-CLLt09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-MvdDwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Boz_xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-gec6Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-h0BiMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-EIlM2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-WtHseY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:04 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-zUHOi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:05 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-UDozrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:05 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-DodcZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:05 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Pxkskt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:05 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-WebsBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:05 INFO - Running setup.py install for manifestparser 15:17:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:05 INFO - Running setup.py install for mozcrash 15:17:05 INFO - Running setup.py install for mozdebug 15:17:06 INFO - Running setup.py install for mozdevice 15:17:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:06 INFO - Running setup.py install for mozfile 15:17:06 INFO - Running setup.py install for mozhttpd 15:17:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:06 INFO - Running setup.py install for mozinfo 15:17:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:06 INFO - Running setup.py install for mozInstall 15:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Running setup.py install for mozleak 15:17:07 INFO - Running setup.py install for mozlog 15:17:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Running setup.py install for moznetwork 15:17:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:07 INFO - Running setup.py install for mozprocess 15:17:07 INFO - Running setup.py install for mozprofile 15:17:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:08 INFO - Running setup.py install for mozrunner 15:17:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:08 INFO - Running setup.py install for mozscreenshot 15:17:08 INFO - Running setup.py install for moztest 15:17:08 INFO - Running setup.py install for mozversion 15:17:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:08 INFO - Cleaning up... 15:17:08 INFO - Return code: 0 15:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:08 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:17:08 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 15:17:08 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 15:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:08 INFO - 'HOME': '/Users/cltbld', 15:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:08 INFO - 'LOGNAME': 'cltbld', 15:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:08 INFO - 'MOZ_NO_REMOTE': '1', 15:17:08 INFO - 'NO_EM_RESTART': '1', 15:17:08 INFO - 'PAGER': '/bin/cat', 15:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:08 INFO - 'PWD': '/builds/slave/test', 15:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:08 INFO - 'SHELL': '/bin/bash', 15:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:17:08 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:08 INFO - 'USER': 'cltbld', 15:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:08 INFO - 'XPC_FLAGS': '0x0', 15:17:08 INFO - 'XPC_SERVICE_NAME': '0', 15:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-h6vOAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:09 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)) 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-6VXB_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:09 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)) 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-BVLt_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:09 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)) 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-jaAsAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:09 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)) 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-zUaYKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:09 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)) 15:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:09 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-VKN3dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-SA8lqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-JfgZGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-hoIZSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-qzgnp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-HCx7k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-aB7ehu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:10 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)) 15:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:10 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-wWb8fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:11 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)) 15:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:11 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-KpJ98E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:11 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)) 15:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:11 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-_D9U5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:11 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)) 15:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:11 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-sdCN66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:11 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)) 15:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:11 INFO - Running setup.py (path:/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/pip-Pb0xYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:11 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)) 15:17:11 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)) 15:17:11 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)) 15:17:11 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)) 15:17:11 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)) 15:17:11 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)) 15:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:14 INFO - Downloading blessings-1.5.1.tar.gz 15:17:14 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 15:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:14 INFO - Installing collected packages: blessings 15:17:14 INFO - Running setup.py install for blessings 15:17:14 INFO - Successfully installed blessings 15:17:14 INFO - Cleaning up... 15:17:14 INFO - Return code: 0 15:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:15 INFO - Reading from file tmpfile_stdout 15:17:15 INFO - Current package versions: 15:17:15 INFO - blessings == 1.5.1 15:17:15 INFO - blobuploader == 1.2.4 15:17:15 INFO - docopt == 0.6.1 15:17:15 INFO - manifestparser == 1.1 15:17:15 INFO - mozInstall == 1.12 15:17:15 INFO - mozcrash == 0.16 15:17:15 INFO - mozdebug == 0.1 15:17:15 INFO - mozdevice == 0.47 15:17:15 INFO - mozfile == 1.2 15:17:15 INFO - mozhttpd == 0.7 15:17:15 INFO - mozinfo == 0.9 15:17:15 INFO - mozleak == 0.1 15:17:15 INFO - mozlog == 3.0 15:17:15 INFO - moznetwork == 0.27 15:17:15 INFO - mozprocess == 0.22 15:17:15 INFO - mozprofile == 0.27 15:17:15 INFO - mozrunner == 6.11 15:17:15 INFO - mozscreenshot == 0.1 15:17:15 INFO - mozsystemmonitor == 0.0 15:17:15 INFO - moztest == 0.7 15:17:15 INFO - mozversion == 1.4 15:17:15 INFO - psutil == 3.1.1 15:17:15 INFO - requests == 1.2.3 15:17:15 INFO - wsgiref == 0.1.2 15:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 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 0x10dd70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c0e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, '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.3nQbPPbjOI/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.sbCO8vdogj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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 15:17:15 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 15:17:15 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 15:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:15 INFO - 'HOME': '/Users/cltbld', 15:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:15 INFO - 'LOGNAME': 'cltbld', 15:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:15 INFO - 'MOZ_NO_REMOTE': '1', 15:17:15 INFO - 'NO_EM_RESTART': '1', 15:17:15 INFO - 'PAGER': '/bin/cat', 15:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:15 INFO - 'PWD': '/builds/slave/test', 15:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:15 INFO - 'SHELL': '/bin/bash', 15:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:17:15 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:15 INFO - 'USER': 'cltbld', 15:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:15 INFO - 'XPC_FLAGS': '0x0', 15:17:15 INFO - 'XPC_SERVICE_NAME': '0', 15:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 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)) 15:17:15 INFO - Cleaning up... 15:17:15 INFO - Return code: 0 15:17:15 INFO - Running post-action listener: _resource_record_post_action 15:17:15 INFO - Running post-action listener: _start_resource_monitoring 15:17:15 INFO - Starting resource monitoring. 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running install step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: install 15:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:15 INFO - Reading from file tmpfile_stdout 15:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:16 INFO - Reading from file tmpfile_stdout 15:17:16 INFO - Output received: 15:17:16 INFO - Usage: mozinstall [options] installer 15:17:16 INFO - Options: 15:17:16 INFO - -h, --help show this help message and exit 15:17:16 INFO - -d DEST, --destination=DEST 15:17:16 INFO - Directory to install application into. [default: 15:17:16 INFO - "/builds/slave/test"] 15:17:16 INFO - --app=APP Application being installed. [default: firefox] 15:17:16 INFO - mkdir: /builds/slave/test/build/application 15:17:16 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'] 15:17:16 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 15:17:57 INFO - Reading from file tmpfile_stdout 15:17:57 INFO - Output received: 15:17:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:17:57 INFO - Running post-action listener: _resource_record_post_action 15:17:57 INFO - ##### 15:17:57 INFO - ##### Running run-tests step. 15:17:57 INFO - ##### 15:17:57 INFO - Running pre-action listener: _resource_record_pre_action 15:17:57 INFO - Running main action method: run_tests 15:17:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:17:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:17:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:17:57 INFO - 2015-11-17 15:17:57.672 screenresolution[2203:18759] starting screenresolution argv=screenresolution get 15:17:57 INFO - 2015-11-17 15:17:57.676 screenresolution[2203:18759] Display 0: 1600x1200x32@60 15:17:57 INFO - 2015-11-17 15:17:57.683 screenresolution[2204:18761] starting screenresolution argv=screenresolution list 15:17:57 INFO - Available Modes on Display 0 15:17:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:17:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:17:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:17:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:17:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:17:57 INFO - Intel HD Graphics 3000: 15:17:57 INFO - Chipset Model: Intel HD Graphics 3000 15:17:57 INFO - Type: GPU 15:17:57 INFO - Bus: Built-In 15:17:57 INFO - VRAM (Total): 512 MB 15:17:57 INFO - VRAM (Dynamic, Max): 10 15:17:57 INFO - Vendor: Intel (0x8086) 15:17:57 INFO - Device ID: 0x0116 15:17:57 INFO - Revision ID: 0x0009 15:17:57 INFO - Displays: 15:17:57 INFO - Display: 15:17:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:17:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:17:57 INFO - Display Serial Number: 1600x1200 60 15:17:57 INFO - Main Display: Yes 15:17:57 INFO - Mirror: Off 15:17:57 INFO - Online: Yes 15:17:57 INFO - Rotation: Supported 15:17:57 INFO - Return code: 0 15:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:57 INFO - Python 2.7.3 15:17:57 INFO - Return code: 0 15:17:57 INFO - grabbing minidump binary from tooltool 15:17:57 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')]} 15:17:57 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 0x10dc939f0>, '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 0x10d9f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc878c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:57 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 15:17:57 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 15:17:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:58 INFO - Return code: 0 15:17:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:17:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:17:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] in /builds/slave/test/build 15:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0105 --webServer localhost 15:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3nQbPPbjOI/Render', 15:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:58 INFO - 'HOME': '/Users/cltbld', 15:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:58 INFO - 'LOGNAME': 'cltbld', 15:17:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:58 INFO - 'MOZ_NO_REMOTE': '1', 15:17:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:58 INFO - 'NO_EM_RESTART': '1', 15:17:58 INFO - 'PAGER': '/bin/cat', 15:17:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:58 INFO - 'PWD': '/builds/slave/test', 15:17:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:58 INFO - 'SHELL': '/bin/bash', 15:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sbCO8vdogj/Listeners', 15:17:58 INFO - 'TMPDIR': '/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/', 15:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:58 INFO - 'USER': 'cltbld', 15:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:58 INFO - 'XPC_FLAGS': '0x0', 15:17:58 INFO - 'XPC_SERVICE_NAME': '0', 15:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:17:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0105', '--webServer', 'localhost'] with output_timeout 3600 15:17:58 INFO - mozversion INFO | application_buildid: 20151117132206 15:17:58 INFO - mozversion INFO | application_changeset: 8c3a0b58fd51c02c8aca138b0da58445becb037f 15:17:58 INFO - mozversion INFO | application_display_name: Nightly 15:17:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:58 INFO - mozversion INFO | application_name: Firefox 15:17:58 INFO - mozversion INFO | application_remotingname: firefox 15:17:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:17:58 INFO - mozversion INFO | application_vendor: Mozilla 15:17:58 INFO - mozversion INFO | application_version: 45.0a1 15:17:58 INFO - mozversion INFO | platform_buildid: 20151117132206 15:17:58 INFO - mozversion INFO | platform_changeset: 8c3a0b58fd51c02c8aca138b0da58445becb037f 15:17:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:17:58 INFO - mozversion INFO | platform_version: 45.0a1 15:17:58 INFO - 2015-11-17 15:17:58,355 DEBUG : using testdate: 1447802278 15:17:58 INFO - 2015-11-17 15:17:58,355 DEBUG : actual date: 1447802278 15:17:58 INFO - 2015-11-17 15:17:58,364 INFO : starting webserver on 'localhost:57345' 15:17:58 INFO - 2015-11-17 15:17:58,366 INFO : Starting test suite t-yosemite-r5-0105 15:17:58 INFO - 2015-11-17 15:17:58,366 INFO : Starting test dromaeo_css 15:17:58 INFO - 2015-11-17 15:17:58,366 DEBUG : operating with platform_type : mac_ 15:17:58 INFO - 2015-11-17 15:17:58,367 INFO : Initialising browser for dromaeo_css test... 15:17:58 INFO - 2015-11-17 15:17:58,404 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpA43G3p/profile http://localhost:57345/getInfo.html 15:18:00 INFO - 2015-11-17 15:18:00,988 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:18:00 INFO - 2015-11-17 15:18:00,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:18:00 INFO - 2015-11-17 15:18:00,989 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:18:00 INFO - 2015-11-17 15:18:00,989 DEBUG : BROWSER_OUTPUT: __metrics 15:18:01 INFO - 2015-11-17 15:18:01,006 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:01 INFO - 2015-11-17 15:18:01,811 INFO : Browser initialized. 15:18:01 INFO - 2015-11-17 15:18:01,811 INFO : Running cycle 1/1 for dromaeo_css test... 15:18:01 INFO - 2015-11-17 15:18:01,811 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpA43G3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:18:13 INFO - 2015-11-17 15:18:13,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 230117376 15:18:13 INFO - 2015-11-17 15:18:13,954 DEBUG : BROWSER_OUTPUT: 15:19:05 INFO - 2015-11-17 15:19:05,681 DEBUG : BROWSER_OUTPUT: 1447802345677 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] 15:21:16 INFO - 2015-11-17 15:21:16,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57345/tests/dromaeo/cssquery-ext.html) 15:21:17 INFO - 2015-11-17 15:21:17,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 352165888 15:21:17 INFO - 2015-11-17 15:21:17,412 DEBUG : BROWSER_OUTPUT: 15:24:20 INFO - 2015-11-17 15:24:20,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-ext.html (next: http://localhost:57345/tests/dromaeo/cssquery-jquery.html) 15:24:21 INFO - 2015-11-17 15:24:21,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 367915008 15:24:21 INFO - 2015-11-17 15:24:21,038 DEBUG : BROWSER_OUTPUT: 15:27:23 INFO - 2015-11-17 15:27:23,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57345/tests/dromaeo/cssquery-mootools.html) 15:27:23 INFO - 2015-11-17 15:27:23,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 339279872 15:27:23 INFO - 2015-11-17 15:27:23,781 DEBUG : BROWSER_OUTPUT: 15:30:25 INFO - 2015-11-17 15:30:25,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57345/tests/dromaeo/cssquery-prototype.html) 15:30:26 INFO - 2015-11-17 15:30:26,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 331997184 15:30:26 INFO - 2015-11-17 15:30:26,578 DEBUG : BROWSER_OUTPUT: 15:33:29 INFO - 2015-11-17 15:33:29,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57345/tests/dromaeo/cssquery-yui.html) 15:33:30 INFO - 2015-11-17 15:33:30,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 331649024 15:33:30 INFO - 2015-11-17 15:33:30,448 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/dromaeo/cssquery-yui.html (next: http://localhost:57345/tests/dromaeo/cssquery-dojo.html) 15:36:33 INFO - 2015-11-17 15:36:33,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 372113408 15:36:33 INFO - 2015-11-17 15:36:33,577 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,577 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:36:33 INFO - 2015-11-17 15:36:33,577 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:36:33 INFO - 2015-11-17 15:36:33,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:36:33 INFO - 2015-11-17 15:36:33,578 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:36:33 INFO - 2015-11-17 15:36:33,579 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2571.2671888511773;2675.5852842809372;2694.9056783012597;2717.918462446126;2730.9453810923783;4435.31252655838;4480.395146655201;4516.751578663172;4519.751413672247;4608.562186592277;4423.845165419219;4465.977670111653;4569.109023740372;4609.216433206355;4614.192516309649;4131.6281534661875;4185.225733239346;4192.49690037196;4233.745975241495;4254.744715317075;4279.336702811053;4290.584107244602;4331.155424692186;4344.717593356421;4411.779411029452;4082.142750022499;4089.9795501022604;4233.153369326116;4300.956990430102;4331.393604895317;4223.535411104776;4228.556001619816;4261.31818908973;4286.335617979218;4305.246581848164;4183.477065366829;4231.640310573605;4255.87232383029;4290.528041915387;4303.289957157065;4333.913321733579;4516.728996260234;4545.11370282795;4592.425946756655;4665.440147182326;4729.101470720587;4739.786709598076;4749.1926372516755;4811.182099043171;4821.614270858323;4915;4922.089413458521;4959.057779021974;4965.354503914468;4969.304297398367;4403.911921761547;4579.771011449414;4614.031053478773;4617.861464156081;4663.930041049387;4851.927221091686;4936.086823937583;4948.109340318777;4954.380702412199;4976.800927962841;4664.440267167962;4666.066786642685;4746.59653929413;4747.810087596457;4758.809647614126;4824;4829.830955916596;4832;4843.636727245471;4907.7300748458465;4753.619710423158;4754.09672162295;4760.500147484534;4810.134175848311;4817;4750.8337208197545;4761.714297142183;4785.880352991203;4797.736124513185;4799.160146974265;3627.183883626163;3694.427363758568;3708.128589781399;3713.517242758424;3728.55257369112;3272.9672703272663;3394.7963122212745;3419.1623052352334;3436.055084851636;3478.2869511750537;4619.884502887455;4689.648276379286;4693.530646935279;4694.178518759203;4701.106789709944;4643.883902902387;4785.353977213102;4797.856064318076;4831.033793241366;4898.853034408973;4572.222722137245;4595.310703394518;4597.609203217697;4631.62946964242;4645.605123564467;4250.553691862372;4306.4616922884015;4335.284678028153;4342.978285108554;4350.369196466495;4796.2805579163405;4917.164082105979;5007.774650140679;5039.21892106724;5053.0651829410945;4757.405324334458;4860.95139048605;4879.4388645304825;4928.408590969107;4941.802327906988;5022.17134172872;5041.092603331435;5056.721880296619;5105.5149760772665;5145.819896303611;4609.239475486641;4750.904981900412;4813.278008298783;4833.081714474239;4967.503249675004;4839.274108883696;4850.805967761391;4871.975640121776;4906.460289368095;4917.409910810726;4628.861134165981;4750;4762.380890484214;4773.188557945227;4843.685160464559;4529.8641040768825;4664.836730714409;4747.406574178228;4778.426588809365;4837.443693975238;4552.9772351138035;4670.416197975253;4689.179393606173;4695.741734204652;4778.713277203379;4779.3070004848405;4826.903461930812;4827.734474603931;4840.782164802663;4847.200211964986;4510.729356238505;4623.237165867594;4646.024334889711;4772.236442169236;4788.425388953208 15:36:33 INFO - 2015-11-17 15:36:33,583 DEBUG : BROWSER_OUTPUT: |1;ext.html;472.86523340847856;477.6226780843134;480.7019647818351;490.39681192133685;502.1789374372899;26012.349691257703;26773.999999999975;26774.59838102425;26796.330091747717;26802.5979610306;27291.590626140623;33210;33866.322673546514;33953.83023084887;34286.48570271442;7509.924900750991;7556.093268807724;7562.205968373297;7608.467407281492;7636.847263054736;6977;7383.963080184619;7399;7515.286047825448;7540.622968851536;6913.827154321157;6959.373656370925;9180.816383672323;9251.814963700723;9320.394174378644;8699.782505437352;8937.687180948635;8950.597223124974;9141.085891410872;9156.725298241063;6799.558028728117;6898.344657257552;8913.643454261823;8989.955050224708;8995.910040899573;24716.13493527718;35002.87449696318;35094.29811403783;35573;35615;2477.826552141351;2652.907148249821;2847.7437030667134;3006.729394354497;3037.8025428347087;21964.670529942065;22492.43768905774;22663.773362266333;22753.886230568907;23651.763482365128;2010.5476267839765;2046.6316063108634;2077.210659949225;2082.666773316262;2190.3319487556287;194527;198682;199446;200629;201551;46152.538474615496;46291.76854115708;46382.30426543605;46631.766841165576;46732.76633616878;48487.51512484901;48812.51187488151;49110.75444622754;49181.75409122931;49468.257976130386;12590.685232869251;13855.653608659864;13962.162270263816;14038.087524310888;14067.2966351682;9525.761855953657;9599.47202903833;9620.37467564606;9679.177269931994;9702.175315098295;16333;16454.75317870233;16458.341666333214;16717.58206044834;16844.473329000746;7231.602261875647;7544.622768861535;7570.356519695777;7575.545467271982;7616.9238307617325;841.9873701894477;845.8646616541324;849.8300339932039;853.108501615813;923.2936803345447;22957.655635165487;23240.7675923242;23250;23280;23361.883190584278;893.2139717048956;920.5259291464901;929.2798081486902;966.9081437263449;999.8550210219623;12074.577389791315;12114.757704845853;12129.45417456199;12175.817362739388;12182.390880455941;259251;262195;262743;265344;265382;43793.78103109464;43943.78028109903;44012.559874401486;44056;44057;1182.6038277177242;1185.5672679471759;1189.9583514576948;1193.8806119387991;1202.6452196602024;22810.315690528645;23128.306150815504;23146.305610831703;23211;23489;37837.24325513529;38228;38281;38281.234375312895;38696.22607547777;229031.12906612828;229617;229641;232095;233200;26187.214383568524;26542.203733888015;26907.730922691306;26927.596086059115;27262.045828395912;29232.41535169327;29474.852625736734;29783.702162978094;30021.84989075128;35805.64194358127;25305.367365815266;27131;27712.168634940983;28027.859860700566;29050.27374315659;28347.85826070939;28621.14136575906;28664.57003144913;28902.710972890003;28940.85529572423;25507.23478295654;26077.478450431263;28789.712102878704;29523.261918452212;29869.103926882228;22875.428114297276;24250.51498970046;24607.507849842546;24765;25189.62215566731;19056.8094319055;19369.903150484723;19791;19904.402867913985;20248.696269555672 15:36:33 INFO - 2015-11-17 15:36:33,584 DEBUG : BROWSER_OUTPUT: |2;jquery.html;280.1357811152594;283.3680891611706;285.65883178477054;287.8057311314861;289.882597547993;10678.412687302196;14689.192094434815;15186.468473603427;15283.541493755178;16372;15482.535523934272;15857.207139643;16264.75602865958;16984.915075424604;17169.484915452525;4658.883527911796;4809.7835597398025;4826.251930950708;4827.51724827518;4874.122657921573;4726.952730472685;4762.666613337051;4770.809167633308;4774.665773395846;4826.517348265163;3399.490076488522;3524.859005639771;4729.834455794048;4757.619390448773;5116.104681680691;5193.143131383317;5286.814961476349;5290.074237008508;5293.285406470116;5341.786328546854;4250.766207858566;4308.31067029277;4325.52419233884;4619.792109355053;4636.629069674452;19723.30968416113;19779.80220197794;19866.20535178591;19905;20199.39401817948;1795.6139430022477;1803.7925638551603;1817.082373401437;1839.4297767691924;1839.7884243312058;11829.881701182963;12000.459979300953;12170.391480426031;12303.384830758427;12307.076969227253;1364.1951248763278;1429.9714005719932;1465.9780103298458;1485.4355344968951;1510.3279040826837;49322.7533862332;51800.74099629516;51969.22046169273;52081;52204.47795522034;5562.86092847674;5615.410381909923;5615.859603509945;5644.74598643062;5664.150377443334;5920.703964801829;6308.810735677937;6393.520485963571;6414.422701956846;6426.775062872777;4599.310103484438;4614.815407383734;4676.766161691902;4708.529147085333;4741.739204343725;4955.876103097451;4960.330355401975;4986.925196122061;5044.8234311798915;5058.089543882063;2487.1543675150538;2492.6011838105815;2512.258883629334;2556.590945448719;2562.7949764018836;861.6165806216173;865.913408659129;870.2124577257592;874.9868751968726;937.9155875971195;298.7662931302605;364.7082334132736;365.493791099324;365.87311081867784;371.4409813231124;9595;9981.700548983543;10134.189264858793;10221.437820919771;10222.233332500093;381.706086313537;385.64713287341766;390.6171951487558;401.03951037265585;406.24438544307566;4655.6944569355455;5441.211024401518;5463.699496527729;5489;5519.2824932758485;439431;441753;442501;448621;456963;43454;60928.390716093156;61246.38753612496;63154.68422657949;63258;409.62928549662604;412.3793690495785;414.04975581041583;420.3967306914526;422.51832910482074;9038.819223615359;9232.815343693223;9328.253739700944;9369.297302702462;9394.154526092685;29895.70104299016;30022.3995520084;30339.69660303457;30373.392532149675;31181.220469488446;41411.1717765637;41552.1689566213;42172.789136054125;42253;42656;5187.948120518747;5230.450802665665;5334.973325133349;5339.492748188916;5342;9833.557489912828;10060.396376217157;10103.444310562989;10221.33561318512;10299.588016479556;8158.265756081981;8526.74419767408;8740.388172827841;8769.605367758339;8773.166549177819;8044;8579.2707619853;8637.179467950535;8685.869711954452;8801.29589632815;8215.753527394188;8797.38418310712;9114.40756350835;9128.908710912805;9173.724788256362;5216.113260745758;5298.973505132604;5302;5333.439988801275;5402.459754024566;8560.743177704679;8882.111788821325;8899.599518021576;8911.50986695738;9016.954915225382 15:36:33 INFO - 2015-11-17 15:36:33,585 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1083.653230966091;1169.286735091594;1309.657600959017;1424.7649137892247;1508.4494159631734;5670.716464176795;5806.187133801272;5917.142014407908;5926.703664816758;5998.9700051499685;5953.553483488734;6136.877262454748;6181.969090154555;6192.473639740628;6196.845078873031;1870.1677753399708;1872.11074739499;1872.4663470910793;1882.6987681970888;1884.2557189910046;1899.1833511590012;1914.0812410043188;1932.5361913140816;1942.1842826013037;1965.0665933681457;1826.4703236061594;1841.7697787776528;1862.1713337564788;1866.4960460675609;1890.1210936914333;1842.3459671816513;1844.2346426233098;1850.6668799616064;1865.5149661088078;1869.1682201420374;1847.7967423583395;1847.9466703978737;1860.3674750584867;1870.0182404237885;1883.905804709759;6118.877622447526;6136.7545298188015;6139.693015349215;6146.846328841814;6153.4154255345675;3527.3298073365977;3676.191237927652;3689.0777305673582;3914.451976723261;4053.148838743867;2463.507298540281;2557.6163575463643;2600.5826824380756;2605.6091586262214;2622.6721659792524;768.5004746914494;772.2740623813597;773.1842905734447;832.1927730101792;834.9457285276499;7966.28303452692;8102.716404925799;8113.797155071112;8122;8138.186181381933;3557.4663800429626;3611.6749492545796;3613.2773445311045;3673.265346930571;3682.1531047859144;6903.447724182053;6925.515213935077;6929.722811087601;6941.375276225063;6944.305569443116;4073.307537718595;4081.469408976814;4082.081531655354;4083;4091;3732.9440058399146;3773.132179598708;3776.86780962665;3777.3956167013694;3779.3197224499304;2853.9714602853705;2855.271905664084;2858.980066280836;2884.956725649117;2895.724906133914;827.5407149032345;833.6165363932658;840.2185967050701;841.2596914715011;848.0459483081534;1106.950187241576;1132.1056365471186;1134.4554613785429;1153.6020073074776;1154.05944155513;5878.911816322759;5928.347881733006;5938.970305148533;5960.850978725566;5961.701914904237;419.09057345560205;419.72298283132983;423.42625742118986;426.1285670803215;426.7013090836427;4711.246200607886;4726.929096063562;4794.856154315376;4796.2805579162705;4796.304535842283;7273.709051637981;7487;7490.1386340571535;7492.475526713187;7546.20764819697;7456;7461.552306861606;7463.664135113933;7465.85068298631;7552.66013029415;5906.586538942319;5957.940420595739;5979.850503737354;6001.4298641628975;6001.7599296027665;5744.42555744439;5778.364379918122;5789.363170051375;5792.275965504312;5843.2695913010875;6475.352464753487;6598.868022639616;6632.568883022588;6664.400203981665;6719.496037797283;6754.966225168842;6833.58998460094;6850.520463567702;6872.553284036521;6977.825554361181;5231.476852314738;5294.126469132704;5315.069862774077;5320.44135365781;5347.679139251657;5805.071188609802;6033.577649564489;6081.422264884829;6087.2999605044215;6141.969290153521;5670.886582268414;5683.2895888014;5688.488036076773;5751.8562035949435;5797.275340582427;5390.083685773507;5498.780048798003;5590.888182236251;5617.297837770278;5670.943290567042;5629.043062679272;5667.263255776723;5695.629784064023;5737.799177028784;5753.482186603058;5165.586753059822;5189.429162792015;5211.921821172761;5263.315768950012;5270.446603106619;5112.258722485293;5118.104331742004;5129.640925135204;5135.435102138687;5324.361076670824 15:36:33 INFO - 2015-11-17 15:36:33,588 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.34886690073412;262.69658544381235;267.5718849840256;268.54883795224015;278.5390179253334;5161.251618515318;5226.2683224348575;5233.555147812436;5265.842024739254;5276.076686579852;5090.287359769635;5158.174692049273;5160.071187186305;5179.041877252711;5225.137852254374;3875.4380614810975;3902.6487616114546;3927.4501569780255;3946.6842652587725;3977.6817854571564;3996.1608062306805;4017.9799101004455;4021.4168945502884;4045.7167998240134;4074;4009.2582872168596;4018.9397159042637;4021.899452513696;4023.959760402388;4047.4738284023183;3803.7147213958924;3890.513685789276;3919.2161567686576;3949.328614135604;4038.2125485530332;3419.777714448553;3433.9828300858585;3435.158386195398;3473.4616134499192;3499.3701133795907;5110.361204849394;5118.283440318359;5120.052790233782;5170.767315470813;5174.896502069938;4456.732596044215;4530;4534.6372290216705;4547.636189104896;4551.340055691906;5304.602154838364;5483.835484935418;5493.23094766733;5495.945040549584;5524.66851988882;3768.7361884668085;3774.6602805747616;3775.6224377562025;3779.4897688811934;3782.1868298315994;5782.479576838063;5793.855153621109;5796.97101514494;5829.154772557998;5882.588218824684;3844.9807750961068;3854.5759966403675;3862.3240932836643;3867.0332416895776;3908.9804550977065;3628.9092772680365;3895.9805200973815;3900.1224724436775;3900.5124359455067;3919.0006548329993;4383.517813040563;4406.9559304407185;4408.008198155453;4409.2724700424715;4437.378766972626;5490;5493.587980901449;5499.725013749377;5512.779488820483;5527.751251193706;1312.7571399291162;1315.4277889118264;1316.1379296560767;1318.1168617026424;1319.0371029148776;860.8794768732382;865.260202526843;878.885744853165;891.5319457284847;896.3232759266712;5323.254744335796;5325.733713314319;5346.652467589594;5408.269883565747;5410.188471729193;5748.597598168171;5831.358550559435;5834.183214349994;5839.240898683144;5847.94152058474;5314.415414304423;5347.759350829222;5352.223927530486;5395.379531353866;5398.78404863801;2858.1425572328217;2992.670806211315;3109.9067027989195;3112.4242015227255;3114.7196752292402;5960.642361458326;5985.491233245223;6014.51883849291;6039.54703397247;6060.636361818305;5938.079597662369;5960.761569537257;6028;6036.034234522455;6055.333913269536;6030.306514750772;6077.270727512727;6095.085737139465;6099.71905899766;6120.816375508742;5573.191887176417;5746.7701291949525;5801;5840.065589505659;5878.676672783038;5674.546036317167;5692.373838877803;5700.771969121189;5707.086866101404;5735.885282294247;5948.345681974893;5953.791617293374;6026.638401695912;6037.849053773515;6048.969755151196;3677.6138505456543;3773.3019391412677;3786.3373909565166;3796.715246356479;3833.386658134685;5736.483716465538;5766.394528574607;5776.913346299725;5788.971055144866;5803.390643982321;5467.917981230205;5543.417941116125;5588.245586845724;5614.466625670555;5629.043062679272;5353.411124776349;5558;5588.720563971867;5591.720413979204;5600.775968961196;5404.405515393225;5407.540359069523;5411.567074633941;5452.672839629477;5471.37079235893;5555.583331250254;5556.972215138899;5560.916586251128;5624.128260119688;5642.943570564242;5223.2948551945;5397.055515284888;5398.163284690879;5435;5533.667979921218 15:36:33 INFO - 2015-11-17 15:36:33,590 DEBUG : BROWSER_OUTPUT: |5;yui.html;564.5963136357503;581.4766709961035;623.1867413025999;626.6772612104766;653.196568221088;11378.805225451333;11633.47649355779;11736.647900562975;11859.881401185985;11946.701332466682;11159.553617855296;11187.44062796861;11287.774244515105;11290.09679225662;11386.7153321167;600.2197143713178;601.9036954087347;609.7865746988541;740.1636151149194;747.0922828763051;747.8242612985944;755.7921571567808;758.1281526244835;771.9848399354859;783.6316931042401;778.9610519474032;788.1055002572093;789.2423273657267;789.4000559574707;796.7888509544975;621.6518749500294;627.2786295759889;628.114358754159;750.8273097187623;774.910885248198;574.7155158196678;575.4763165519357;575.4849409778267;575.5683237571822;576.0610205365227;11729.648110556696;11814.527418903233;11821.054315654726;11879.703007424798;11898.22661526998;9705.563249653713;9726.416415015121;10234.744131396701;10402.011808878144;10439.739006524898;7711.2288771123;7923.466069593434;8033.196680331978;8293.792655183668;8466.111058338909;2811.507986102444;2843.317603775079;2862.2128914548457;2906.1862678450066;2933.9559906601417;41416.58583414157;41493.792531037456;41530;41616.1676766466;41744.1651166975;7412.888806667905;7579.848403032019;7592.8481430372185;7788.532688038736;7846.686132554748;16072.919635401748;16122.919385403233;16205.513834584746;16255.51233462998;16305.266263018193;5794.710264486759;5932.436418540232;6102.542309326818;6139.907901381483;6160.537959653044;3151.8581663825184;3165.5568220448695;3178.0465860241834;3230.9030729078167;3280.0815771583993;2459.5449841779327;2495.2389521195846;2505.912293069734;2530.8228424010144;2532.303616505476;354.1942081763956;360.91338078860883;366.1961993424461;366.75244210158036;369.9130704284491;454.69989806727403;490.8699194713404;494.430184165281;513.7123211001851;539.3500831498036;6385.265694445198;6757.628330441873;6933.93066069343;6937.445004399636;7000.92999070013;404.5711545761502;431.48437617047955;481.0283227879664;486.5791090706513;502.6707506583194;3103.4103520331064;3168.904932852018;3199.4763411319896;3295.681727309048;3326.667333266654;49563;49628.50371496239;49927.25109123366;49931;50272;43013.35479967803;43575.34636980448;43682.34476482855;43859;43936.780316098215;39267.41098883519;39523.40714889336;39620;39761.20477590432;40257.39613905735;6377.1390862233;6451.774187903401;6463.741450342121;6499;6625.105610742681;27859.16422507328;28780.424391511635;28791.424171516872;29637;29966.25084372908;38521.807390962866;39626.2074758509;39715;40214.39678404885;40302;6403.4877209824035;6446.613203207635;6464.4828413725845;6672.232693240146;6724.596524208563;9057.411268267542;9075.773105672411;9081.909180908106;9117.817643646957;9280.211182049601;8384.916150838413;8458.873116903374;8501.489910605384;8502.107278735892;8575.185357391038;8455.915440845512;8480.236778689947;8525.91474085276;8569.228769410534;8614.870776938225;7711.826953158056;8341.45780524264;8474.788130296793;8501.19238672325;8784.341174411817;7589;7707.961460192663;7820.687172513036;7942.483738556975;8024.638891250024;7527.172011078667;7606.733764318223;7818.218178182136;7893.763187104396;7939.245771651684 15:36:33 INFO - 2015-11-17 15:36:33,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: __startTimestamp1447803393575__endTimestamp 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:36:33 INFO - 2015-11-17 15:36:33,591 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,592 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4532.27 Median:4670.42 stddev:485.84 (10.4%) stddev-sans-first:462.33 15:36:33 INFO - 2015-11-17 15:36:33,593 DEBUG : BROWSER_OUTPUT: Values: 2571.3 2675.6 2694.9 2717.9 2730.9 4435.3 4480.4 4516.8 4519.8 4608.6 4423.8 4466.0 4569.1 4609.2 4614.2 4131.6 4185.2 4192.5 4233.7 4254.7 4279.3 4290.6 4331.2 4344.7 4411.8 4082.1 4090.0 4233.2 4301.0 4331.4 4223.5 4228.6 4261.3 4286.3 4305.2 4183.5 4231.6 4255.9 4290.5 4303.3 4333.9 4516.7 4545.1 4592.4 4665.4 4729.1 4739.8 4749.2 4811.2 4821.6 4915.0 4922.1 4959.1 4965.4 4969.3 4403.9 4579.8 4614.0 4617.9 4663.9 4851.9 4936.1 4948.1 4954.4 4976.8 4664.4 4666.1 4746.6 4747.8 4758.8 4824.0 4829.8 4832.0 4843.6 4907.7 4753.6 4754.1 4760.5 4810.1 4817.0 4750.8 4761.7 4785.9 4797.7 4799.2 3627.2 3694.4 3708.1 3713.5 3728.6 3273.0 3394.8 3419.2 3436.1 3478.3 4619.9 4689.6 4693.5 4694.2 4701.1 4643.9 4785.4 4797.9 4831.0 4898.9 4572.2 4595.3 4597.6 4631.6 4645.6 4250.6 4306.5 4335.3 4343.0 4350.4 4796.3 4917.2 5007.8 5039.2 5053.1 4757.4 4861.0 4879.4 4928.4 4941.8 5022.2 5041.1 5056.7 5105.5 5145.8 4609.2 4750.9 4813.3 4833.1 4967.5 4839.3 4850.8 4872.0 4906.5 4917.4 4628.9 4750.0 4762.4 4773.2 4843.7 4529.9 4664.8 4747.4 4778.4 4837.4 4553.0 4670.4 4689.2 4695.7 4778.7 4779.3 4826.9 4827.7 4840.8 4847.2 4510.7 4623.2 4646.0 4772.2 4788.4 15:36:33 INFO - 2015-11-17 15:36:33,593 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,593 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36827.31 Median:28921.78 stddev:60660.15 (209.7%) stddev-sans-first:60768.90 15:36:33 INFO - 2015-11-17 15:36:33,595 DEBUG : BROWSER_OUTPUT: Values: 472.9 477.6 480.7 490.4 502.2 26012.3 26774.0 26774.6 26796.3 26802.6 27291.6 33210.0 33866.3 33953.8 34286.5 7509.9 7556.1 7562.2 7608.5 7636.8 6977.0 7384.0 7399.0 7515.3 7540.6 6913.8 6959.4 9180.8 9251.8 9320.4 8699.8 8937.7 8950.6 9141.1 9156.7 6799.6 6898.3 8913.6 8990.0 8995.9 24716.1 35002.9 35094.3 35573.0 35615.0 2477.8 2652.9 2847.7 3006.7 3037.8 21964.7 22492.4 22663.8 22753.9 23651.8 2010.5 2046.6 2077.2 2082.7 2190.3 194527.0 198682.0 199446.0 200629.0 201551.0 46152.5 46291.8 46382.3 46631.8 46732.8 48487.5 48812.5 49110.8 49181.8 49468.3 12590.7 13855.7 13962.2 14038.1 14067.3 9525.8 9599.5 9620.4 9679.2 9702.2 16333.0 16454.8 16458.3 16717.6 16844.5 7231.6 7544.6 7570.4 7575.5 7616.9 842.0 845.9 849.8 853.1 923.3 22957.7 23240.8 23250.0 23280.0 23361.9 893.2 920.5 929.3 966.9 999.9 12074.6 12114.8 12129.5 12175.8 12182.4 259251.0 262195.0 262743.0 265344.0 265382.0 43793.8 43943.8 44012.6 44056.0 44057.0 1182.6 1185.6 1190.0 1193.9 1202.6 22810.3 23128.3 23146.3 23211.0 23489.0 37837.2 38228.0 38281.0 38281.2 38696.2 229031.1 229617.0 229641.0 232095.0 233200.0 26187.2 26542.2 26907.7 26927.6 27262.0 29232.4 29474.9 29783.7 30021.8 35805.6 25305.4 27131.0 27712.2 28027.9 29050.3 28347.9 28621.1 28664.6 28902.7 28940.9 25507.2 26077.5 28789.7 29523.3 29869.1 22875.4 24250.5 24607.5 24765.0 25189.6 19056.8 19369.9 19791.0 19904.4 20248.7 15:36:33 INFO - 2015-11-17 15:36:33,595 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,595 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22900.37 Median:4717.74 stddev:72984.47 (1547.0%) stddev-sans-first:73169.44 15:36:33 INFO - 2015-11-17 15:36:33,595 DEBUG : BROWSER_OUTPUT: Values: 280.1 283.4 285.7 287.8 289.9 10678.4 14689.2 15186.5 15283.5 16372.0 15482.5 15857.2 16264.8 16984.9 17169.5 4658.9 4809.8 4826.3 4827.5 4874.1 4727.0 4762.7 4770.8 4774.7 4826.5 3399.5 3524.9 4729.8 4757.6 5116.1 5193.1 5286.8 5290.1 5293.3 5341.8 4250.8 4308.3 4325.5 4619.8 4636.6 19723.3 19779.8 19866.2 19905.0 20199.4 1795.6 1803.8 1817.1 1839.4 1839.8 11829.9 12000.5 12170.4 12303.4 12307.1 1364.2 1430.0 1466.0 1485.4 1510.3 49322.8 51800.7 51969.2 52081.0 52204.5 5562.9 5615.4 5615.9 5644.7 5664.2 5920.7 6308.8 6393.5 6414.4 6426.8 4599.3 4614.8 4676.8 4708.5 4741.7 4955.9 4960.3 4986.9 5044.8 5058.1 2487.2 2492.6 2512.3 2556.6 2562.8 861.6 865.9 870.2 875.0 937.9 298.8 364.7 365.5 365.9 371.4 9595.0 9981.7 10134.2 10221.4 10222.2 381.7 385.6 390.6 401.0 406.2 4655.7 5441.2 5463.7 5489.0 5519.3 439431.0 441753.0 442501.0 448621.0 456963.0 43454.0 60928.4 61246.4 63154.7 63258.0 409.6 412.4 414.0 420.4 422.5 9038.8 9232.8 9328.3 9369.3 9394.2 29895.7 30022.4 30339.7 30373.4 31181.2 41411.2 41552.2 42172.8 42253.0 42656.0 5187.9 5230.5 5335.0 5339.5 5342.0 9833.6 10060.4 10103.4 10221.3 10299.6 8158.3 8526.7 8740.4 8769.6 8773.2 8044.0 8579.3 8637.2 8685.9 8801.3 8215.8 8797.4 9114.4 9128.9 9173.7 5216.1 5299.0 5302.0 5333.4 5402.5 8560.7 8882.1 8899.6 8911.5 9017.0 15:36:33 INFO - 2015-11-17 15:36:33,595 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,597 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4368.67 Median:5444.43 stddev:2212.46 (40.6%) stddev-sans-first:2204.88 15:36:33 INFO - 2015-11-17 15:36:33,597 DEBUG : BROWSER_OUTPUT: Values: 1083.7 1169.3 1309.7 1424.8 1508.4 5670.7 5806.2 5917.1 5926.7 5999.0 5953.6 6136.9 6182.0 6192.5 6196.8 1870.2 1872.1 1872.5 1882.7 1884.3 1899.2 1914.1 1932.5 1942.2 1965.1 1826.5 1841.8 1862.2 1866.5 1890.1 1842.3 1844.2 1850.7 1865.5 1869.2 1847.8 1847.9 1860.4 1870.0 1883.9 6118.9 6136.8 6139.7 6146.8 6153.4 3527.3 3676.2 3689.1 3914.5 4053.1 2463.5 2557.6 2600.6 2605.6 2622.7 768.5 772.3 773.2 832.2 834.9 7966.3 8102.7 8113.8 8122.0 8138.2 3557.5 3611.7 3613.3 3673.3 3682.2 6903.4 6925.5 6929.7 6941.4 6944.3 4073.3 4081.5 4082.1 4083.0 4091.0 3732.9 3773.1 3776.9 3777.4 3779.3 2854.0 2855.3 2859.0 2885.0 2895.7 827.5 833.6 840.2 841.3 848.0 1107.0 1132.1 1134.5 1153.6 1154.1 5878.9 5928.3 5939.0 5960.9 5961.7 419.1 419.7 423.4 426.1 426.7 4711.2 4726.9 4794.9 4796.3 4796.3 7273.7 7487.0 7490.1 7492.5 7546.2 7456.0 7461.6 7463.7 7465.9 7552.7 5906.6 5957.9 5979.9 6001.4 6001.8 5744.4 5778.4 5789.4 5792.3 5843.3 6475.4 6598.9 6632.6 6664.4 6719.5 6755.0 6833.6 6850.5 6872.6 6977.8 5231.5 5294.1 5315.1 5320.4 5347.7 5805.1 6033.6 6081.4 6087.3 6142.0 5670.9 5683.3 5688.5 5751.9 5797.3 5390.1 5498.8 5590.9 5617.3 5670.9 5629.0 5667.3 5695.6 5737.8 5753.5 5165.6 5189.4 5211.9 5263.3 5270.4 5112.3 5118.1 5129.6 5135.4 5324.4 15:36:33 INFO - 2015-11-17 15:36:33,597 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,598 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4632.87 Median:5347.21 stddev:1439.82 (26.9%) stddev-sans-first:1405.85 15:36:33 INFO - 2015-11-17 15:36:33,598 DEBUG : BROWSER_OUTPUT: Values: 254.3 262.7 267.6 268.5 278.5 5161.3 5226.3 5233.6 5265.8 5276.1 5090.3 5158.2 5160.1 5179.0 5225.1 3875.4 3902.6 3927.5 3946.7 3977.7 3996.2 4018.0 4021.4 4045.7 4074.0 4009.3 4018.9 4021.9 4024.0 4047.5 3803.7 3890.5 3919.2 3949.3 4038.2 3419.8 3434.0 3435.2 3473.5 3499.4 5110.4 5118.3 5120.1 5170.8 5174.9 4456.7 4530.0 4534.6 4547.6 4551.3 5304.6 5483.8 5493.2 5495.9 5524.7 3768.7 3774.7 3775.6 3779.5 3782.2 5782.5 5793.9 5797.0 5829.2 5882.6 3845.0 3854.6 3862.3 3867.0 3909.0 3628.9 3896.0 3900.1 3900.5 3919.0 4383.5 4407.0 4408.0 4409.3 4437.4 5490.0 5493.6 5499.7 5512.8 5527.8 1312.8 1315.4 1316.1 1318.1 1319.0 860.9 865.3 878.9 891.5 896.3 5323.3 5325.7 5346.7 5408.3 5410.2 5748.6 5831.4 5834.2 5839.2 5847.9 5314.4 5347.8 5352.2 5395.4 5398.8 2858.1 2992.7 3109.9 3112.4 3114.7 5960.6 5985.5 6014.5 6039.5 6060.6 5938.1 5960.8 6028.0 6036.0 6055.3 6030.3 6077.3 6095.1 6099.7 6120.8 5573.2 5746.8 5801.0 5840.1 5878.7 5674.5 5692.4 5700.8 5707.1 5735.9 5948.3 5953.8 6026.6 6037.8 6049.0 3677.6 3773.3 3786.3 3796.7 3833.4 5736.5 5766.4 5776.9 5789.0 5803.4 5467.9 5543.4 5588.2 5614.5 5629.0 5353.4 5558.0 5588.7 5591.7 5600.8 5404.4 5407.5 5411.6 5452.7 5471.4 5555.6 5557.0 5560.9 5624.1 5642.9 5223.3 5397.1 5398.2 5435.0 5533.7 15:36:33 INFO - 2015-11-17 15:36:33,599 DEBUG : BROWSER_OUTPUT: 15:36:33 INFO - 2015-11-17 15:36:33,599 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11482.16 Median:575.48 stddev:13861.87 (2408.7%) stddev-sans-first:13876.51 15:36:33 INFO - 2015-11-17 15:36:33,600 DEBUG : BROWSER_OUTPUT: Values: 564.6 581.5 623.2 626.7 653.2 11378.8 11633.5 11736.6 11859.9 11946.7 11159.6 11187.4 11287.8 11290.1 11386.7 600.2 601.9 609.8 740.2 747.1 747.8 755.8 758.1 772.0 783.6 779.0 788.1 789.2 789.4 796.8 621.7 627.3 628.1 750.8 774.9 574.7 575.5 575.5 575.6 576.1 11729.6 11814.5 11821.1 11879.7 11898.2 9705.6 9726.4 10234.7 10402.0 10439.7 7711.2 7923.5 8033.2 8293.8 8466.1 2811.5 2843.3 2862.2 2906.2 2934.0 41416.6 41493.8 41530.0 41616.2 41744.2 7412.9 7579.8 7592.8 7788.5 7846.7 16072.9 16122.9 16205.5 16255.5 16305.3 5794.7 5932.4 6102.5 6139.9 6160.5 3151.9 3165.6 3178.0 3230.9 3280.1 2459.5 2495.2 2505.9 2530.8 2532.3 354.2 360.9 366.2 366.8 369.9 454.7 490.9 494.4 513.7 539.4 6385.3 6757.6 6933.9 6937.4 7000.9 404.6 431.5 481.0 486.6 502.7 3103.4 3168.9 3199.5 3295.7 3326.7 49563.0 49628.5 49927.3 49931.0 50272.0 43013.4 43575.3 43682.3 43859.0 43936.8 39267.4 39523.4 39620.0 39761.2 40257.4 6377.1 6451.8 6463.7 6499.0 6625.1 27859.2 28780.4 28791.4 29637.0 29966.3 38521.8 39626.2 39715.0 40214.4 40302.0 6403.5 6446.6 6464.5 6672.2 6724.6 9057.4 9075.8 9081.9 9117.8 9280.2 8384.9 8458.9 8501.5 8502.1 8575.2 8455.9 8480.2 8525.9 8569.2 8614.9 7711.8 8341.5 8474.8 8501.2 8784.3 7589.0 7708.0 7820.7 7942.5 8024.6 7527.2 7606.7 7818.2 7893.8 7939.2 15:36:33 INFO - 2015-11-17 15:36:33,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:36:33 INFO - 2015-11-17 15:36:33,600 DEBUG : BROWSER_OUTPUT: 15:36:34 INFO - 2015-11-17 15:36:34,298 INFO : Browser exited with error code: 0 15:36:34 INFO - 2015-11-17 15:36:34,330 INFO : Completed test dromaeo_css (00:18:35) 15:36:34 INFO - 2015-11-17 15:36:34,331 INFO : Starting test kraken 15:36:34 INFO - 2015-11-17 15:36:34,331 DEBUG : operating with platform_type : mac_ 15:36:34 INFO - 2015-11-17 15:36:34,331 INFO : Initialising browser for kraken test... 15:36:34 INFO - 2015-11-17 15:36:34,346 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpUtKn_c/profile http://localhost:57345/getInfo.html 15:36:36 INFO - 2015-11-17 15:36:36,818 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:36:36 INFO - 2015-11-17 15:36:36,819 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:36:36 INFO - 2015-11-17 15:36:36,819 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:36:36 INFO - 2015-11-17 15:36:36,819 DEBUG : BROWSER_OUTPUT: __metrics 15:36:36 INFO - 2015-11-17 15:36:36,839 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:37 INFO - 2015-11-17 15:36:37,632 INFO : Browser initialized. 15:36:37 INFO - 2015-11-17 15:36:37,632 INFO : Running cycle 1/1 for kraken test... 15:36:37 INFO - 2015-11-17 15:36:37,632 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpUtKn_c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:36:49 INFO - 2015-11-17 15:36:49,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 229363712 15:36:49 INFO - 2015-11-17 15:36:49,733 DEBUG : BROWSER_OUTPUT: 15:36:52 INFO - 2015-11-17 15:36:52,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57345/tests/kraken/driver.html?testName=audio-beat-detection) 15:36:53 INFO - 2015-11-17 15:36:53,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 285081600 15:36:53 INFO - 2015-11-17 15:36:53,126 DEBUG : BROWSER_OUTPUT: 15:36:56 INFO - 2015-11-17 15:36:56,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57345/tests/kraken/driver.html?testName=audio-dft) 15:36:56 INFO - 2015-11-17 15:36:56,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 297381888 15:36:56 INFO - 2015-11-17 15:36:56,721 DEBUG : BROWSER_OUTPUT: 15:37:00 INFO - 2015-11-17 15:37:00,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57345/tests/kraken/driver.html?testName=audio-fft) 15:37:00 INFO - 2015-11-17 15:37:00,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 283353088 15:37:00 INFO - 2015-11-17 15:37:00,616 DEBUG : BROWSER_OUTPUT: 15:37:02 INFO - 2015-11-17 15:37:02,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57345/tests/kraken/driver.html?testName=audio-oscillator) 15:37:03 INFO - 2015-11-17 15:37:03,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 285380608 15:37:03 INFO - 2015-11-17 15:37:03,444 DEBUG : BROWSER_OUTPUT: 15:37:05 INFO - 2015-11-17 15:37:05,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:06 INFO - 2015-11-17 15:37:06,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 286461952 15:37:06 INFO - 2015-11-17 15:37:06,469 DEBUG : BROWSER_OUTPUT: 15:37:09 INFO - 2015-11-17 15:37:09,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57345/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:10 INFO - 2015-11-17 15:37:10,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 281042944 15:37:10 INFO - 2015-11-17 15:37:10,548 DEBUG : BROWSER_OUTPUT: 15:37:14 INFO - 2015-11-17 15:37:14,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57345/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:14 INFO - 2015-11-17 15:37:14,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 281706496 15:37:14 INFO - 2015-11-17 15:37:14,711 DEBUG : BROWSER_OUTPUT: 15:37:17 INFO - 2015-11-17 15:37:17,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57345/tests/kraken/driver.html?testName=json-parse-financial) 15:37:18 INFO - 2015-11-17 15:37:18,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 283226112 15:37:18 INFO - 2015-11-17 15:37:18,533 DEBUG : BROWSER_OUTPUT: 15:37:20 INFO - 2015-11-17 15:37:20,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:20 INFO - 2015-11-17 15:37:20,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 318513152 15:37:20 INFO - 2015-11-17 15:37:20,841 DEBUG : BROWSER_OUTPUT: 15:37:22 INFO - 2015-11-17 15:37:22,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:23 INFO - 2015-11-17 15:37:23,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 317911040 15:37:23 INFO - 2015-11-17 15:37:23,530 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-17 15:37:25,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:26 INFO - 2015-11-17 15:37:26,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 326316032 15:37:26 INFO - 2015-11-17 15:37:26,446 DEBUG : BROWSER_OUTPUT: 15:37:29 INFO - 2015-11-17 15:37:29,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:29 INFO - 2015-11-17 15:37:29,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 326819840 15:37:29 INFO - 2015-11-17 15:37:29,967 DEBUG : BROWSER_OUTPUT: 15:37:32 INFO - 2015-11-17 15:37:32,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:33 INFO - 2015-11-17 15:37:33,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 326049792 15:37:33 INFO - 2015-11-17 15:37:33,511 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57345/tests/kraken/driver.html?testName=ai-astar) 15:37:35 INFO - 2015-11-17 15:37:35,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 386166784 15:37:35 INFO - 2015-11-17 15:37:35,729 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,729 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:37:35 INFO - 2015-11-17 15:37:35,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;127;125;123;132;129;126;124;124;133 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;182;158;183;194;152;176;180;153;190;149 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;190;187;189;189;187;187;190;190;189 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;95;104;104;84;85;86;98;99;79 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;114;160;103;104;109;156;108;104;153 15:37:35 INFO - 2015-11-17 15:37:35,730 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;141;141;135;147;144;135;141;135;142 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;148;155;151;148;148;148;148;147;147 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;109;123;114;109;119;114;114;112;119;130 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;67;71;70;70;70;75;84;72;72 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;77;80;82;82;83;87;87;85;82 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;101;104;105;104;101;101;103;103;102 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;155;152;149;162;143;158;154;158;143 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;172;171;179;186;188;172;183;179;182;167 15:37:35 INFO - 2015-11-17 15:37:35,731 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;84;85;83;86;82;84;89;90;88 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: __startTimestamp1447803455723__endTimestamp 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:37:35 INFO - 2015-11-17 15:37:35,732 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.50 Median:126.50 stddev:5.84 (4.6%) stddev-sans-first:3.61 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: Values: 112.0 127.0 125.0 123.0 132.0 129.0 126.0 124.0 124.0 133.0 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.70 Median:181.00 stddev:16.98 (9.4%) stddev-sans-first:17.59 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: Values: 182.0 158.0 183.0 194.0 152.0 176.0 180.0 153.0 190.0 149.0 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:188.50 Median:189.00 stddev:1.35 (0.7%) stddev-sans-first:1.32 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: Values: 187.0 190.0 187.0 189.0 189.0 187.0 187.0 190.0 190.0 189.0 15:37:35 INFO - 2015-11-17 15:37:35,733 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.50 Median:85.50 stddev:9.54 (11.2%) stddev-sans-first:9.33 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: Values: 81.0 95.0 104.0 104.0 84.0 85.0 86.0 98.0 99.0 79.0 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:122.10 Median:112.00 stddev:23.90 (21.3%) stddev-sans-first:24.95 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 160.0 103.0 104.0 109.0 156.0 108.0 104.0 153.0 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:140.30 Median:141.50 stddev:4.08 (2.9%) stddev-sans-first:4.28 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 141.0 135.0 147.0 144.0 135.0 141.0 135.0 142.0 15:37:35 INFO - 2015-11-17 15:37:35,734 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.50 Median:148.00 stddev:3.10 (2.1%) stddev-sans-first:2.57 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: Values: 155.0 148.0 155.0 151.0 148.0 148.0 148.0 148.0 147.0 147.0 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.30 Median:116.50 stddev:6.57 (5.6%) stddev-sans-first:6.41 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: Values: 109.0 123.0 114.0 109.0 119.0 114.0 114.0 112.0 119.0 130.0 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.50 stddev:5.01 (7.0%) stddev-sans-first:4.87 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 71.0 70.0 70.0 70.0 75.0 84.0 72.0 72.0 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,735 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:82.50 stddev:3.17 (3.8%) stddev-sans-first:3.23 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: Values: 80.0 77.0 80.0 82.0 82.0 83.0 87.0 87.0 85.0 82.0 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:102.20 Median:103.50 stddev:2.04 (2.0%) stddev-sans-first:1.50 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: Values: 98.0 101.0 104.0 105.0 104.0 101.0 101.0 103.0 103.0 102.0 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:154.50 stddev:6.83 (4.4%) stddev-sans-first:6.63 15:37:35 INFO - 2015-11-17 15:37:35,736 DEBUG : BROWSER_OUTPUT: Values: 144.0 155.0 152.0 149.0 162.0 143.0 158.0 154.0 158.0 143.0 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:180.50 stddev:7.06 (3.9%) stddev-sans-first:7.16 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: Values: 172.0 171.0 179.0 186.0 188.0 172.0 183.0 179.0 182.0 167.0 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.10 Median:85.50 stddev:3.18 (3.7%) stddev-sans-first:2.78 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 85.0 83.0 86.0 82.0 84.0 89.0 90.0 88.0 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:37:35 INFO - 2015-11-17 15:37:35,737 DEBUG : BROWSER_OUTPUT: 15:37:36 INFO - 2015-11-17 15:37:36,498 INFO : Browser exited with error code: 0 15:37:36 INFO - 2015-11-17 15:37:36,555 INFO : Completed test kraken (00:01:02) 15:37:36 INFO - 2015-11-17 15:37:36,555 INFO : Starting test v8_7 15:37:36 INFO - 2015-11-17 15:37:36,555 DEBUG : operating with platform_type : mac_ 15:37:36 INFO - 2015-11-17 15:37:36,555 INFO : Initialising browser for v8_7 test... 15:37:36 INFO - 2015-11-17 15:37:36,570 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpXN6Nuh/profile http://localhost:57345/getInfo.html 15:37:39 INFO - 2015-11-17 15:37:39,000 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:37:39 INFO - 2015-11-17 15:37:39,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:37:39 INFO - 2015-11-17 15:37:39,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:37:39 INFO - 2015-11-17 15:37:39,001 DEBUG : BROWSER_OUTPUT: __metrics 15:37:39 INFO - 2015-11-17 15:37:39,021 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:39 INFO - 2015-11-17 15:37:39,827 INFO : Browser initialized. 15:37:39 INFO - 2015-11-17 15:37:39,827 INFO : Running cycle 1/1 for v8_7 test... 15:37:39 INFO - 2015-11-17 15:37:39,828 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/T/tmpXN6Nuh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:37:51 INFO - 2015-11-17 15:37:51,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 230060032 15:37:51 INFO - 2015-11-17 15:37:51,965 DEBUG : BROWSER_OUTPUT: 15:38:14 INFO - 2015-11-17 15:38:14,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57345/tests/v8_7/run.html (next: http://localhost:57345/tests/v8_7/run.html) 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 707993600 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:38:15 INFO - 2015-11-17 15:38:15,213 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |0;Richards;195.54165037152913 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;234.52157598499062 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |2;Encrypt;369.139904023625 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6724.832214765101 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2269.84126984127 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |5;Earley;914.9130832570905 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |6;Boyer;15875 15:38:15 INFO - 2015-11-17 15:38:15,214 DEBUG : BROWSER_OUTPUT: |7;RegExp;34440.67796610169 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: |8;Splay;825.8011503697617 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6706.666666666667 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: __startTimestamp1447803495210__endTimestamp 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,215 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:195.54 Median:195.54 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: Values: 195.5 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:234.52 Median:234.52 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: Values: 234.5 15:38:15 INFO - 2015-11-17 15:38:15,216 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:369.14 Median:369.14 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: Values: 369.1 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: Values: 6724.8 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,217 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2269.84 Median:2269.84 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: Values: 2269.8 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:914.91 Median:914.91 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: Values: 914.9 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15875.00 Median:15875.00 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: Values: 15875.0 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34440.68 Median:34440.68 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: Values: 34440.7 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:825.80 Median:825.80 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,218 DEBUG : BROWSER_OUTPUT: Values: 825.8 15:38:15 INFO - 2015-11-17 15:38:15,219 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,219 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6706.67 Median:6706.67 stddev:0.00 (0.0%) 15:38:15 INFO - 2015-11-17 15:38:15,219 DEBUG : BROWSER_OUTPUT: Values: 6706.7 15:38:15 INFO - 2015-11-17 15:38:15,219 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:38:15 INFO - 2015-11-17 15:38:15,219 DEBUG : BROWSER_OUTPUT: 15:38:15 INFO - 2015-11-17 15:38:15,979 INFO : Browser exited with error code: 0 15:38:16 INFO - 2015-11-17 15:38:16,002 INFO : Completed test v8_7 (00:00:39) 15:38:16 INFO - 2015-11-17 15:38:16,306 INFO : Completed test suite (00:20:17) 15:38:16 INFO - 2015-11-17 15:38:16,306 DEBUG : Working with test: dromaeo_css 15:38:16 INFO - 2015-11-17 15:38:16,307 DEBUG : Generating results file: dromaeo_css 15:38:16 INFO - 2015-11-17 15:38:16,307 DEBUG : Working with test: kraken 15:38:16 INFO - 2015-11-17 15:38:16,307 DEBUG : Generating results file: kraken 15:38:16 INFO - 2015-11-17 15:38:16,308 INFO : javascript benchmark 15:38:16 INFO - 2015-11-17 15:38:16,308 DEBUG : Working with test: v8_7 15:38:16 INFO - 2015-11-17 15:38:16,308 DEBUG : Generating results file: v8_7 15:38:16 INFO - 2015-11-17 15:38:16,308 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:38:16 INFO - 2015-11-17 15:38:16,358 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 15:38:16 INFO - 2015-11-17 15:38:16,358 DEBUG : process_Request line: dromaeo_css 5597.36 graph.html#tests=[[72,1,55]] 15:38:16 INFO - 2015-11-17 15:38:16,359 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:38:16 INFO - 2015-11-17 15:38:16,391 DEBUG : process_Request line: kraken 1776.60 graph.html#tests=[[232,1,55]] 15:38:16 INFO - 2015-11-17 15:38:16,391 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:38:16 INFO - 2015-11-17 15:38:16,438 DEBUG : process_Request line: v8_7 15648.69 graph.html#tests=[[230,1,55]] 15:38:16 INFO - 2015-11-17 15:38:16,439 INFO : javascript benchmark 15:38:16 INFO - 2015-11-17 15:38:16,441 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [280.1357811152594, 283.3680891611706, 285.65883178477054, 287.8057311314861, 289.882597547993, 10678.412687302196, 14689.192094434815, 15186.468473603427, 15283.541493755178, 16372.0, 15482.535523934272, 15857.207139643, 16264.75602865958, 16984.915075424604, 17169.484915452525, 4658.883527911796, 4809.7835597398025, 4826.251930950708, 4827.51724827518, 4874.122657921573, 4726.952730472685, 4762.666613337051, 4770.809167633308, 4774.665773395846, 4826.517348265163, 3399.490076488522, 3524.859005639771, 4729.834455794048, 4757.619390448773, 5116.104681680691, 5193.143131383317, 5286.814961476349, 5290.074237008508, 5293.285406470116, 5341.786328546854, 4250.766207858566, 4308.31067029277, 4325.52419233884, 4619.792109355053, 4636.629069674452, 19723.30968416113, 19779.80220197794, 19866.20535178591, 19905.0, 20199.39401817948, 1795.6139430022477, 1803.7925638551603, 1817.082373401437, 1839.4297767691924, 1839.7884243312058, 11829.881701182963, 12000.459979300953, 12170.391480426031, 12303.384830758427, 12307.076969227253, 1364.1951248763278, 1429.9714005719932, 1465.9780103298458, 1485.4355344968951, 1510.3279040826837, 49322.7533862332, 51800.74099629516, 51969.22046169273, 52081.0, 52204.47795522034, 5562.86092847674, 5615.410381909923, 5615.859603509945, 5644.74598643062, 5664.150377443334, 5920.703964801829, 6308.810735677937, 6393.520485963571, 6414.422701956846, 6426.775062872777, 4599.310103484438, 4614.815407383734, 4676.766161691902, 4708.529147085333, 4741.739204343725, 4955.876103097451, 4960.330355401975, 4986.925196122061, 5044.8234311798915, 5058.089543882063, 2487.1543675150538, 2492.6011838105815, 2512.258883629334, 2556.590945448719, 2562.7949764018836, 861.6165806216173, 865.913408659129, 870.2124577257592, 874.9868751968726, 937.9155875971195, 298.7662931302605, 364.7082334132736, 365.493791099324, 365.87311081867784, 371.4409813231124, 9595.0, 9981.700548983543, 10134.189264858793, 10221.437820919771, 10222.233332500093, 381.706086313537, 385.64713287341766, 390.6171951487558, 401.03951037265585, 406.24438544307566, 4655.6944569355455, 5441.211024401518, 5463.699496527729, 5489.0, 5519.2824932758485, 439431.0, 441753.0, 442501.0, 448621.0, 456963.0, 43454.0, 60928.390716093156, 61246.38753612496, 63154.68422657949, 63258.0, 409.62928549662604, 412.3793690495785, 414.04975581041583, 420.3967306914526, 422.51832910482074, 9038.819223615359, 9232.815343693223, 9328.253739700944, 9369.297302702462, 9394.154526092685, 29895.70104299016, 30022.3995520084, 30339.69660303457, 30373.392532149675, 31181.220469488446, 41411.1717765637, 41552.1689566213, 42172.789136054125, 42253.0, 42656.0, 5187.948120518747, 5230.450802665665, 5334.973325133349, 5339.492748188916, 5342.0, 9833.557489912828, 10060.396376217157, 10103.444310562989, 10221.33561318512, 10299.588016479556, 8158.265756081981, 8526.74419767408, 8740.388172827841, 8769.605367758339, 8773.166549177819, 8044.0, 8579.2707619853, 8637.179467950535, 8685.869711954452, 8801.29589632815, 8215.753527394188, 8797.38418310712, 9114.40756350835, 9128.908710912805, 9173.724788256362, 5216.113260745758, 5298.973505132604, 5302.0, 5333.439988801275, 5402.459754024566, 8560.743177704679, 8882.111788821325, 8899.599518021576, 8911.50986695738, 9016.954915225382], "dojo.html": [2571.2671888511773, 2675.5852842809372, 2694.9056783012597, 2717.918462446126, 2730.9453810923783, 4435.31252655838, 4480.395146655201, 4516.751578663172, 4519.751413672247, 4608.562186592277, 4423.845165419219, 4465.977670111653, 4569.109023740372, 4609.216433206355, 4614.192516309649, 4131.6281534661875, 4185.225733239346, 4192.49690037196, 4233.745975241495, 4254.744715317075, 4279.336702811053, 4290.584107244602, 4331.155424692186, 4344.717593356421, 4411.779411029452, 4082.142750022499, 4089.9795501022604, 4233.153369326116, 4300.956990430102, 4331.393604895317, 4223.535411104776, 4228.556001619816, 4261.31818908973, 4286.335617979218, 4305.246581848164, 4183.477065366829, 4231.640310573605, 4255.87232383029, 4290.528041915387, 4303.289957157065, 4333.913321733579, 4516.728996260234, 4545.11370282795, 4592.425946756655, 4665.440147182326, 4729.101470720587, 4739.786709598076, 4749.1926372516755, 4811.182099043171, 4821.614270858323, 4915.0, 4922.089413458521, 4959.057779021974, 4965.354503914468, 4969.304297398367, 4403.911921761547, 4579.771011449414, 4614.031053478773, 4617.861464156081, 4663.930041049387, 4851.927221091686, 4936.086823937583, 4948.109340318777, 4954.380702412199, 4976.800927962841, 4664.440267167962, 4666.066786642685, 4746.59653929413, 4747.810087596457, 4758.809647614126, 4824.0, 4829.830955916596, 4832.0, 4843.636727245471, 4907.7300748458465, 4753.619710423158, 4754.09672162295, 4760.500147484534, 4810.134175848311, 4817.0, 4750.8337208197545, 4761.714297142183, 4785.880352991203, 4797.736124513185, 4799.160146974265, 3627.183883626163, 3694.427363758568, 3708.128589781399, 3713.517242758424, 3728.55257369112, 3272.9672703272663, 3394.7963122212745, 3419.1623052352334, 3436.055084851636, 3478.2869511750537, 4619.884502887455, 4689.648276379286, 4693.530646935279, 4694.178518759203, 4701.106789709944, 4643.883902902387, 4785.353977213102, 4797.856064318076, 4831.033793241366, 4898.853034408973, 4572.222722137245, 4595.310703394518, 4597.609203217697, 4631.62946964242, 4645.605123564467, 4250.553691862372, 4306.4616922884015, 4335.284678028153, 4342.978285108554, 4350.369196466495, 4796.2805579163405, 4917.164082105979, 5007.774650140679, 5039.21892106724, 5053.0651829410945, 4757.405324334458, 4860.95139048605, 4879.4388645304825, 4928.408590969107, 4941.802327906988, 5022.17134172872, 5041.092603331435, 5056.721880296619, 5105.5149760772665, 5145.819896303611, 4609.239475486641, 4750.904981900412, 4813.278008298783, 4833.081714474239, 4967.503249675004, 4839.274108883696, 4850.805967761391, 4871.975640121776, 4906.460289368095, 4917.409910810726, 4628.861134165981, 4750.0, 4762.380890484214, 4773.188557945227, 4843.685160464559, 4529.8641040768825, 4664.836730714409, 4747.406574178228, 4778.426588809365, 4837.443693975238, 4552.9772351138035, 4670.416197975253, 4689.179393606173, 4695.741734204652, 4778.713277203379, 4779.3070004848405, 4826.903461930812, 4827.734474603931, 4840.782164802663, 4847.200211964986, 4510.729356238505, 4623.237165867594, 4646.024334889711, 4772.236442169236, 4788.425388953208], "mootools.html": [1083.653230966091, 1169.286735091594, 1309.657600959017, 1424.7649137892247, 1508.4494159631734, 5670.716464176795, 5806.187133801272, 5917.142014407908, 5926.703664816758, 5998.9700051499685, 5953.553483488734, 6136.877262454748, 6181.969090154555, 6192.473639740628, 6196.845078873031, 1870.1677753399708, 1872.11074739499, 1872.4663470910793, 1882.6987681970888, 1884.2557189910046, 1899.1833511590012, 1914.0812410043188, 1932.5361913140816, 1942.1842826013037, 1965.0665933681457, 1826.4703236061594, 1841.7697787776528, 1862.1713337564788, 1866.4960460675609, 1890.1210936914333, 1842.3459671816513, 1844.2346426233098, 1850.6668799616064, 1865.5149661088078, 1869.1682201420374, 1847.7967423583395, 1847.9466703978737, 1860.3674750584867, 1870.0182404237885, 1883.905804709759, 6118.877622447526, 6136.7545298188015, 6139.693015349215, 6146.846328841814, 6153.4154255345675, 3527.3298073365977, 3676.191237927652, 3689.0777305673582, 3914.451976723261, 4053.148838743867, 2463.507298540281, 2557.6163575463643, 2600.5826824380756, 2605.6091586262214, 2622.6721659792524, 768.5004746914494, 772.2740623813597, 773.1842905734447, 832.1927730101792, 834.9457285276499, 7966.28303452692, 8102.716404925799, 8113.797155071112, 8122.0, 8138.186181381933, 3557.4663800429626, 3611.6749492545796, 3613.2773445311045, 3673.265346930571, 3682.1531047859144, 6903.447724182053, 6925.515213935077, 6929.722811087601, 6941.375276225063, 6944.305569443116, 4073.307537718595, 4081.469408976814, 4082.081531655354, 4083.0, 4091.0, 3732.9440058399146, 3773.132179598708, 3776.86780962665, 3777.3956167013694, 3779.3197224499304, 2853.9714602853705, 2855.271905664084, 2858.980066280836, 2884.956725649117, 2895.724906133914, 827.5407149032345, 833.6165363932658, 840.2185967050701, 841.2596914715011, 848.0459483081534, 1106.950187241576, 1132.1056365471186, 1134.4554613785429, 1153.6020073074776, 1154.05944155513, 5878.911816322759, 5928.347881733006, 5938.970305148533, 5960.850978725566, 5961.701914904237, 419.09057345560205, 419.72298283132983, 423.42625742118986, 426.1285670803215, 426.7013090836427, 4711.246200607886, 4726.929096063562, 4794.856154315376, 4796.2805579162705, 4796.304535842283, 7273.709051637981, 7487.0, 7490.1386340571535, 7492.475526713187, 7546.20764819697, 7456.0, 7461.552306861606, 7463.664135113933, 7465.85068298631, 7552.66013029415, 5906.586538942319, 5957.940420595739, 5979.850503737354, 6001.4298641628975, 6001.7599296027665, 5744.42555744439, 5778.364379918122, 5789.363170051375, 5792.275965504312, 5843.2695913010875, 6475.352464753487, 6598.868022639616, 6632.568883022588, 6664.400203981665, 6719.496037797283, 6754.966225168842, 6833.58998460094, 6850.520463567702, 6872.553284036521, 6977.825554361181, 5231.476852314738, 5294.126469132704, 5315.069862774077, 5320.44135365781, 5347.679139251657, 5805.071188609802, 6033.577649564489, 6081.422264884829, 6087.2999605044215, 6141.969290153521, 5670.886582268414, 5683.2895888014, 5688.488036076773, 5751.8562035949435, 5797.275340582427, 5390.083685773507, 5498.780048798003, 5590.888182236251, 5617.297837770278, 5670.943290567042, 5629.043062679272, 5667.263255776723, 5695.629784064023, 5737.799177028784, 5753.482186603058, 5165.586753059822, 5189.429162792015, 5211.921821172761, 5263.315768950012, 5270.446603106619, 5112.258722485293, 5118.104331742004, 5129.640925135204, 5135.435102138687, 5324.361076670824], "ext.html": [472.86523340847856, 477.6226780843134, 480.7019647818351, 490.39681192133685, 502.1789374372899, 26012.349691257703, 26773.999999999975, 26774.59838102425, 26796.330091747717, 26802.5979610306, 27291.590626140623, 33210.0, 33866.322673546514, 33953.83023084887, 34286.48570271442, 7509.924900750991, 7556.093268807724, 7562.205968373297, 7608.467407281492, 7636.847263054736, 6977.0, 7383.963080184619, 7399.0, 7515.286047825448, 7540.622968851536, 6913.827154321157, 6959.373656370925, 9180.816383672323, 9251.814963700723, 9320.394174378644, 8699.782505437352, 8937.687180948635, 8950.597223124974, 9141.085891410872, 9156.725298241063, 6799.558028728117, 6898.344657257552, 8913.643454261823, 8989.955050224708, 8995.910040899573, 24716.13493527718, 35002.87449696318, 35094.29811403783, 35573.0, 35615.0, 2477.826552141351, 2652.907148249821, 2847.7437030667134, 3006.729394354497, 3037.8025428347087, 21964.670529942065, 22492.43768905774, 22663.773362266333, 22753.886230568907, 23651.763482365128, 2010.5476267839765, 2046.6316063108634, 2077.210659949225, 2082.666773316262, 2190.3319487556287, 194527.0, 198682.0, 199446.0, 200629.0, 201551.0, 46152.538474615496, 46291.76854115708, 46382.30426543605, 46631.766841165576, 46732.76633616878, 48487.51512484901, 48812.51187488151, 49110.75444622754, 49181.75409122931, 49468.257976130386, 12590.685232869251, 13855.653608659864, 13962.162270263816, 14038.087524310888, 14067.2966351682, 9525.761855953657, 9599.47202903833, 9620.37467564606, 9679.177269931994, 9702.175315098295, 16333.0, 16454.75317870233, 16458.341666333214, 16717.58206044834, 16844.473329000746, 7231.602261875647, 7544.622768861535, 7570.356519695777, 7575.545467271982, 7616.9238307617325, 841.9873701894477, 845.8646616541324, 849.8300339932039, 853.108501615813, 923.2936803345447, 22957.655635165487, 23240.7675923242, 23250.0, 23280.0, 23361.883190584278, 893.2139717048956, 920.5259291464901, 929.2798081486902, 966.9081437263449, 999.8550210219623, 12074.577389791315, 12114.757704845853, 12129.45417456199, 12175.817362739388, 12182.390880455941, 259251.0, 262195.0, 262743.0, 265344.0, 265382.0, 43793.78103109464, 43943.78028109903, 44012.559874401486, 44056.0, 44057.0, 1182.6038277177242, 1185.5672679471759, 1189.9583514576948, 1193.8806119387991, 1202.6452196602024, 22810.315690528645, 23128.306150815504, 23146.305610831703, 23211.0, 23489.0, 37837.24325513529, 38228.0, 38281.0, 38281.234375312895, 38696.22607547777, 229031.12906612828, 229617.0, 229641.0, 232095.0, 233200.0, 26187.214383568524, 26542.203733888015, 26907.730922691306, 26927.596086059115, 27262.045828395912, 29232.41535169327, 29474.852625736734, 29783.702162978094, 30021.84989075128, 35805.64194358127, 25305.367365815266, 27131.0, 27712.168634940983, 28027.859860700566, 29050.27374315659, 28347.85826070939, 28621.14136575906, 28664.57003144913, 28902.710972890003, 28940.85529572423, 25507.23478295654, 26077.478450431263, 28789.712102878704, 29523.261918452212, 29869.103926882228, 22875.428114297276, 24250.51498970046, 24607.507849842546, 24765.0, 25189.62215566731, 19056.8094319055, 19369.903150484723, 19791.0, 19904.402867913985, 20248.696269555672], "prototype.html": [254.34886690073412, 262.69658544381235, 267.5718849840256, 268.54883795224015, 278.5390179253334, 5161.251618515318, 5226.2683224348575, 5233.555147812436, 5265.842024739254, 5276.076686579852, 5090.287359769635, 5158.174692049273, 5160.071187186305, 5179.041877252711, 5225.137852254374, 3875.4380614810975, 3902.6487616114546, 3927.4501569780255, 3946.6842652587725, 3977.6817854571564, 3996.1608062306805, 4017.9799101004455, 4021.4168945502884, 4045.7167998240134, 4074.0, 4009.2582872168596, 4018.9397159042637, 4021.899452513696, 4023.959760402388, 4047.4738284023183, 3803.7147213958924, 3890.513685789276, 3919.2161567686576, 3949.328614135604, 4038.2125485530332, 3419.777714448553, 3433.9828300858585, 3435.158386195398, 3473.4616134499192, 3499.3701133795907, 5110.361204849394, 5118.283440318359, 5120.052790233782, 5170.767315470813, 5174.896502069938, 4456.732596044215, 4530.0, 4534.6372290216705, 4547.636189104896, 4551.340055691906, 5304.602154838364, 5483.835484935418, 5493.23094766733, 5495.945040549584, 5524.66851988882, 3768.7361884668085, 3774.6602805747616, 3775.6224377562025, 3779.4897688811934, 3782.1868298315994, 5782.479576838063, 5793.855153621109, 5796.97101514494, 5829.154772557998, 5882.588218824684, 3844.9807750961068, 3854.5759966403675, 3862.3240932836643, 3867.0332416895776, 3908.9804550977065, 3628.9092772680365, 3895.9805200973815, 3900.1224724436775, 3900.5124359455067, 3919.0006548329993, 4383.517813040563, 4406.9559304407185, 4408.008198155453, 4409.2724700424715, 4437.378766972626, 5490.0, 5493.587980901449, 5499.725013749377, 5512.779488820483, 5527.751251193706, 1312.7571399291162, 1315.4277889118264, 1316.1379296560767, 1318.1168617026424, 1319.0371029148776, 860.8794768732382, 865.260202526843, 878.885744853165, 891.5319457284847, 896.3232759266712, 5323.254744335796, 5325.733713314319, 5346.652467589594, 5408.269883565747, 5410.188471729193, 5748.597598168171, 5831.358550559435, 5834.183214349994, 5839.240898683144, 5847.94152058474, 5314.415414304423, 5347.759350829222, 5352.223927530486, 5395.379531353866, 5398.78404863801, 2858.1425572328217, 2992.670806211315, 3109.9067027989195, 3112.4242015227255, 3114.7196752292402, 5960.642361458326, 5985.491233245223, 6014.51883849291, 6039.54703397247, 6060.636361818305, 5938.079597662369, 5960.761569537257, 6028.0, 6036.034234522455, 6055.333913269536, 6030.306514750772, 6077.270727512727, 6095.085737139465, 6099.71905899766, 6120.816375508742, 5573.191887176417, 5746.7701291949525, 5801.0, 5840.065589505659, 5878.676672783038, 5674.546036317167, 5692.373838877803, 5700.771969121189, 5707.086866101404, 5735.885282294247, 5948.345681974893, 5953.791617293374, 6026.638401695912, 6037.849053773515, 6048.969755151196, 3677.6138505456543, 3773.3019391412677, 3786.3373909565166, 3796.715246356479, 3833.386658134685, 5736.483716465538, 5766.394528574607, 5776.913346299725, 5788.971055144866, 5803.390643982321, 5467.917981230205, 5543.417941116125, 5588.245586845724, 5614.466625670555, 5629.043062679272, 5353.411124776349, 5558.0, 5588.720563971867, 5591.720413979204, 5600.775968961196, 5404.405515393225, 5407.540359069523, 5411.567074633941, 5452.672839629477, 5471.37079235893, 5555.583331250254, 5556.972215138899, 5560.916586251128, 5624.128260119688, 5642.943570564242, 5223.2948551945, 5397.055515284888, 5398.163284690879, 5435.0, 5533.667979921218], "yui.html": [564.5963136357503, 581.4766709961035, 623.1867413025999, 626.6772612104766, 653.196568221088, 11378.805225451333, 11633.47649355779, 11736.647900562975, 11859.881401185985, 11946.701332466682, 11159.553617855296, 11187.44062796861, 11287.774244515105, 11290.09679225662, 11386.7153321167, 600.2197143713178, 601.9036954087347, 609.7865746988541, 740.1636151149194, 747.0922828763051, 747.8242612985944, 755.7921571567808, 758.1281526244835, 771.9848399354859, 783.6316931042401, 778.9610519474032, 788.1055002572093, 789.2423273657267, 789.4000559574707, 796.7888509544975, 621.6518749500294, 627.2786295759889, 628.114358754159, 750.8273097187623, 774.910885248198, 574.7155158196678, 575.4763165519357, 575.4849409778267, 575.5683237571822, 576.0610205365227, 11729.648110556696, 11814.527418903233, 11821.054315654726, 11879.703007424798, 11898.22661526998, 9705.563249653713, 9726.416415015121, 10234.744131396701, 10402.011808878144, 10439.739006524898, 7711.2288771123, 7923.466069593434, 8033.196680331978, 8293.792655183668, 8466.111058338909, 2811.507986102444, 2843.317603775079, 2862.2128914548457, 2906.1862678450066, 2933.9559906601417, 41416.58583414157, 41493.792531037456, 41530.0, 41616.1676766466, 41744.1651166975, 7412.888806667905, 7579.848403032019, 7592.8481430372185, 7788.532688038736, 7846.686132554748, 16072.919635401748, 16122.919385403233, 16205.513834584746, 16255.51233462998, 16305.266263018193, 5794.710264486759, 5932.436418540232, 6102.542309326818, 6139.907901381483, 6160.537959653044, 3151.8581663825184, 3165.5568220448695, 3178.0465860241834, 3230.9030729078167, 3280.0815771583993, 2459.5449841779327, 2495.2389521195846, 2505.912293069734, 2530.8228424010144, 2532.303616505476, 354.1942081763956, 360.91338078860883, 366.1961993424461, 366.75244210158036, 369.9130704284491, 454.69989806727403, 490.8699194713404, 494.430184165281, 513.7123211001851, 539.3500831498036, 6385.265694445198, 6757.628330441873, 6933.93066069343, 6937.445004399636, 7000.92999070013, 404.5711545761502, 431.48437617047955, 481.0283227879664, 486.5791090706513, 502.6707506583194, 3103.4103520331064, 3168.904932852018, 3199.4763411319896, 3295.681727309048, 3326.667333266654, 49563.0, 49628.50371496239, 49927.25109123366, 49931.0, 50272.0, 43013.35479967803, 43575.34636980448, 43682.34476482855, 43859.0, 43936.780316098215, 39267.41098883519, 39523.40714889336, 39620.0, 39761.20477590432, 40257.39613905735, 6377.1390862233, 6451.774187903401, 6463.741450342121, 6499.0, 6625.105610742681, 27859.16422507328, 28780.424391511635, 28791.424171516872, 29637.0, 29966.25084372908, 38521.807390962866, 39626.2074758509, 39715.0, 40214.39678404885, 40302.0, 6403.4877209824035, 6446.613203207635, 6464.4828413725845, 6672.232693240146, 6724.596524208563, 9057.411268267542, 9075.773105672411, 9081.909180908106, 9117.817643646957, 9280.211182049601, 8384.916150838413, 8458.873116903374, 8501.489910605384, 8502.107278735892, 8575.185357391038, 8455.915440845512, 8480.236778689947, 8525.91474085276, 8569.228769410534, 8614.870776938225, 7711.826953158056, 8341.45780524264, 8474.788130296793, 8501.19238672325, 8784.341174411817, 7589.0, 7707.961460192663, 7820.687172513036, 7942.483738556975, 8024.638891250024, 7527.172011078667, 7606.733764318223, 7818.218178182136, 7893.763187104396, 7939.245771651684]}, "summary": {"lowerIsBetter": false, "suite": 5597.363880147689, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6059.504132761569, "unit": "ms", "value": 6059.504132761569}, "dojo.html": {"lowerIsBetter": false, "filtered": 4501.388641909717, "unit": "ms", "value": 4501.388641909717}, "mootools.html": {"lowerIsBetter": false, "filtered": 3561.1910104082094, "unit": "ms", "value": 3561.1910104082094}, "ext.html": {"lowerIsBetter": false, "filtered": 15076.175848494511, "unit": "ms", "value": 15076.175848494511}, "prototype.html": {"lowerIsBetter": false, "filtered": 4148.855957486738, "unit": "ms", "value": 4148.855957486738}, "yui.html": {"lowerIsBetter": false, "filtered": 5061.263893639118, "unit": "ms", "value": 5061.263893639118}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1447802278, "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": "20151117132206", "branch": "Firefox", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}, {"talos_counters": {}, "results": {"audio-dft": [187.0, 190.0, 187.0, 189.0, 189.0, 187.0, 187.0, 190.0, 190.0, 189.0], "ai-astar": [112.0, 127.0, 125.0, 123.0, 132.0, 129.0, 126.0, 124.0, 124.0, 133.0], "imaging-gaussian-blur": [142.0, 141.0, 141.0, 135.0, 147.0, 144.0, 135.0, 141.0, 135.0, 142.0], "audio-beat-detection": [182.0, 158.0, 183.0, 194.0, 152.0, 176.0, 180.0, 153.0, 190.0, 149.0], "json-stringify-tinderbox": [80.0, 77.0, 80.0, 82.0, 82.0, 83.0, 87.0, 87.0, 85.0, 82.0], "stanford-crypto-pbkdf2": [172.0, 171.0, 179.0, 186.0, 188.0, 172.0, 183.0, 179.0, 182.0, 167.0], "json-parse-financial": [66.0, 67.0, 71.0, 70.0, 70.0, 70.0, 75.0, 84.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 84.0, 85.0, 83.0, 86.0, 82.0, 84.0, 89.0, 90.0, 88.0], "audio-fft": [81.0, 95.0, 104.0, 104.0, 84.0, 85.0, 86.0, 98.0, 99.0, 79.0], "imaging-darkroom": [155.0, 148.0, 155.0, 151.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0], "stanford-crypto-ccm": [144.0, 155.0, 152.0, 149.0, 162.0, 143.0, 158.0, 154.0, 158.0, 143.0], "audio-oscillator": [110.0, 114.0, 160.0, 103.0, 104.0, 109.0, 156.0, 108.0, 104.0, 153.0], "stanford-crypto-aes": [98.0, 101.0, 104.0, 105.0, 104.0, 101.0, 101.0, 103.0, 103.0, 102.0], "imaging-desaturate": [109.0, 123.0, 114.0, 109.0, 119.0, 114.0, 114.0, 112.0, 119.0, 130.0]}, "summary": {"lowerIsBetter": true, "suite": 1776.6000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 91.5, "unit": "ms", "value": 91.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 177.9, "unit": "ms", "value": 177.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 171.7, "unit": "ms", "value": 171.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 151.8, "unit": "ms", "value": 151.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.5, "unit": "ms", "value": 149.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.7, "unit": "ms", "value": 71.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 122.1, "unit": "ms", "value": 122.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 125.5, "unit": "ms", "value": 125.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 188.5, "unit": "ms", "value": 188.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 85.1, "unit": "ms", "value": 85.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 82.5, "unit": "ms", "value": 82.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 140.3, "unit": "ms", "value": 140.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 102.2, "unit": "ms", "value": 102.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 116.3, "unit": "ms", "value": 116.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1447802278, "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": "20151117132206", "branch": "Firefox", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [234.52157598499062], "Encrypt": [369.139904023625], "NavierStokes": [6706.666666666667], "Decrypt": [6724.832214765101], "Splay": [825.8011503697617], "Richards": [195.54165037152913], "RegExp": [34440.67796610169], "Earley": [914.9130832570905], "Boyer": [15875.0], "RayTrace": [2269.84126984127]}, "summary": {"lowerIsBetter": false, "suite": 15648.691638143117, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 281.9271519999999, "unit": "score", "value": 281.9271519999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 721.084329, "unit": "score", "value": 721.084329}, "NavierStokes": {"lowerIsBetter": false, "filtered": 221.27236580516907, "unit": "score", "value": 221.27236580516907}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.581805389221536, "unit": "score", "value": 39.581805389221536}, "Splay": {"lowerIsBetter": false, "filtered": 98.68114129353235, "unit": "score", "value": 98.68114129353235}, "RegExp": {"lowerIsBetter": false, "filtered": 26.45084399606298, "unit": "score", "value": 26.45084399606298}, "Richards": {"lowerIsBetter": false, "filtered": 180.53442799999993, "unit": "score", "value": 180.53442799999993}, "Earley": {"lowerIsBetter": false, "filtered": 728.444059, "unit": "score", "value": 728.444059}, "Boyer": {"lowerIsBetter": false, "filtered": 41.98192125984252, "unit": "score", "value": 41.98192125984252}, "RayTrace": {"lowerIsBetter": false, "filtered": 326.0091398601399, "unit": "score", "value": 326.0091398601399}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0105"}, "testrun": {"date": 1447802278, "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": "20151117132206", "branch": "Firefox", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}] 15:38:16 INFO - RETURN: dromaeo_css: 5597.36 15:38:16 INFO - RETURN: kraken: 1776.60 15:38:16 INFO - RETURN: v8_7: 15648.69 15:38:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15648.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1776.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5597.36"}}} 15:38:16 INFO - Return code: 0 15:38:16 INFO - # TBPL SUCCESS # 15:38:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:38:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:38:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:38:16 INFO - 2015-11-17 15:38:16.544 screenresolution[2231:20946] starting screenresolution argv=screenresolution get 15:38:16 INFO - 2015-11-17 15:38:16.548 screenresolution[2231:20946] Display 0: 1600x1200x32@60 15:38:16 INFO - 2015-11-17 15:38:16.554 screenresolution[2232:20950] starting screenresolution argv=screenresolution list 15:38:16 INFO - Available Modes on Display 0 15:38:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:38:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:38:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:38:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:38:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:38:16 INFO - Intel HD Graphics 3000: 15:38:16 INFO - Chipset Model: Intel HD Graphics 3000 15:38:16 INFO - Type: GPU 15:38:16 INFO - Bus: Built-In 15:38:16 INFO - VRAM (Total): 512 MB 15:38:16 INFO - VRAM (Dynamic, Max): 10 15:38:16 INFO - Vendor: Intel (0x8086) 15:38:16 INFO - Device ID: 0x0116 15:38:16 INFO - Revision ID: 0x0009 15:38:16 INFO - Displays: 15:38:16 INFO - Display: 15:38:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:38:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:38:16 INFO - Display Serial Number: 1600x1200 60 15:38:16 INFO - Main Display: Yes 15:38:16 INFO - Mirror: Off 15:38:16 INFO - Online: Yes 15:38:16 INFO - Rotation: Supported 15:38:16 INFO - Return code: 0 15:38:16 INFO - Running post-action listener: _resource_record_post_action 15:38:16 INFO - Running post-run listener: _resource_record_post_run 15:38:17 INFO - Total resource usage - Wall time: 1261s; CPU: 30.0%; Read bytes: 942080; Write bytes: 684624896; Read time: 840; Write time: 61068 15:38:17 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 343249408; Write bytes: 344963072; Read time: 37206; Write time: 4695 15:38:17 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 204800; Write bytes: 338256896; Read time: 773; Write time: 56350 15:38:17 INFO - Running post-run listener: _upload_blobber_files 15:38:17 INFO - Blob upload gear active. 15:38:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:38:17 INFO - Copying logs to upload dir... 15:38:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1319.570228 ========= master_lag: 1.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-17 15:38:19.140713) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-17 15:38:19.147292) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009778 build_url: 'https://queue.taskcluster.net/v1/task/dUgAGJlcQcmx8PYA_kaPyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.08 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-17 15:38:20.234484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:38:20.237135) ========= 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.3nQbPPbjOI/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.sbCO8vdogj/Listeners TMPDIR=/var/folders/dq/2cgqwyz90cv3_ndl5rbdcl7w00000w/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.005373 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:38:20.550947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 15:38:20.551273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 15:38:20.556273) ========= ========= Total master_lag: 2.94 =========