builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0043 starttime: 1447259531.61 results: success (0) buildid: 20151111071631 builduid: a68df9c5e0e34c968a606f9c245c7e59 revision: af5c9cf6898b0e2931a809774387cad5953363c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.610891) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.611331) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.611636) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.005991 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.634859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.635175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.651016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.651440) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.005515 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.700451) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.700836) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.701202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.701479) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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-11 08:32:11-- 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% 1.41G=0s 2015-11-11 08:32:11 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.855469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.855801) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.020546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:11.909064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 08:32:11.909415) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev af5c9cf6898b0e2931a809774387cad5953363c3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev af5c9cf6898b0e2931a809774387cad5953363c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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-11 08:32:11,981 truncating revision to first 12 chars 2015-11-11 08:32:11,981 Setting DEBUG logging. 2015-11-11 08:32:11,981 attempt 1/10 2015-11-11 08:32:11,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/af5c9cf6898b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 08:32:13,263 unpacking tar archive at: mozilla-inbound-af5c9cf6898b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.524118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 08:32:13.452691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:13.453055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:13.466447) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:13.466812) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 08:32:13.467259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2015-11-11 08:32:13.467552) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:13 INFO - MultiFileLogger online at 20151111 08:32:13 in /builds/slave/test 08:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:13 INFO - {'append_to_log': False, 08:32:13 INFO - 'base_work_dir': '/builds/slave/test', 08:32:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:13 INFO - 'branch': 'Mozilla-Inbound', 08:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:13 INFO - 'config_files': ('talos/mac_config.py',), 08:32:13 INFO - 'default_actions': ('clobber', 08:32:13 INFO - 'read-buildbot-config', 08:32:13 INFO - 'download-and-extract', 08:32:13 INFO - 'populate-webroot', 08:32:13 INFO - 'create-virtualenv', 08:32:13 INFO - 'install', 08:32:13 INFO - 'run-tests'), 08:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:13 INFO - 'download_minidump_stackwalk': True, 08:32:13 INFO - 'download_symbols': 'ondemand', 08:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:13 INFO - 'installer_path': 'installer.exe', 08:32:13 INFO - 'log_level': 'info', 08:32:13 INFO - 'log_name': 'talos', 08:32:13 INFO - 'log_to_console': True, 08:32:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:32:13 INFO - 'opt_config_files': (), 08:32:13 INFO - 'pip_index': False, 08:32:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:13 INFO - 'cmd': ('bash', 08:32:13 INFO - '-c', 08:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:13 INFO - 'enabled': True, 08:32:13 INFO - 'halt_on_failure': False, 08:32:13 INFO - 'name': 'check_screen_resolution'},), 08:32:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:13 INFO - 'cmd': ('bash', 08:32:13 INFO - '-c', 08:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:13 INFO - 'enabled': True, 08:32:13 INFO - 'halt_on_failure': False, 08:32:13 INFO - 'name': 'check_screen_resolution'},), 08:32:13 INFO - 'run_cmd_checks_enabled': True, 08:32:13 INFO - 'sps_profile': False, 08:32:13 INFO - 'sps_profile_interval': 0, 08:32:13 INFO - 'suite': 'dromaeojs', 08:32:13 INFO - 'system_bits': '64', 08:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:13 INFO - 'title': 't-yosemite-r5-0043', 08:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:13 INFO - 'use_talos_json': True, 08:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:13 INFO - 'work_dir': 'build'} 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running clobber step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: clobber 08:32:13 INFO - rmtree: /builds/slave/test/build 08:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:15 INFO - Running post-action listener: _resource_record_post_action 08:32:15 INFO - ##### 08:32:15 INFO - ##### Running read-buildbot-config step. 08:32:15 INFO - ##### 08:32:15 INFO - Running pre-action listener: _resource_record_pre_action 08:32:15 INFO - Running main action method: read_buildbot_config 08:32:15 INFO - Using buildbot properties: 08:32:15 INFO - { 08:32:15 INFO - "properties": { 08:32:15 INFO - "buildnumber": 3110, 08:32:15 INFO - "product": "firefox", 08:32:15 INFO - "script_repo_revision": "production", 08:32:15 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 08:32:15 INFO - "repository": "", 08:32:15 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 08:32:15 INFO - "buildid": "20151111071631", 08:32:15 INFO - "slavename": "t-yosemite-r5-0043", 08:32:15 INFO - "pgo_build": "False", 08:32:15 INFO - "basedir": "/builds/slave/test", 08:32:15 INFO - "project": "", 08:32:15 INFO - "platform": "yosemite", 08:32:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:32:15 INFO - "slavebuilddir": "test", 08:32:15 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 08:32:15 INFO - "branch": "mozilla-inbound", 08:32:15 INFO - "repo_path": "integration/mozilla-inbound", 08:32:15 INFO - "stage_platform": "macosx64", 08:32:15 INFO - "builduid": "a68df9c5e0e34c968a606f9c245c7e59", 08:32:15 INFO - "revision": "af5c9cf6898b0e2931a809774387cad5953363c3" 08:32:15 INFO - }, 08:32:15 INFO - "sourcestamp": { 08:32:15 INFO - "repository": "", 08:32:15 INFO - "hasPatch": false, 08:32:15 INFO - "project": "", 08:32:15 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:32:15 INFO - "changes": [ 08:32:15 INFO - { 08:32:15 INFO - "category": null, 08:32:15 INFO - "files": [ 08:32:15 INFO - { 08:32:15 INFO - "url": null, 08:32:15 INFO - "name": "https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:32:15 INFO - } 08:32:15 INFO - ], 08:32:15 INFO - "repository": "", 08:32:15 INFO - "rev": "af5c9cf6898b0e2931a809774387cad5953363c3", 08:32:15 INFO - "who": "bschouten@mozilla.com", 08:32:15 INFO - "when": 1447259077, 08:32:15 INFO - "number": 6648964, 08:32:15 INFO - "comments": "Bug 1210560 - Part 8: Remove unused PushGroup/PopGroup/PopGroupToSource functions. r=jrmuizel", 08:32:15 INFO - "project": "", 08:32:15 INFO - "at": "Wed 11 Nov 2015 08:24:37", 08:32:15 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:32:15 INFO - "revlink": "", 08:32:15 INFO - "properties": [ 08:32:15 INFO - [ 08:32:15 INFO - "buildid", 08:32:15 INFO - "20151111071631", 08:32:15 INFO - "Change" 08:32:15 INFO - ], 08:32:15 INFO - [ 08:32:15 INFO - "builduid", 08:32:15 INFO - "a68df9c5e0e34c968a606f9c245c7e59", 08:32:15 INFO - "Change" 08:32:15 INFO - ], 08:32:15 INFO - [ 08:32:15 INFO - "pgo_build", 08:32:15 INFO - "False", 08:32:15 INFO - "Change" 08:32:15 INFO - ] 08:32:15 INFO - ], 08:32:15 INFO - "revision": "af5c9cf6898b0e2931a809774387cad5953363c3" 08:32:15 INFO - } 08:32:15 INFO - ], 08:32:15 INFO - "revision": "af5c9cf6898b0e2931a809774387cad5953363c3" 08:32:15 INFO - } 08:32:15 INFO - } 08:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:32:15 INFO - Running post-action listener: _resource_record_post_action 08:32:15 INFO - ##### 08:32:15 INFO - ##### Running download-and-extract step. 08:32:15 INFO - ##### 08:32:15 INFO - Running pre-action listener: _resource_record_pre_action 08:32:15 INFO - Running main action method: download_and_extract 08:32:15 INFO - mkdir: /builds/slave/test/build/tests 08:32: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')]} 08:32:15 INFO - https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/test_packages.json 08:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/test_packages.json 08:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:32:16 INFO - Downloaded 1149 bytes. 08:32:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:32:16 INFO - Using the following test package requirements: 08:32:16 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:32:16 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:32:16 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'jsshell-mac.zip'], 08:32:16 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:32:16 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:32:16 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:32:16 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:32:16 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:32:16 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:32:16 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:32:16 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:32:16 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:16 INFO - https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:17 INFO - Downloaded 17453679 bytes. 08:32:17 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 08:32:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:32:21 INFO - Return code: 0 08:32:21 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 08:32: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')]} 08:32:21 INFO - https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:22 INFO - Downloaded 17453679 bytes. 08:32:22 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 08:32:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:32:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:32:27 INFO - Return code: 0 08:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:27 INFO - https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:28 INFO - Downloaded 11131693 bytes. 08:32:28 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 08:32:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:32:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:32:28 INFO - Return code: 0 08:32: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')]} 08:32:28 INFO - https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-BOtQRAHTUWi0SGAPzxVZg/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 08:32:32 INFO - Downloaded 108736523 bytes. 08:32:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:32:32 INFO - mkdir: /builds/slave/test/properties 08:32:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:32 INFO - Contents: 08:32:32 INFO - build_url:https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:32:32 INFO - Running post-action listener: _resource_record_post_action 08:32:32 INFO - Running post-action listener: set_extra_try_arguments 08:32:32 INFO - ##### 08:32:32 INFO - ##### Running populate-webroot step. 08:32:32 INFO - ##### 08:32:32 INFO - Running pre-action listener: _resource_record_pre_action 08:32:32 INFO - Running main action method: populate_webroot 08:32:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:32:32 INFO - '../fennec_ids.txt'], 08:32:32 INFO - 'tests': ['tcheck2']}, 08:32:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:32 INFO - '--tppagecycles', 08:32:32 INFO - '7'], 08:32:32 INFO - 'tests': ['tsvgm']}}, 08:32:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:32:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'tests': ['damp', 'tps']}, 08:32:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['damp', 'tps']}, 08:32:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:32:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:32 INFO - 'other': {'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'other_l64': {'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'other_nol64': {'tests': ['a11yr', 08:32:32 INFO - 'ts_paint', 08:32:32 INFO - 'tpaint', 08:32:32 INFO - 'sessionrestore', 08:32:32 INFO - 'sessionrestore_no_auto_restore']}, 08:32:32 INFO - 'svgr': {'tests': ['tsvgx', 08:32:32 INFO - 'tsvgr_opacity', 08:32:32 INFO - 'tart', 08:32:32 INFO - 'tscrollx', 08:32:32 INFO - 'cart']}, 08:32:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['tsvgx', 08:32:32 INFO - 'tsvgr_opacity', 08:32:32 INFO - 'tart', 08:32:32 INFO - 'tscrollx', 08:32:32 INFO - 'cart']}, 08:32:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'tests': ['tp5o']}, 08:32:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'talos_options': ['--e10s'], 08:32:32 INFO - 'tests': ['tp5o']}, 08:32:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'talos_options': ['--xperf_path', 08:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:32 INFO - 'tests': ['tp5n']}, 08:32:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:32 INFO - 'talos_options': ['--e10s', 08:32:32 INFO - '--xperf_path', 08:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:32 INFO - 'tests': ['tp5n']}}, 08:32:32 INFO - 'talos.zip': {'path': '', 08:32:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:32 INFO - Running post-action listener: _resource_record_post_action 08:32:32 INFO - ##### 08:32:32 INFO - ##### Running create-virtualenv step. 08:32:32 INFO - ##### 08:32:32 INFO - Running pre-action listener: _resource_record_pre_action 08:32:32 INFO - Running main action method: create_virtualenv 08:32:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:32 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 08:32:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:32 INFO - Using real prefix '/tools/python27' 08:32:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:36 INFO - Installing pip.................done. 08:32:36 INFO - Return code: 0 08:32:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:36 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:36 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 08:32:36 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 08:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:36 INFO - 'HOME': '/Users/cltbld', 08:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:36 INFO - 'LOGNAME': 'cltbld', 08:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:36 INFO - 'MOZ_NO_REMOTE': '1', 08:32:36 INFO - 'NO_EM_RESTART': '1', 08:32:36 INFO - 'PAGER': '/bin/cat', 08:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:36 INFO - 'PWD': '/builds/slave/test', 08:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:36 INFO - 'SHELL': '/bin/bash', 08:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:36 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:36 INFO - 'USER': 'cltbld', 08:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:36 INFO - 'XPC_FLAGS': '0x0', 08:32:36 INFO - 'XPC_SERVICE_NAME': '0', 08:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:37 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 08:32:37 INFO - Cleaning up... 08:32:37 INFO - Return code: 0 08:32:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:32:37 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')]} 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:37 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')]} 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:37 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:37 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 08:32:37 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 08:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:37 INFO - 'HOME': '/Users/cltbld', 08:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:37 INFO - 'LOGNAME': 'cltbld', 08:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:37 INFO - 'MOZ_NO_REMOTE': '1', 08:32:37 INFO - 'NO_EM_RESTART': '1', 08:32:37 INFO - 'PAGER': '/bin/cat', 08:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:37 INFO - 'PWD': '/builds/slave/test', 08:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:37 INFO - 'SHELL': '/bin/bash', 08:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:37 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:37 INFO - 'USER': 'cltbld', 08:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:37 INFO - 'XPC_FLAGS': '0x0', 08:32:37 INFO - 'XPC_SERVICE_NAME': '0', 08:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:37 INFO - Downloading/unpacking psutil>=0.7.1 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:39 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:32:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:40 INFO - Installing collected packages: psutil 08:32:40 INFO - Running setup.py install for psutil 08:32:40 INFO - building 'psutil._psutil_osx' extension 08:32:40 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 08:32:40 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 08:32:40 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 08:32:40 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 08:32:40 INFO - building 'psutil._psutil_posix' extension 08:32:40 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 08:32:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:32:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:32:40 INFO - ^ 08:32:40 INFO - 1 warning generated. 08:32:40 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 08:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:40 INFO - Successfully installed psutil 08:32:40 INFO - Cleaning up... 08:32:41 INFO - Return code: 0 08:32:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:41 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 08:32:41 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 08:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:41 INFO - 'HOME': '/Users/cltbld', 08:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:41 INFO - 'LOGNAME': 'cltbld', 08:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:41 INFO - 'MOZ_NO_REMOTE': '1', 08:32:41 INFO - 'NO_EM_RESTART': '1', 08:32:41 INFO - 'PAGER': '/bin/cat', 08:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:41 INFO - 'PWD': '/builds/slave/test', 08:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:41 INFO - 'SHELL': '/bin/bash', 08:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:41 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:41 INFO - 'USER': 'cltbld', 08:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:41 INFO - 'XPC_FLAGS': '0x0', 08:32:41 INFO - 'XPC_SERVICE_NAME': '0', 08:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:43 INFO - Installing collected packages: mozsystemmonitor 08:32:43 INFO - Running setup.py install for mozsystemmonitor 08:32:43 INFO - Successfully installed mozsystemmonitor 08:32:43 INFO - Cleaning up... 08:32:43 INFO - Return code: 0 08:32:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:43 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')]} 08:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:43 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')]} 08:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:43 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:43 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 08:32:43 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 08:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:43 INFO - 'HOME': '/Users/cltbld', 08:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:43 INFO - 'LOGNAME': 'cltbld', 08:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:43 INFO - 'MOZ_NO_REMOTE': '1', 08:32:43 INFO - 'NO_EM_RESTART': '1', 08:32:43 INFO - 'PAGER': '/bin/cat', 08:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:43 INFO - 'PWD': '/builds/slave/test', 08:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:43 INFO - 'SHELL': '/bin/bash', 08:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:43 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:43 INFO - 'USER': 'cltbld', 08:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:43 INFO - 'XPC_FLAGS': '0x0', 08:32:43 INFO - 'XPC_SERVICE_NAME': '0', 08:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:47 INFO - Downloading docopt-0.6.1.tar.gz 08:32:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:47 INFO - Running setup.py install for blobuploader 08:32:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:47 INFO - Running setup.py install for requests 08:32:48 INFO - Running setup.py install for docopt 08:32:48 INFO - Successfully installed blobuploader requests docopt 08:32:48 INFO - Cleaning up... 08:32:48 INFO - Return code: 0 08:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:48 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')]} 08:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:48 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')]} 08:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:48 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:48 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 08:32:48 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 08:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:48 INFO - 'HOME': '/Users/cltbld', 08:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:48 INFO - 'LOGNAME': 'cltbld', 08:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:48 INFO - 'MOZ_NO_REMOTE': '1', 08:32:48 INFO - 'NO_EM_RESTART': '1', 08:32:48 INFO - 'PAGER': '/bin/cat', 08:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:48 INFO - 'PWD': '/builds/slave/test', 08:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:48 INFO - 'SHELL': '/bin/bash', 08:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:48 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:48 INFO - 'USER': 'cltbld', 08:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:48 INFO - 'XPC_FLAGS': '0x0', 08:32:48 INFO - 'XPC_SERVICE_NAME': '0', 08:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:48 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-YvRELM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-V9mdOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-PKICuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-sTj0uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-KnP3wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-1Luu2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-6e9qCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-dSjp2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-jyGudC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:49 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-0D_wfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-J10I7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-aBeiBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-eTQh7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-JoglJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-riJVMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-RtYLFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:50 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-7cxkB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:50 INFO - Running setup.py install for manifestparser 08:32:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:51 INFO - Running setup.py install for mozcrash 08:32:51 INFO - Running setup.py install for mozdebug 08:32:51 INFO - Running setup.py install for mozdevice 08:32:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:51 INFO - Running setup.py install for mozfile 08:32:51 INFO - Running setup.py install for mozhttpd 08:32:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:51 INFO - Running setup.py install for mozinfo 08:32:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:51 INFO - Running setup.py install for mozInstall 08:32:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozleak 08:32:52 INFO - Running setup.py install for mozlog 08:32:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for moznetwork 08:32:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozprocess 08:32:52 INFO - Running setup.py install for mozprofile 08:32:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Running setup.py install for mozrunner 08:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Running setup.py install for mozscreenshot 08:32:53 INFO - Running setup.py install for moztest 08:32:53 INFO - Running setup.py install for mozversion 08:32:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:53 INFO - Cleaning up... 08:32:53 INFO - Return code: 0 08:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:53 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')]} 08:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 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')]} 08:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:53 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 08:32:53 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 08:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:53 INFO - 'HOME': '/Users/cltbld', 08:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:53 INFO - 'LOGNAME': 'cltbld', 08:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:53 INFO - 'MOZ_NO_REMOTE': '1', 08:32:53 INFO - 'NO_EM_RESTART': '1', 08:32:53 INFO - 'PAGER': '/bin/cat', 08:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:53 INFO - 'PWD': '/builds/slave/test', 08:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:53 INFO - 'SHELL': '/bin/bash', 08:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:53 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:53 INFO - 'USER': 'cltbld', 08:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:53 INFO - 'XPC_FLAGS': '0x0', 08:32:53 INFO - 'XPC_SERVICE_NAME': '0', 08:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-opvyus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-L1vakz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-vHFpTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-9pEWzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-HWhAeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-3tvvsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-ypQJwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-_pQeP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:54 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-XpLFSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-5_j9S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-oXkHmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-XKUske-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-I1zMUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-ssr8xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-7YVExa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-SmcEFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:55 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-PYmbl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:56 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)) 08:32:56 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)) 08:32:56 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)) 08:32:56 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)) 08:32:56 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)) 08:32:56 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)) 08:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - Downloading blessings-1.5.1.tar.gz 08:32:58 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 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:58 INFO - Installing collected packages: blessings 08:32:58 INFO - Running setup.py install for blessings 08:32:58 INFO - Successfully installed blessings 08:32:58 INFO - Cleaning up... 08:32:58 INFO - Return code: 0 08:32:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:58 INFO - Reading from file tmpfile_stdout 08:32:58 INFO - Current package versions: 08:32:58 INFO - blessings == 1.5.1 08:32:58 INFO - blobuploader == 1.2.4 08:32:58 INFO - docopt == 0.6.1 08:32:58 INFO - manifestparser == 1.1 08:32:58 INFO - mozInstall == 1.12 08:32:58 INFO - mozcrash == 0.16 08:32:58 INFO - mozdebug == 0.1 08:32:58 INFO - mozdevice == 0.47 08:32:58 INFO - mozfile == 1.2 08:32:58 INFO - mozhttpd == 0.7 08:32:58 INFO - mozinfo == 0.9 08:32:58 INFO - mozleak == 0.1 08:32:58 INFO - mozlog == 3.0 08:32:58 INFO - moznetwork == 0.27 08:32:58 INFO - mozprocess == 0.22 08:32:58 INFO - mozprofile == 0.27 08:32:58 INFO - mozrunner == 6.11 08:32:58 INFO - mozscreenshot == 0.1 08:32:58 INFO - mozsystemmonitor == 0.0 08:32:58 INFO - moztest == 0.7 08:32:58 INFO - mozversion == 1.4 08:32:58 INFO - psutil == 3.1.1 08:32:58 INFO - requests == 1.2.3 08:32:58 INFO - wsgiref == 0.1.2 08:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:58 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')]} 08:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:58 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')]} 08:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:58 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 0x10aa38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa15228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb368e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, '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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 08:32:58 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 08:32:58 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 08:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:58 INFO - 'HOME': '/Users/cltbld', 08:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:58 INFO - 'LOGNAME': 'cltbld', 08:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:58 INFO - 'MOZ_NO_REMOTE': '1', 08:32:58 INFO - 'NO_EM_RESTART': '1', 08:32:58 INFO - 'PAGER': '/bin/cat', 08:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:58 INFO - 'PWD': '/builds/slave/test', 08:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:58 INFO - 'SHELL': '/bin/bash', 08:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:32:58 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:58 INFO - 'USER': 'cltbld', 08:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:58 INFO - 'XPC_FLAGS': '0x0', 08:32:58 INFO - 'XPC_SERVICE_NAME': '0', 08:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 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)) 08:32:59 INFO - Cleaning up... 08:32:59 INFO - Return code: 0 08:32:59 INFO - Running post-action listener: _resource_record_post_action 08:32:59 INFO - Running post-action listener: _start_resource_monitoring 08:32:59 INFO - Starting resource monitoring. 08:32:59 INFO - ##### 08:32:59 INFO - ##### Running install step. 08:32:59 INFO - ##### 08:32:59 INFO - Running pre-action listener: _resource_record_pre_action 08:32:59 INFO - Running main action method: install 08:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:59 INFO - Reading from file tmpfile_stdout 08:32:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:59 INFO - Reading from file tmpfile_stdout 08:32:59 INFO - Output received: 08:32:59 INFO - Usage: mozinstall [options] installer 08:32:59 INFO - Options: 08:32:59 INFO - -h, --help show this help message and exit 08:32:59 INFO - -d DEST, --destination=DEST 08:32:59 INFO - Directory to install application into. [default: 08:32:59 INFO - "/builds/slave/test"] 08:32:59 INFO - --app=APP Application being installed. [default: firefox] 08:32:59 INFO - mkdir: /builds/slave/test/build/application 08:32:59 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'] 08:32:59 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 08:33:34 INFO - Reading from file tmpfile_stdout 08:33:34 INFO - Output received: 08:33:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:33:34 INFO - Running post-action listener: _resource_record_post_action 08:33:34 INFO - ##### 08:33:34 INFO - ##### Running run-tests step. 08:33:34 INFO - ##### 08:33:34 INFO - Running pre-action listener: _resource_record_pre_action 08:33:34 INFO - Running main action method: run_tests 08:33:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:34 INFO - 2015-11-11 08:33:34.931 screenresolution[2528:22055] starting screenresolution argv=screenresolution get 08:33:34 INFO - 2015-11-11 08:33:34.934 screenresolution[2528:22055] Display 0: 1600x1200x32@60 08:33:34 INFO - 2015-11-11 08:33:34.940 screenresolution[2529:22058] starting screenresolution argv=screenresolution list 08:33:34 INFO - Available Modes on Display 0 08:33:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:35 INFO - Intel HD Graphics 3000: 08:33:35 INFO - Chipset Model: Intel HD Graphics 3000 08:33:35 INFO - Type: GPU 08:33:35 INFO - Bus: Built-In 08:33:35 INFO - VRAM (Total): 512 MB 08:33:35 INFO - VRAM (Dynamic, Max): 10 08:33:35 INFO - Vendor: Intel (0x8086) 08:33:35 INFO - Device ID: 0x0116 08:33:35 INFO - Revision ID: 0x0009 08:33:35 INFO - Displays: 08:33:35 INFO - Display: 08:33:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:35 INFO - Display Serial Number: 1600x1200 60 08:33:35 INFO - Main Display: Yes 08:33:35 INFO - Mirror: Off 08:33:35 INFO - Online: Yes 08:33:35 INFO - Rotation: Supported 08:33:35 INFO - Return code: 0 08:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:35 INFO - Python 2.7.3 08:33:35 INFO - Return code: 0 08:33:35 INFO - grabbing minidump binary from tooltool 08:33:35 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')]} 08:33:35 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 0x10a95b9f0>, '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 0x10a6bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:35 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 08:33:35 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 08:33:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:35 INFO - Return code: 0 08:33:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:33:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:33:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0043', '--webServer', 'localhost'] in /builds/slave/test/build 08:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0043 --webServer localhost 08:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RjiWtg1h2c/Render', 08:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:35 INFO - 'HOME': '/Users/cltbld', 08:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:35 INFO - 'LOGNAME': 'cltbld', 08:33:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:35 INFO - 'MOZ_NO_REMOTE': '1', 08:33:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:35 INFO - 'NO_EM_RESTART': '1', 08:33:35 INFO - 'PAGER': '/bin/cat', 08:33:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:35 INFO - 'PWD': '/builds/slave/test', 08:33:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:35 INFO - 'SHELL': '/bin/bash', 08:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRzCuvUAiW/Listeners', 08:33:35 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 08:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:35 INFO - 'USER': 'cltbld', 08:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:35 INFO - 'XPC_FLAGS': '0x0', 08:33:35 INFO - 'XPC_SERVICE_NAME': '0', 08:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:33:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0043', '--webServer', 'localhost'] with output_timeout 3600 08:33:35 INFO - mozversion INFO | application_buildid: 20151111071631 08:33:35 INFO - mozversion INFO | application_changeset: af5c9cf6898b0e2931a809774387cad5953363c3 08:33:35 INFO - mozversion INFO | application_display_name: Nightly 08:33:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:35 INFO - mozversion INFO | application_name: Firefox 08:33:35 INFO - mozversion INFO | application_remotingname: firefox 08:33:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:33:35 INFO - mozversion INFO | application_vendor: Mozilla 08:33:35 INFO - mozversion INFO | application_version: 45.0a1 08:33:35 INFO - mozversion INFO | platform_buildid: 20151111071631 08:33:35 INFO - mozversion INFO | platform_changeset: af5c9cf6898b0e2931a809774387cad5953363c3 08:33:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:33:35 INFO - mozversion INFO | platform_version: 45.0a1 08:33:35 INFO - 2015-11-11 08:33:35,520 DEBUG : using testdate: 1447259615 08:33:35 INFO - 2015-11-11 08:33:35,520 DEBUG : actual date: 1447259615 08:33:35 INFO - 2015-11-11 08:33:35,530 INFO : starting webserver on 'localhost:51099' 08:33:35 INFO - 2015-11-11 08:33:35,531 INFO : Starting test suite t-yosemite-r5-0043 08:33:35 INFO - 2015-11-11 08:33:35,531 INFO : Starting test dromaeo_css 08:33:35 INFO - 2015-11-11 08:33:35,531 DEBUG : operating with platform_type : mac_ 08:33:35 INFO - 2015-11-11 08:33:35,532 INFO : Initialising browser for dromaeo_css test... 08:33:35 INFO - 2015-11-11 08:33:35,545 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpvsOQxP/profile http://localhost:51099/getInfo.html 08:33:38 INFO - 2015-11-11 08:33:38,015 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:33:38 INFO - 2015-11-11 08:33:38,016 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:33:38 INFO - 2015-11-11 08:33:38,016 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:33:38 INFO - 2015-11-11 08:33:38,016 DEBUG : BROWSER_OUTPUT: __metrics 08:33:38 INFO - 2015-11-11 08:33:38,032 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:38 INFO - 2015-11-11 08:33:38,677 INFO : Browser initialized. 08:33:38 INFO - 2015-11-11 08:33:38,677 INFO : Running cycle 1/1 for dromaeo_css test... 08:33:38 INFO - 2015-11-11 08:33:38,677 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpvsOQxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:33:50 INFO - 2015-11-11 08:33:50,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 227581952 08:33:50 INFO - 2015-11-11 08:33:50,698 DEBUG : BROWSER_OUTPUT: 08:34:42 INFO - 2015-11-11 08:34:42,456 DEBUG : BROWSER_OUTPUT: 1447259682455 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:36:52 INFO - 2015-11-11 08:36:52,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51099/tests/dromaeo/cssquery-ext.html) 08:36:54 INFO - 2015-11-11 08:36:54,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 407252992 08:36:54 INFO - 2015-11-11 08:36:54,184 DEBUG : BROWSER_OUTPUT: 08:39:57 INFO - 2015-11-11 08:39:57,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-ext.html (next: http://localhost:51099/tests/dromaeo/cssquery-jquery.html) 08:39:57 INFO - 2015-11-11 08:39:57,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 370081792 08:39:57 INFO - 2015-11-11 08:39:57,641 DEBUG : BROWSER_OUTPUT: 08:42:59 INFO - 2015-11-11 08:42:59,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51099/tests/dromaeo/cssquery-mootools.html) 08:43:00 INFO - 2015-11-11 08:43:00,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 361185280 08:43:00 INFO - 2015-11-11 08:43:00,362 DEBUG : BROWSER_OUTPUT: 08:46:02 INFO - 2015-11-11 08:46:02,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51099/tests/dromaeo/cssquery-prototype.html) 08:46:02 INFO - 2015-11-11 08:46:02,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 319205376 08:46:02 INFO - 2015-11-11 08:46:02,951 DEBUG : BROWSER_OUTPUT: 08:49:06 INFO - 2015-11-11 08:49:06,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51099/tests/dromaeo/cssquery-yui.html) 08:49:06 INFO - 2015-11-11 08:49:06,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 321544192 08:49:06 INFO - 2015-11-11 08:49:06,823 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-11 08:52:09,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/dromaeo/cssquery-yui.html (next: http://localhost:51099/tests/dromaeo/cssquery-dojo.html) 08:52:10 INFO - 2015-11-11 08:52:10,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 380477440 08:52:10 INFO - 2015-11-11 08:52:10,003 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,003 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:10 INFO - 2015-11-11 08:52:10,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:10 INFO - 2015-11-11 08:52:10,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:10 INFO - 2015-11-11 08:52:10,004 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:10 INFO - 2015-11-11 08:52:10,006 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3137.8901738439154;3203.4233837909196;3220.5652236948004;3230.4669729494635;3254.495553189255;5211.765470553824;5334.91997620036;5381.515663590276;5438.428964958677;5526.19870118833;5425.3489581250205;5462.972685136579;5476.479734425223;5491.450854914507;5641.294838145232;5035.118854200509;5087;5091.210862316347;5176.171812509999;5189.2475591039465;5202.479752024805;5230.790768369261;5234.581233501311;5256.237845512398;5276.841694749163;4933.827316043921;5015.0972824891505;5017.8243761468175;5039.72281524516;5208.8437346879655;5008.424031236382;5143.948560514385;5167.560757335631;5171.120909445403;5176;5119.795208191668;5132.307138536287;5134.306868572769;5158.071547121516;5162.174052151675;5152.819651312224;5272.393674727378;5290.920636190422;5450.127979523258;5452.154915988028;5870.97064514679;5941.613795103304;5942.554308426886;5948.7620495180145;6013.007853704134;5996.820095397102;6052.303985041688;6060.72726727294;6060.878782424371;6063.090536419572;5459.481349271813;5562.972185139049;5574.58190635704;5595.104783234704;5598.356189038232;5880.764769409176;6061.393860613904;6063.060225665029;6070.544709146831;6071.453569178795;5840.8247752567495;5863.970680146572;5876.559258055663;5882.823515294548;5883.117532370093;5739.799107031234;5868.911966320508;5884.646921184657;6004.039353703474;6007.189029481052;5699.116636921284;5745.109508026263;5755.6834374108985;5775.364709881909;5800.477956983892;5864.882702345929;5877;5912.054071348563;5915.70421478933;5925.229720136354;4447.155040542287;4517.41273634432;4527.117212143667;4529.207388707029;4544.023035047415;4074.6536544394057;4080.3063479208013;4113.568075352105;4124.257633625916;4147.97926010368;5521.5306698930235;5530.446955304437;5546.611737178439;5547.44525547442;5547.972260138754;5801.6519008859605;5905.350411454737;5914.585978981516;5977;5980.641161530322;5401.081816091274;5450.672959622435;5461.371942226695;5476.205950137208;5482.780688772485;5243.790248390098;5254.028004819121;5263;5269.1569348903995;5309.5752339812725;5911.586188966731;5970.731317090655;6057.727402266997;6077.301110372364;6147.323794382614;5747.367789543064;5823.505002074871;5862.267216597926;5875.294964604275;5896.380880007538;5950.940490595039;5969.224000879858;5972.910406343822;6029;6050.606710563799;5672.376038635664;5773.942260577341;5805.564582656233;5818.418158184148;5844.853878653068;5750.166225897138;5780.479756821906;5783.16144159103;5784.5083167929515;5819.330776960704;5742.942570574408;5812.82561523155;5834.416558344132;5869.207656966255;5874.5887787854435;5646.85882852932;5761.5102716269585;5811.79658711943;5837.94162058374;5889.823305300848;5599.636023658449;5612.579056570692;5640.774369025357;5644.8024319148635;5671.404502527175;5547.5007249347755;5590.86022849432;5718.25662663851;5719.57103217252;5766.1350797379055;5648.068068768607;5674.546036317167;5679.062954612443;5727.369989301257;5741.684207368635 08:52:10 INFO - 2015-11-11 08:52:10,010 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.1509133480106;553.8559974406654;566.0744682444204;569.2144840120638;573.7131434282859;31277.843610781943;32031;38670.80664596673;39095.41356879642;39178;42116;42460;42484.15031699364;42609.360859587054;42716;7441.330280274774;9202.125798049192;9357.67248146315;9383.155516003559;9385.061493850628;8401.621927013299;11171.329720216812;11398.658040258806;11405.20163588549;11429;10972.23194376394;11187.272827266203;11210.831837522444;11263.085275503143;11273.718157046098;8582.22759951601;8639.697610583662;11064.889351106507;11157.386343751132;11252.099832013419;10756.300840445347;10934.507947142398;11044.779104417947;11048.834267485994;11070.944645276802;39593.20813583741;39749.20501589952;39819.60180398188;40176.39735403971;40221.59778402208;3010.7892447528684;3055.3125546752026;3183.4906414973725;3214;3368.528406023159;27786.861065694746;27881.16356509308;28184.295392615142;28338.2915427116;28509.85745071282;2318.860868347888;2341.976580234193;2388.3551441110803;2405.290439320405;2487.179230853814;269077;269998.65000675066;270887;271722;272241;56743.432565674644;57764;59768;60258.698706507064;65944.67027664927;61856;62390;62609.373906261266;62683.05975410373;62798.37201628017;16946.152692365333;17153.228104735317;17153.228104735317;17160.914195428944;17169.828301717072;12879.871201288055;12998.220106793622;13026.218426894417;13033.218006919615;13040.413181406859;20416.387508374773;20705.89647051785;20709;20713.171473141207;20716.896415517826;8595.484270943763;8824.823503530022;8851.867221991675;8919.725470005107;8922.910770892207;904.6381447420953;1009.2380252909006;1081.9288903984998;1088.3415533602056;1123.8424422844482;27690.10831912895;27702.861485692443;27838;28388.148355549365;28422.573661395094;1018.8267994440963;1038.8130136575337;1068.8076146293743;1085.5006696919506;1168.9649310520697;14293.213873236864;14325.928370358082;14377;14454.277286135652;14479.92760036193;400567;410589;411010;412134;412288;53753;54351.72824135933;54352.45647543553;54374.728126359114;54444.727776360865;1156.9942150289362;1262.9684257893625;1360.7890776929592;1383.7094210215766;1401.2013152503382;30049.248768780082;30433.391332173676;30682;30693.693063069084;30991.535126973566;41440;48426;49502;49525.504744953534;49551.256731149784;198560;200480;200673;200999;276256;30590.84704576463;31446.21384465315;31488.69368716252;31527.36945261036;31527.369452611278;39026;39575.40636890391;39662.2067558653;39986.400203997546;40195.79902100588;34213;34451.65548344485;34635.13412164716;34737.13157171091;40186.598134018284;37707.43438848474;37758.62241377551;37989.81005094957;38412;38471.615283846804;38305.4254186193;38323.233535329695;38585.2282954345;38803.223935521695;38867.6113238864;33275.500867486524;33309.83345083259;33896.15259618529;33978;34045.27637789021;25216.621750674123;25305.240842774747;25551;25595.232143035737;25712.614310785728 08:52:10 INFO - 2015-11-11 08:52:10,010 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.79392906783835;332.2971914401042;337.62692225091257;340.88580325590925;344.8069081314464;14472.710545789078;15003.624909377271;17120.14399280037;17297.48107556772;18004.639907201865;14778.334974926127;16447.753283700753;18661.34685286015;19026.334078307264;19133.42599722007;5176.016556854204;5253.474652534745;5396.487333703292;5425.755840987145;5431.538319242869;3859.729818912663;3991.700622453313;4860;5340.786368545254;5362.0616392131415;5595.244641973342;5739.995500787367;5787.594868359217;5787.942120578782;5796.681182534959;5623.409541998113;5747.971260143672;5760.8271751847515;5779.682117483558;5785.913211301834;5010.2735103409805;5015.799368025275;5020.021095886304;5021.422536408323;5022.648414610942;21182.15271389158;21712.348629540982;22035;22064.779352206595;22068.88965555162;1890.7258447525032;1962.1170473286936;1963.7545306836646;1970.2513045042936;1975.5456245063572;13207.537736179283;13293.86706132936;13336.23818460009;13670.658233544242;13733.313334333343;1601.1673929556566;1613.9677206455922;1672.732362821955;1697.4313604942236;1708.8291170882812;58724.70637646827;59824.40175598232;59985;60470.395296047354;60483.39516604822;9317.860232096524;9521.238300936047;9734.805303893883;9743.9025609743;9810.656627018163;12121.090918181171;12140.878591214152;12141.332226727438;12144.878551214551;12156.209846359958;7526.360259377905;7551.433642476836;7605.847883042308;7738.883916741253;7813.02337207849;7815.921840781633;7826.334761545332;7849.450538462253;7860.606969651494;7883.0292426893275;5720.942790572041;5816.1566572846705;5818.156367326798;5823.912641310384;5851.678157701367;1545.4050190676671;1595.2582049346877;1602.2869822928685;1656.238130460002;1698.5901701587652;396.8789519196615;915.4141349536302;922.89386720528;937.4656445825814;940.7036783413203;9920.652777152765;10093.394396336244;10104.595816167272;10112.696619101438;10124.898751012395;366.78359767737163;405.22197381028496;415.9912212883745;455.19430607823966;467.15211890418783;6060.969635162033;6302.716377763011;6320.525960552977;6384.553081284358;6431.807045788634;379465;386189;506458;516881;522205;71946.28053719396;73777.6311118441;73832;73869;75114;469.3358897160548;485.19457700218175;487.1256095308929;487.28126014129583;487.97316147611514;10674.092702120406;11115.277506962022;11268.211225214156;11271.774564508827;11331.943340283246;33960.15099622529;34123.65876341205;34347.484787727706;34570.48144277788;34607.4808877862;46613.30080048734;46747.76626116848;46913;47361.763191183825;48475.27287090626;6281.152044473937;6346.809595712136;6350.269718982377;6362.013887847391;6370.490360771035;11674.941625292158;11868.525258989544;11974.880251197725;12039.699007524881;12154.574589889311;10179.84730229062;10188.388696678223;10386.42874641902;10507.737306567396;10524;10066.44634545107;10139.797204056025;10165.491725413553;10177.353887989027;10180.389176649425;8333.916660833314;8622.870656940026;9707.271954603291;10118.898811011795;10444;5899.823005309848;6193.783217587363;6195.783147589813;6196.411340922605;6230.59501132425;9879.654212102541;10143.7464063399;10164.136048435967;10191.94904025475;10209.642662506776 08:52:10 INFO - 2015-11-11 08:52:10,012 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1213.8422005139341;1697.1938329293587;1800.1089460716946;1815.0924537731134;1847.6581832361014;7222.638868056596;7514.286142816437;7811.140774514806;7920.247576480239;7942.682292708299;7854.293113619788;7909.644066017028;8004.839903201932;8006;8007.63965621547;1978.8021197880241;2048.7336646235967;2221.566794475078;2248.1344682297354;2252.831037672173;2231.3975226688785;2273.465735552144;2275.533515629292;2276.0326861084054;2280.498290376123;2210.5910406574753;2229.6544035674497;2278.6100478707976;2279.680844681746;2282.2924893283052;1940.4566721318054;2044.1414605865573;2176.379731776444;2191.1454532732246;2237.765034671352;2181.727284089489;2194.7695491973273;2200.460887082675;2201.625723626987;2204.041242059693;7997.680092796281;8069.677212911476;8078.596070196525;8080.838383232362;8081.151479094669;4819.734914579697;4888.266759985995;4895.902081958341;4898.338724272213;4906.362172917534;2819.675737290197;2880.971190288112;2911.7670586353042;2930.5311150216075;2933.325335172901;867.6509320041934;888.9733308000706;895.7536677413698;913.8674892140668;937.6765016069445;10364.11904988077;10498.737531561772;10518.631847885288;10530.47347632623;10546.419946902917;4137.420761093449;4206.663466922639;4312.504062032906;4323.292299541664;4330.437043184366;9045.140711632515;9067.09329067088;9121.635134594675;9148.405353651991;9162.496062716615;4820.975895120572;4850.272459131088;4911.9754401227765;4913.434954980152;4929.630277729185;4430.933535996963;4445.777711114431;4455.4876189238;4468.285074388083;4488.708233964847;3683;3753.5871054184017;3762.473253744478;3776.4712940188397;3786.6213378662464;1218.5795900414344;1230.0933552993004;1230.3786587773118;1237.6782036670531;1255.9811602825964;1076.2412499188054;1102.399192440122;1107.3909349857547;1238.504598160725;1346.0846624295573;7145;7268.45486588508;7698.884516732253;7708.614569271514;7801.375889928792;643.6395618453587;644.2140588482044;651.9511036672269;673.5655502201053;679.3614002837317;5821.214136091573;5890.234269545017;5928;6016.819495415145;6023.578349515579;9162.312826538036;9304.581293841658;9374.671886484077;9394.342396032349;9497.477638729799;9250.121238482334;9340.673076442292;9390.295727820441;9414.623415063457;9427.670031549;7185.784426467214;7351.375133113638;7428.591427471541;7460.85078298431;7464.552126872405;7193.280671932974;7225.530340527849;7254.274572542915;7257.745978890925;7273.818154546178;8208.548529830916;8258.463199891989;8284;8303.6678532858;8310.293625041939;8355.832883342178;8536.658533658832;8696.78258043554;8712.172343627346;8726.781830454289;6935.930640693528;6962.1297337832775;6988.6505674715045;7032.894506582303;7033.191183013814;7558.811029724301;7620.80947976305;7624.542527448149;7634.312911837961;7637;7005.0893383859775;7058.54119482232;7117.43060555144;7250.673719682522;7263.527870688388;6937.549059311129;6950.131233595801;6953.061336719478;7029.507934444539;7104.360607545345;7076.150861896605;7097.7160913562875;7132.393746531396;7163.785086447415;7168.4265258780215;6492.285848556749;6507.349265073455;6575.967120164369;6576.112224849584;6587.176602924635;6292.937070629235;6588.176477940257;6635.369639884203;6649.035889795856;6650.235222949229 08:52:10 INFO - 2015-11-11 08:52:10,014 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.94015226878486;306.0527666871033;321.06249750727886;331.9468884978404;334.9581302337208;6103.7182191739785;6112.755489780415;6118.265808103023;6145.416185462385;6150.169727086842;5793.4785869271755;5914.733836977335;5931.466168044875;6052.546059045567;6074.301455332638;4753.287006948968;4770.950390913993;4775.379200703904;4776.832810851621;4804.639652026094;4568.497465278817;4772.403449568804;4788.138135135674;4790.041991601676;4791.185498465252;4620.376249206348;4625.5836974672275;4678.508756580561;4704.976475117637;4720.740359280238;4696.483386827446;4701.059788042371;4707.576318131368;4719;4724.031573527419;4072.9592704073175;4082.9795851020854;4096.9795151024355;4099.323611604082;4120.196561670476;5838.12428135783;5856.795012174596;5857.092150716646;5868.2664666916635;5891.941080589182;5154.175331946871;5168.612354073422;5170.121079416508;5173.482651734834;5174.896502069938;6364.363563643645;6368.77709280173;6378.107065010902;6382.521310901655;6389.105525226472;4230.386593943861;4232.259354612961;4236.894077648052;4237.300845360512;4241.066965267636;6563.146790917151;6591.176102987127;6636.8672626547195;6640;6645.534812563123;4344.087741574242;4364.585364390377;4375.234333991539;4376.474823021194;4381.18947994622;4434.0245146068455;4435.445569303837;4442.267025940748;4463.196624607537;4480.820767169342;5183.2743415921805;5196.45437229093;5198.636095473356;5200.2199670049795;5207.192885102815;6220.813375598649;6316.526260530479;6330;6340.239171299381;6398.232212134573;1574.0241050548734;1594.186964648038;1594.4658539389434;1594.9681006379808;1596.4173076826874;1000.3347773730533;1008.9899101009042;1010.4139599032543;1020.73460900165;1021.7547788530848;6064.4845188158615;6065.332813390523;6071.939280607226;6078.513718902477;6079.544034197453;6518.478521718251;6681.732730690718;6690.163729533809;6708.463322934153;6709.194896612437;6047.15339852421;6066.817995460143;6109.14471973924;6135.601185922901;6175.814725558151;3611.6930060945115;3692.51997240357;3702.629737026276;3703.2963736889906;3707.5180226570915;6584.012398140221;6837.555558888656;6844.794656160323;6848.623325717133;6853.931460685429;6781.287964763727;6802.965985170043;6806.55757375769;6808.523403361816;6893.75871844493;6881.724731010803;6899.793006209822;6910.689018994158;6918.515703900679;6940.167179938439;6604.438622717123;6730.25967143604;6752.189737231563;6773.458123350219;6789.4568434524135;6573.046908198189;6573.57271777333;6578.276389597237;6581.736730530725;6599.67001649906;6826.590404575742;6840.760573379908;6853.554518956252;6860.622665753432;6862.382385585322;4366.170427618742;4427.800748966369;4430.313301438282;4436.933445998248;4438.533953934791;6535.183102112236;6612.0743095965645;6662.167229096363;6681.997700344987;6687.230968438692;6478.773242936474;6492.123563318892;6500.5449618526245;6508.739650413931;6512.446442052478;6408.9038664421005;6505.837354066186;6514.315996820265;6524;6549.967250163719;6340.873182536416;6342.016987366781;6342.746290148342;6358.809235722936;6369.20384951881;6486.772962946275;6487.870242595216;6501.609903405811;6503.642299673564;6508.544401891822;6170.3212646607935;6376.39424254695;6396.808095757135;6397.168368112116;6401.167848179894 08:52:10 INFO - 2015-11-11 08:52:10,017 DEBUG : BROWSER_OUTPUT: |5;yui.html;686.8900975843866;751.4364226829878;770.4221833624778;794.4399198565012;841.0496139362522;13392.732145357088;13805.792913106287;13815.65460863479;13816.654583635414;13829.792553111698;12572.874271257284;13027.869721302784;13034.804477932816;13057.347132643354;13078.019148563872;716.2694052066888;725.408791834653;897.4794619120911;916.3539704508306;916.5234078279291;892.6027917576681;897.6723495923974;908.7500937242278;911.731039343392;911.9817603647956;924.4638109896244;948.0188005414398;948.2414068745011;948.7059011706393;949.933504654671;749.052448652455;757.0650246945046;916.7891384981492;928.4939707859232;936.7564433247405;684.9828754281133;692.3388164303078;696.5994553131919;697.0833354139342;697.2051860878603;13503.12229705066;13653.795193072112;13655.180689158682;13655.248961307125;13707.383167757474;11561.768764624745;11685.474153663106;11741;11926.403679816061;11969.601645745297;9421.38760980534;9542.761430964212;9561.330706850524;9680.854787178198;10101.848472272923;3324.7173990210863;3422.0418282880833;3425.9828700856337;3437.7937323760652;3440;47038.29442558364;47075.76462117702;47826.28260576094;47883.52116478825;48094;8951.641934322553;8981.236594889377;9084.091590840862;9121.361504694607;9132.406393584395;18906.243750249836;18928.81071189298;18937.715934260996;18942.337018204296;18962.52593685169;6950.687219075154;7036.050133231948;7088.822779430556;7122.465815063891;7222.349988501061;3778.5843557208686;3800.657940785343;3813.3707938189887;3820.6943444524372;3930.8231129599235;2966.0805150403444;2997.985010074936;3003.3692924485667;3003.5494675798805;3010.4731671957757;415.08680902015084;419.09057345560205;419.5762280097124;435.80388825028865;437.58210908582225;544.8174861421389;555.8526990347561;558.9157035351486;606.3269770554681;610.8075956073823;7458.32875041238;7575.507592006502;7664.6934122635585;7903.170167132484;7904.28861402465;475.9690620109682;508.4635709326696;509.35566508366946;528.5348892974158;582.5397935630889;3477.3045390921916;3501.2122272488486;3529.94705079424;3622.3660859349507;3729.533808273966;57795.71102144462;58198.709006454694;58276.41723582795;58310.416895831346;58464.707676461345;49763;50063;50292.74853625709;50445.747771261646;50740.74629626902;44657.77671111689;44800;46003;46281.30578041332;46938.76530617393;7656.846863062819;7671.2712292332135;7694.730684426018;7760.961195194213;7789.844203116019;34735.652643473244;35162;35201.1199720009;35261.29477410386;35949.64050359463;44518.777406112764;44941.77529112333;45206.77396612996;46538.301925471824;46640;6849.1438570178725;7289.562626242442;7339.119305683352;7462.8507429850015;7840.725574604861;10957.56169753201;11122.110231181325;11197.44012799373;11789.404231709412;11849.703757406134;10540.367577945348;10788.298760580537;10791.514381852678;10829.620963266563;10945.562177512811;10749.677509674722;10874.130069594255;10885.23803333759;10998.780024399628;11077.390743509184;10337.844932326172;10365.429901355497;10469.31949423285;10656.62701805433;10670.62652807148;9072.319576031692;9182.449053056838;9197.402168859002;9211.170994610517;9537.189338906272;8788.736337909873;9054.63781448761;9224.077592240723;9283.257339412965;9460.668876589287 08:52:10 INFO - 2015-11-11 08:52:10,017 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:10 INFO - 2015-11-11 08:52:10,017 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:52:10 INFO - 2015-11-11 08:52:10,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1643 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: __startTimestamp1447260730002__endTimestamp 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:52:10 INFO - 2015-11-11 08:52:10,018 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,019 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5482.82 Median:5648.07 stddev:594.78 (10.5%) stddev-sans-first:567.45 08:52:10 INFO - 2015-11-11 08:52:10,019 DEBUG : BROWSER_OUTPUT: Values: 3137.9 3203.4 3220.6 3230.5 3254.5 5211.8 5334.9 5381.5 5438.4 5526.2 5425.3 5463.0 5476.5 5491.5 5641.3 5035.1 5087.0 5091.2 5176.2 5189.2 5202.5 5230.8 5234.6 5256.2 5276.8 4933.8 5015.1 5017.8 5039.7 5208.8 5008.4 5143.9 5167.6 5171.1 5176.0 5119.8 5132.3 5134.3 5158.1 5162.2 5152.8 5272.4 5290.9 5450.1 5452.2 5871.0 5941.6 5942.6 5948.8 6013.0 5996.8 6052.3 6060.7 6060.9 6063.1 5459.5 5563.0 5574.6 5595.1 5598.4 5880.8 6061.4 6063.1 6070.5 6071.5 5840.8 5864.0 5876.6 5882.8 5883.1 5739.8 5868.9 5884.6 6004.0 6007.2 5699.1 5745.1 5755.7 5775.4 5800.5 5864.9 5877.0 5912.1 5915.7 5925.2 4447.2 4517.4 4527.1 4529.2 4544.0 4074.7 4080.3 4113.6 4124.3 4148.0 5521.5 5530.4 5546.6 5547.4 5548.0 5801.7 5905.4 5914.6 5977.0 5980.6 5401.1 5450.7 5461.4 5476.2 5482.8 5243.8 5254.0 5263.0 5269.2 5309.6 5911.6 5970.7 6057.7 6077.3 6147.3 5747.4 5823.5 5862.3 5875.3 5896.4 5950.9 5969.2 5972.9 6029.0 6050.6 5672.4 5773.9 5805.6 5818.4 5844.9 5750.2 5780.5 5783.2 5784.5 5819.3 5742.9 5812.8 5834.4 5869.2 5874.6 5646.9 5761.5 5811.8 5837.9 5889.8 5599.6 5612.6 5640.8 5644.8 5671.4 5547.5 5590.9 5718.3 5719.6 5766.1 5648.1 5674.5 5679.1 5727.4 5741.7 08:52:10 INFO - 2015-11-11 08:52:10,019 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,019 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47310.08 Median:31467.45 stddev:81518.27 (259.1%) stddev-sans-first:81671.35 08:52:10 INFO - 2015-11-11 08:52:10,020 DEBUG : BROWSER_OUTPUT: Values: 553.2 553.9 566.1 569.2 573.7 31277.8 32031.0 38670.8 39095.4 39178.0 42116.0 42460.0 42484.2 42609.4 42716.0 7441.3 9202.1 9357.7 9383.2 9385.1 8401.6 11171.3 11398.7 11405.2 11429.0 10972.2 11187.3 11210.8 11263.1 11273.7 8582.2 8639.7 11064.9 11157.4 11252.1 10756.3 10934.5 11044.8 11048.8 11070.9 39593.2 39749.2 39819.6 40176.4 40221.6 3010.8 3055.3 3183.5 3214.0 3368.5 27786.9 27881.2 28184.3 28338.3 28509.9 2318.9 2342.0 2388.4 2405.3 2487.2 269077.0 269998.7 270887.0 271722.0 272241.0 56743.4 57764.0 59768.0 60258.7 65944.7 61856.0 62390.0 62609.4 62683.1 62798.4 16946.2 17153.2 17153.2 17160.9 17169.8 12879.9 12998.2 13026.2 13033.2 13040.4 20416.4 20705.9 20709.0 20713.2 20716.9 8595.5 8824.8 8851.9 8919.7 8922.9 904.6 1009.2 1081.9 1088.3 1123.8 27690.1 27702.9 27838.0 28388.1 28422.6 1018.8 1038.8 1068.8 1085.5 1169.0 14293.2 14325.9 14377.0 14454.3 14479.9 400567.0 410589.0 411010.0 412134.0 412288.0 53753.0 54351.7 54352.5 54374.7 54444.7 1157.0 1263.0 1360.8 1383.7 1401.2 30049.2 30433.4 30682.0 30693.7 30991.5 41440.0 48426.0 49502.0 49525.5 49551.3 198560.0 200480.0 200673.0 200999.0 276256.0 30590.8 31446.2 31488.7 31527.4 31527.4 39026.0 39575.4 39662.2 39986.4 40195.8 34213.0 34451.7 34635.1 34737.1 40186.6 37707.4 37758.6 37989.8 38412.0 38471.6 38305.4 38323.2 38585.2 38803.2 38867.6 33275.5 33309.8 33896.2 33978.0 34045.3 25216.6 25305.2 25551.0 25595.2 25712.6 08:52:10 INFO - 2015-11-11 08:52:10,020 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,021 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25431.09 Median:23607.46 stddev:76538.64 (324.2%) stddev-sans-first:76730.15 08:52:10 INFO - 2015-11-11 08:52:10,022 DEBUG : BROWSER_OUTPUT: Values: 331.8 332.3 337.6 340.9 344.8 14472.7 15003.6 17120.1 17297.5 18004.6 14778.3 16447.8 18661.3 19026.3 19133.4 5176.0 5253.5 5396.5 5425.8 5431.5 3859.7 3991.7 4860.0 5340.8 5362.1 5595.2 5740.0 5787.6 5787.9 5796.7 5623.4 5748.0 5760.8 5779.7 5785.9 5010.3 5015.8 5020.0 5021.4 5022.6 21182.2 21712.3 22035.0 22064.8 22068.9 1890.7 1962.1 1963.8 1970.3 1975.5 13207.5 13293.9 13336.2 13670.7 13733.3 1601.2 1614.0 1672.7 1697.4 1708.8 58724.7 59824.4 59985.0 60470.4 60483.4 9317.9 9521.2 9734.8 9743.9 9810.7 12121.1 12140.9 12141.3 12144.9 12156.2 7526.4 7551.4 7605.8 7738.9 7813.0 7815.9 7826.3 7849.5 7860.6 7883.0 5720.9 5816.2 5818.2 5823.9 5851.7 1545.4 1595.3 1602.3 1656.2 1698.6 396.9 915.4 922.9 937.5 940.7 9920.7 10093.4 10104.6 10112.7 10124.9 366.8 405.2 416.0 455.2 467.2 6061.0 6302.7 6320.5 6384.6 6431.8 379465.0 386189.0 506458.0 516881.0 522205.0 71946.3 73777.6 73832.0 73869.0 75114.0 469.3 485.2 487.1 487.3 488.0 10674.1 11115.3 11268.2 11271.8 11331.9 33960.2 34123.7 34347.5 34570.5 34607.5 46613.3 46747.8 46913.0 47361.8 48475.3 6281.2 6346.8 6350.3 6362.0 6370.5 11674.9 11868.5 11974.9 12039.7 12154.6 10179.8 10188.4 10386.4 10507.7 10524.0 10066.4 10139.8 10165.5 10177.4 10180.4 8333.9 8622.9 9707.3 10118.9 10444.0 5899.8 6193.8 6195.8 6196.4 6230.6 9879.7 10143.7 10164.1 10191.9 10209.6 08:52:10 INFO - 2015-11-11 08:52:10,022 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,022 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5492.06 Median:6642.20 stddev:2865.51 (43.1%) stddev-sans-first:2855.50 08:52:10 INFO - 2015-11-11 08:52:10,023 DEBUG : BROWSER_OUTPUT: Values: 1213.8 1697.2 1800.1 1815.1 1847.7 7222.6 7514.3 7811.1 7920.2 7942.7 7854.3 7909.6 8004.8 8006.0 8007.6 1978.8 2048.7 2221.6 2248.1 2252.8 2231.4 2273.5 2275.5 2276.0 2280.5 2210.6 2229.7 2278.6 2279.7 2282.3 1940.5 2044.1 2176.4 2191.1 2237.8 2181.7 2194.8 2200.5 2201.6 2204.0 7997.7 8069.7 8078.6 8080.8 8081.2 4819.7 4888.3 4895.9 4898.3 4906.4 2819.7 2881.0 2911.8 2930.5 2933.3 867.7 889.0 895.8 913.9 937.7 10364.1 10498.7 10518.6 10530.5 10546.4 4137.4 4206.7 4312.5 4323.3 4330.4 9045.1 9067.1 9121.6 9148.4 9162.5 4821.0 4850.3 4912.0 4913.4 4929.6 4430.9 4445.8 4455.5 4468.3 4488.7 3683.0 3753.6 3762.5 3776.5 3786.6 1218.6 1230.1 1230.4 1237.7 1256.0 1076.2 1102.4 1107.4 1238.5 1346.1 7145.0 7268.5 7698.9 7708.6 7801.4 643.6 644.2 652.0 673.6 679.4 5821.2 5890.2 5928.0 6016.8 6023.6 9162.3 9304.6 9374.7 9394.3 9497.5 9250.1 9340.7 9390.3 9414.6 9427.7 7185.8 7351.4 7428.6 7460.9 7464.6 7193.3 7225.5 7254.3 7257.7 7273.8 8208.5 8258.5 8284.0 8303.7 8310.3 8355.8 8536.7 8696.8 8712.2 8726.8 6935.9 6962.1 6988.7 7032.9 7033.2 7558.8 7620.8 7624.5 7634.3 7637.0 7005.1 7058.5 7117.4 7250.7 7263.5 6937.5 6950.1 6953.1 7029.5 7104.4 7076.2 7097.7 7132.4 7163.8 7168.4 6492.3 6507.3 6576.0 6576.1 6587.2 6292.9 6588.2 6635.4 6649.0 6650.2 08:52:10 INFO - 2015-11-11 08:52:10,023 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,023 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5362.40 Median:6079.03 stddev:1635.77 (26.9%) stddev-sans-first:1595.47 08:52:10 INFO - 2015-11-11 08:52:10,024 DEBUG : BROWSER_OUTPUT: Values: 291.9 306.1 321.1 331.9 335.0 6103.7 6112.8 6118.3 6145.4 6150.2 5793.5 5914.7 5931.5 6052.5 6074.3 4753.3 4771.0 4775.4 4776.8 4804.6 4568.5 4772.4 4788.1 4790.0 4791.2 4620.4 4625.6 4678.5 4705.0 4720.7 4696.5 4701.1 4707.6 4719.0 4724.0 4073.0 4083.0 4097.0 4099.3 4120.2 5838.1 5856.8 5857.1 5868.3 5891.9 5154.2 5168.6 5170.1 5173.5 5174.9 6364.4 6368.8 6378.1 6382.5 6389.1 4230.4 4232.3 4236.9 4237.3 4241.1 6563.1 6591.2 6636.9 6640.0 6645.5 4344.1 4364.6 4375.2 4376.5 4381.2 4434.0 4435.4 4442.3 4463.2 4480.8 5183.3 5196.5 5198.6 5200.2 5207.2 6220.8 6316.5 6330.0 6340.2 6398.2 1574.0 1594.2 1594.5 1595.0 1596.4 1000.3 1009.0 1010.4 1020.7 1021.8 6064.5 6065.3 6071.9 6078.5 6079.5 6518.5 6681.7 6690.2 6708.5 6709.2 6047.2 6066.8 6109.1 6135.6 6175.8 3611.7 3692.5 3702.6 3703.3 3707.5 6584.0 6837.6 6844.8 6848.6 6853.9 6781.3 6803.0 6806.6 6808.5 6893.8 6881.7 6899.8 6910.7 6918.5 6940.2 6604.4 6730.3 6752.2 6773.5 6789.5 6573.0 6573.6 6578.3 6581.7 6599.7 6826.6 6840.8 6853.6 6860.6 6862.4 4366.2 4427.8 4430.3 4436.9 4438.5 6535.2 6612.1 6662.2 6682.0 6687.2 6478.8 6492.1 6500.5 6508.7 6512.4 6408.9 6505.8 6514.3 6524.0 6550.0 6340.9 6342.0 6342.7 6358.8 6369.2 6486.8 6487.9 6501.6 6503.6 6508.5 6170.3 6376.4 6396.8 6397.2 6401.2 08:52:10 INFO - 2015-11-11 08:52:10,025 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,025 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13459.46 Median:47988.76 stddev:16036.73 (33.4%) stddev-sans-first:16053.03 08:52:10 INFO - 2015-11-11 08:52:10,026 DEBUG : BROWSER_OUTPUT: Values: 686.9 751.4 770.4 794.4 841.0 13392.7 13805.8 13815.7 13816.7 13829.8 12572.9 13027.9 13034.8 13057.3 13078.0 716.3 725.4 897.5 916.4 916.5 892.6 897.7 908.8 911.7 912.0 924.5 948.0 948.2 948.7 949.9 749.1 757.1 916.8 928.5 936.8 685.0 692.3 696.6 697.1 697.2 13503.1 13653.8 13655.2 13655.2 13707.4 11561.8 11685.5 11741.0 11926.4 11969.6 9421.4 9542.8 9561.3 9680.9 10101.8 3324.7 3422.0 3426.0 3437.8 3440.0 47038.3 47075.8 47826.3 47883.5 48094.0 8951.6 8981.2 9084.1 9121.4 9132.4 18906.2 18928.8 18937.7 18942.3 18962.5 6950.7 7036.1 7088.8 7122.5 7222.3 3778.6 3800.7 3813.4 3820.7 3930.8 2966.1 2998.0 3003.4 3003.5 3010.5 415.1 419.1 419.6 435.8 437.6 544.8 555.9 558.9 606.3 610.8 7458.3 7575.5 7664.7 7903.2 7904.3 476.0 508.5 509.4 528.5 582.5 3477.3 3501.2 3529.9 3622.4 3729.5 57795.7 58198.7 58276.4 58310.4 58464.7 49763.0 50063.0 50292.7 50445.7 50740.7 44657.8 44800.0 46003.0 46281.3 46938.8 7656.8 7671.3 7694.7 7761.0 7789.8 34735.7 35162.0 35201.1 35261.3 35949.6 44518.8 44941.8 45206.8 46538.3 46640.0 6849.1 7289.6 7339.1 7462.9 7840.7 10957.6 11122.1 11197.4 11789.4 11849.7 10540.4 10788.3 10791.5 10829.6 10945.6 10749.7 10874.1 10885.2 10998.8 11077.4 10337.8 10365.4 10469.3 10656.6 10670.6 9072.3 9182.4 9197.4 9211.2 9537.2 8788.7 9054.6 9224.1 9283.3 9460.7 08:52:10 INFO - 2015-11-11 08:52:10,027 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:10 INFO - 2015-11-11 08:52:10,027 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-11 08:52:10,662 INFO : Browser exited with error code: 0 08:52:10 INFO - 2015-11-11 08:52:10,689 INFO : Completed test dromaeo_css (00:18:35) 08:52:10 INFO - 2015-11-11 08:52:10,689 INFO : Starting test kraken 08:52:10 INFO - 2015-11-11 08:52:10,690 DEBUG : operating with platform_type : mac_ 08:52:10 INFO - 2015-11-11 08:52:10,690 INFO : Initialising browser for kraken test... 08:52:10 INFO - 2015-11-11 08:52:10,702 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmp51r9UJ/profile http://localhost:51099/getInfo.html 08:52:13 INFO - 2015-11-11 08:52:13,051 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:13 INFO - 2015-11-11 08:52:13,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:13 INFO - 2015-11-11 08:52:13,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:52:13 INFO - 2015-11-11 08:52:13,052 DEBUG : BROWSER_OUTPUT: __metrics 08:52:13 INFO - 2015-11-11 08:52:13,072 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:13 INFO - 2015-11-11 08:52:13,712 INFO : Browser initialized. 08:52:13 INFO - 2015-11-11 08:52:13,712 INFO : Running cycle 1/1 for kraken test... 08:52:13 INFO - 2015-11-11 08:52:13,712 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmp51r9UJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:25 INFO - 2015-11-11 08:52:25,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 228528128 08:52:25 INFO - 2015-11-11 08:52:25,745 DEBUG : BROWSER_OUTPUT: 08:52:28 INFO - 2015-11-11 08:52:28,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51099/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:28 INFO - 2015-11-11 08:52:28,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 285143040 08:52:28 INFO - 2015-11-11 08:52:28,884 DEBUG : BROWSER_OUTPUT: 08:52:31 INFO - 2015-11-11 08:52:31,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51099/tests/kraken/driver.html?testName=audio-dft) 08:52:32 INFO - 2015-11-11 08:52:32,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 299081728 08:52:32 INFO - 2015-11-11 08:52:32,128 DEBUG : BROWSER_OUTPUT: 08:52:35 INFO - 2015-11-11 08:52:35,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51099/tests/kraken/driver.html?testName=audio-fft) 08:52:35 INFO - 2015-11-11 08:52:35,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 283394048 08:52:35 INFO - 2015-11-11 08:52:35,676 DEBUG : BROWSER_OUTPUT: 08:52:37 INFO - 2015-11-11 08:52:37,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51099/tests/kraken/driver.html?testName=audio-oscillator) 08:52:38 INFO - 2015-11-11 08:52:38,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 283361280 08:52:38 INFO - 2015-11-11 08:52:38,259 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-11-11 08:52:40,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:41 INFO - 2015-11-11 08:52:41,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 285691904 08:52:41 INFO - 2015-11-11 08:52:41,053 DEBUG : BROWSER_OUTPUT: 08:52:44 INFO - 2015-11-11 08:52:44,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51099/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:44 INFO - 2015-11-11 08:52:44,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 284487680 08:52:44 INFO - 2015-11-11 08:52:44,680 DEBUG : BROWSER_OUTPUT: 08:52:47 INFO - 2015-11-11 08:52:47,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51099/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:48 INFO - 2015-11-11 08:52:48,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 285716480 08:52:48 INFO - 2015-11-11 08:52:48,414 DEBUG : BROWSER_OUTPUT: 08:52:51 INFO - 2015-11-11 08:52:51,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51099/tests/kraken/driver.html?testName=json-parse-financial) 08:52:51 INFO - 2015-11-11 08:52:51,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 286896128 08:52:51 INFO - 2015-11-11 08:52:51,875 DEBUG : BROWSER_OUTPUT: 08:52:53 INFO - 2015-11-11 08:52:53,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:54 INFO - 2015-11-11 08:52:54,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 318472192 08:52:54 INFO - 2015-11-11 08:52:54,021 DEBUG : BROWSER_OUTPUT: 08:52:55 INFO - 2015-11-11 08:52:55,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:56 INFO - 2015-11-11 08:52:56,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 319836160 08:52:56 INFO - 2015-11-11 08:52:56,464 DEBUG : BROWSER_OUTPUT: 08:52:58 INFO - 2015-11-11 08:52:58,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:59 INFO - 2015-11-11 08:52:59,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 327892992 08:52:59 INFO - 2015-11-11 08:52:59,142 DEBUG : BROWSER_OUTPUT: 08:53:01 INFO - 2015-11-11 08:53:01,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:02 INFO - 2015-11-11 08:53:02,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 328323072 08:53:02 INFO - 2015-11-11 08:53:02,297 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-11-11 08:53:04,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:05 INFO - 2015-11-11 08:53:05,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 328876032 08:53:05 INFO - 2015-11-11 08:53:05,478 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51099/tests/kraken/driver.html?testName=ai-astar) 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 387653632 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;107;104;108;107;107;107;107;101;109 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;131;152;165;128;151;149;126;165;128 08:53:07 INFO - 2015-11-11 08:53:07,478 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;162;163;162;163;163;164;161 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;76;83;84;67;69;70;81;83;66 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;95;142;90;89;90;134;89;88;136 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;116;114;114;120;114;120;119;115;115 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;125;124;125;124;125;124;125 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;101;101;100;101;101;101;100;100;99 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;58;59;60;59;59;69;58;58 08:53:07 INFO - 2015-11-11 08:53:07,479 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;67;66;66;66;68;67;68;68;68 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;87;88;87;89;89;87;87;87;87 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;125;123;126;130;123;136;120;131;126 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;141;153;152;154;139;155;153;150;142 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;70;71;72;71;71;73;71;73 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:53:07 INFO - 2015-11-11 08:53:07,480 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: __startTimestamp1447260787475__endTimestamp 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:53:07 INFO - 2015-11-11 08:53:07,481 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,483 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.50 Median:107.00 stddev:2.32 (2.2%) stddev-sans-first:2.40 08:53:07 INFO - 2015-11-11 08:53:07,483 DEBUG : BROWSER_OUTPUT: Values: 108.0 107.0 104.0 108.0 107.0 107.0 107.0 107.0 101.0 109.0 08:53:07 INFO - 2015-11-11 08:53:07,483 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,484 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.50 stddev:15.74 (10.4%) stddev-sans-first:15.91 08:53:07 INFO - 2015-11-11 08:53:07,484 DEBUG : BROWSER_OUTPUT: Values: 159.0 131.0 152.0 165.0 128.0 151.0 149.0 126.0 165.0 128.0 08:53:07 INFO - 2015-11-11 08:53:07,484 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,484 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 08:53:07 INFO - 2015-11-11 08:53:07,484 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 162.0 163.0 162.0 163.0 163.0 164.0 161.0 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.70 Median:79.50 stddev:7.12 (9.0%) stddev-sans-first:7.50 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 83.0 84.0 67.0 69.0 70.0 81.0 83.0 66.0 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:89.50 stddev:22.57 (25.2%) stddev-sans-first:23.76 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 142.0 90.0 89.0 90.0 134.0 89.0 88.0 136.0 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,485 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.50 stddev:2.71 (2.3%) stddev-sans-first:2.60 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 114.0 114.0 120.0 114.0 120.0 119.0 115.0 115.0 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.70 Median:125.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 125.0 124.0 125.0 124.0 125.0 124.0 125.0 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.40 Median:101.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: Values: 100.0 101.0 101.0 100.0 101.0 101.0 101.0 100.0 100.0 99.0 08:53:07 INFO - 2015-11-11 08:53:07,486 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:3.33 (5.7%) stddev-sans-first:3.53 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 58.0 59.0 60.0 59.0 59.0 69.0 58.0 58.0 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.50 stddev:1.10 (1.6%) stddev-sans-first:0.93 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 66.0 66.0 66.0 68.0 67.0 68.0 68.0 68.0 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.50 stddev:1.14 (1.3%) stddev-sans-first:0.88 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: Values: 90.0 87.0 88.0 87.0 89.0 89.0 87.0 87.0 87.0 87.0 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,487 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:4.74 (3.7%) stddev-sans-first:4.90 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: Values: 130.0 125.0 123.0 126.0 130.0 123.0 136.0 120.0 131.0 126.0 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:152.50 stddev:5.96 (3.9%) stddev-sans-first:6.28 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: Values: 151.0 141.0 153.0 152.0 154.0 139.0 155.0 153.0 150.0 142.0 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:0.97 (1.4%) stddev-sans-first:1.01 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 71.0 72.0 71.0 71.0 73.0 71.0 73.0 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:07 INFO - 2015-11-11 08:53:07,488 DEBUG : BROWSER_OUTPUT: 08:53:08 INFO - 2015-11-11 08:53:08,112 INFO : Browser exited with error code: 0 08:53:08 INFO - 2015-11-11 08:53:08,162 INFO : Completed test kraken (00:00:57) 08:53:08 INFO - 2015-11-11 08:53:08,162 INFO : Starting test v8_7 08:53:08 INFO - 2015-11-11 08:53:08,162 DEBUG : operating with platform_type : mac_ 08:53:08 INFO - 2015-11-11 08:53:08,162 INFO : Initialising browser for v8_7 test... 08:53:08 INFO - 2015-11-11 08:53:08,175 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmp_p9UD6/profile http://localhost:51099/getInfo.html 08:53:10 INFO - 2015-11-11 08:53:10,599 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:53:10 INFO - 2015-11-11 08:53:10,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:53:10 INFO - 2015-11-11 08:53:10,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:53:10 INFO - 2015-11-11 08:53:10,599 DEBUG : BROWSER_OUTPUT: __metrics 08:53:10 INFO - 2015-11-11 08:53:10,615 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:53:11 INFO - 2015-11-11 08:53:11,311 INFO : Browser initialized. 08:53:11 INFO - 2015-11-11 08:53:11,311 INFO : Running cycle 1/1 for v8_7 test... 08:53:11 INFO - 2015-11-11 08:53:11,311 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmp_p9UD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:53:23 INFO - 2015-11-11 08:53:23,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 228601856 08:53:23 INFO - 2015-11-11 08:53:23,344 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-11-11 08:53:44,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51099/tests/v8_7/run.html (next: http://localhost:51099/tests/v8_7/run.html) 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 750006272 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:45 INFO - 2015-11-11 08:53:45,051 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:45 INFO - 2015-11-11 08:53:45,052 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 08:53:45 INFO - 2015-11-11 08:53:45,052 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.68865487780647 08:53:45 INFO - 2015-11-11 08:53:45,052 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.8390355164549 08:53:45 INFO - 2015-11-11 08:53:45,052 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 08:53:45 INFO - 2015-11-11 08:53:45,052 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1936.1702127659576 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: |5;Earley;934.5794392523364 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: |7;RegExp;29794.117647058825 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: |8;Splay;680.2721088435375 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5786.127167630058 08:53:45 INFO - 2015-11-11 08:53:45,053 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:45 INFO - 2015-11-11 08:53:45,054 DEBUG : BROWSER_OUTPUT: __startTimestamp1447260825050__endTimestamp 08:53:45 INFO - 2015-11-11 08:53:45,054 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,054 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:45 INFO - 2015-11-11 08:53:45,054 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:53:45 INFO - 2015-11-11 08:53:45,054 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,055 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: Values: 166.4 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.69 Median:198.69 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: Values: 198.7 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.84 Median:325.84 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: Values: 325.8 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: Values: 5758.6 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,056 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1936.17 Median:1936.17 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: Values: 1936.2 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: Values: 934.6 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: Values: 12268.3 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29794.12 Median:29794.12 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: Values: 29794.1 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:680.27 Median:680.27 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: Values: 680.3 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,057 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5786.13 Median:5786.13 stddev:0.00 (0.0%) 08:53:45 INFO - 2015-11-11 08:53:45,058 DEBUG : BROWSER_OUTPUT: Values: 5786.1 08:53:45 INFO - 2015-11-11 08:53:45,058 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:45 INFO - 2015-11-11 08:53:45,058 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-11-11 08:53:45,755 INFO : Browser exited with error code: 0 08:53:45 INFO - 2015-11-11 08:53:45,776 INFO : Completed test v8_7 (00:00:37) 08:53:46 INFO - 2015-11-11 08:53:46,173 INFO : Completed test suite (00:20:10) 08:53:46 INFO - 2015-11-11 08:53:46,173 DEBUG : Working with test: dromaeo_css 08:53:46 INFO - 2015-11-11 08:53:46,173 DEBUG : Generating results file: dromaeo_css 08:53:46 INFO - 2015-11-11 08:53:46,174 DEBUG : Working with test: kraken 08:53:46 INFO - 2015-11-11 08:53:46,174 DEBUG : Generating results file: kraken 08:53:46 INFO - 2015-11-11 08:53:46,174 INFO : javascript benchmark 08:53:46 INFO - 2015-11-11 08:53:46,174 DEBUG : Working with test: v8_7 08:53:46 INFO - 2015-11-11 08:53:46,175 DEBUG : Generating results file: v8_7 08:53:46 INFO - 2015-11-11 08:53:46,175 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:46 INFO - 2015-11-11 08:53:46,233 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 08:53:46 INFO - 2015-11-11 08:53:46,233 DEBUG : process_Request line: dromaeo_css 6813.06 graph.html#tests=[[72,63,55]] 08:53:46 INFO - 2015-11-11 08:53:46,233 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:46 INFO - 2015-11-11 08:53:46,261 DEBUG : process_Request line: kraken 1498.50 graph.html#tests=[[232,63,55]] 08:53:46 INFO - 2015-11-11 08:53:46,261 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:46 INFO - 2015-11-11 08:53:46,290 DEBUG : process_Request line: v8_7 18143.92 graph.html#tests=[[230,63,55]] 08:53:46 INFO - 2015-11-11 08:53:46,291 INFO : javascript benchmark 08:53:46 INFO - 2015-11-11 08:53:46,293 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [331.79392906783835, 332.2971914401042, 337.62692225091257, 340.88580325590925, 344.8069081314464, 14472.710545789078, 15003.624909377271, 17120.14399280037, 17297.48107556772, 18004.639907201865, 14778.334974926127, 16447.753283700753, 18661.34685286015, 19026.334078307264, 19133.42599722007, 5176.016556854204, 5253.474652534745, 5396.487333703292, 5425.755840987145, 5431.538319242869, 3859.729818912663, 3991.700622453313, 4860.0, 5340.786368545254, 5362.0616392131415, 5595.244641973342, 5739.995500787367, 5787.594868359217, 5787.942120578782, 5796.681182534959, 5623.409541998113, 5747.971260143672, 5760.8271751847515, 5779.682117483558, 5785.913211301834, 5010.2735103409805, 5015.799368025275, 5020.021095886304, 5021.422536408323, 5022.648414610942, 21182.15271389158, 21712.348629540982, 22035.0, 22064.779352206595, 22068.88965555162, 1890.7258447525032, 1962.1170473286936, 1963.7545306836646, 1970.2513045042936, 1975.5456245063572, 13207.537736179283, 13293.86706132936, 13336.23818460009, 13670.658233544242, 13733.313334333343, 1601.1673929556566, 1613.9677206455922, 1672.732362821955, 1697.4313604942236, 1708.8291170882812, 58724.70637646827, 59824.40175598232, 59985.0, 60470.395296047354, 60483.39516604822, 9317.860232096524, 9521.238300936047, 9734.805303893883, 9743.9025609743, 9810.656627018163, 12121.090918181171, 12140.878591214152, 12141.332226727438, 12144.878551214551, 12156.209846359958, 7526.360259377905, 7551.433642476836, 7605.847883042308, 7738.883916741253, 7813.02337207849, 7815.921840781633, 7826.334761545332, 7849.450538462253, 7860.606969651494, 7883.0292426893275, 5720.942790572041, 5816.1566572846705, 5818.156367326798, 5823.912641310384, 5851.678157701367, 1545.4050190676671, 1595.2582049346877, 1602.2869822928685, 1656.238130460002, 1698.5901701587652, 396.8789519196615, 915.4141349536302, 922.89386720528, 937.4656445825814, 940.7036783413203, 9920.652777152765, 10093.394396336244, 10104.595816167272, 10112.696619101438, 10124.898751012395, 366.78359767737163, 405.22197381028496, 415.9912212883745, 455.19430607823966, 467.15211890418783, 6060.969635162033, 6302.716377763011, 6320.525960552977, 6384.553081284358, 6431.807045788634, 379465.0, 386189.0, 506458.0, 516881.0, 522205.0, 71946.28053719396, 73777.6311118441, 73832.0, 73869.0, 75114.0, 469.3358897160548, 485.19457700218175, 487.1256095308929, 487.28126014129583, 487.97316147611514, 10674.092702120406, 11115.277506962022, 11268.211225214156, 11271.774564508827, 11331.943340283246, 33960.15099622529, 34123.65876341205, 34347.484787727706, 34570.48144277788, 34607.4808877862, 46613.30080048734, 46747.76626116848, 46913.0, 47361.763191183825, 48475.27287090626, 6281.152044473937, 6346.809595712136, 6350.269718982377, 6362.013887847391, 6370.490360771035, 11674.941625292158, 11868.525258989544, 11974.880251197725, 12039.699007524881, 12154.574589889311, 10179.84730229062, 10188.388696678223, 10386.42874641902, 10507.737306567396, 10524.0, 10066.44634545107, 10139.797204056025, 10165.491725413553, 10177.353887989027, 10180.389176649425, 8333.916660833314, 8622.870656940026, 9707.271954603291, 10118.898811011795, 10444.0, 5899.823005309848, 6193.783217587363, 6195.783147589813, 6196.411340922605, 6230.59501132425, 9879.654212102541, 10143.7464063399, 10164.136048435967, 10191.94904025475, 10209.642662506776], "dojo.html": [3137.8901738439154, 3203.4233837909196, 3220.5652236948004, 3230.4669729494635, 3254.495553189255, 5211.765470553824, 5334.91997620036, 5381.515663590276, 5438.428964958677, 5526.19870118833, 5425.3489581250205, 5462.972685136579, 5476.479734425223, 5491.450854914507, 5641.294838145232, 5035.118854200509, 5087.0, 5091.210862316347, 5176.171812509999, 5189.2475591039465, 5202.479752024805, 5230.790768369261, 5234.581233501311, 5256.237845512398, 5276.841694749163, 4933.827316043921, 5015.0972824891505, 5017.8243761468175, 5039.72281524516, 5208.8437346879655, 5008.424031236382, 5143.948560514385, 5167.560757335631, 5171.120909445403, 5176.0, 5119.795208191668, 5132.307138536287, 5134.306868572769, 5158.071547121516, 5162.174052151675, 5152.819651312224, 5272.393674727378, 5290.920636190422, 5450.127979523258, 5452.154915988028, 5870.97064514679, 5941.613795103304, 5942.554308426886, 5948.7620495180145, 6013.007853704134, 5996.820095397102, 6052.303985041688, 6060.72726727294, 6060.878782424371, 6063.090536419572, 5459.481349271813, 5562.972185139049, 5574.58190635704, 5595.104783234704, 5598.356189038232, 5880.764769409176, 6061.393860613904, 6063.060225665029, 6070.544709146831, 6071.453569178795, 5840.8247752567495, 5863.970680146572, 5876.559258055663, 5882.823515294548, 5883.117532370093, 5739.799107031234, 5868.911966320508, 5884.646921184657, 6004.039353703474, 6007.189029481052, 5699.116636921284, 5745.109508026263, 5755.6834374108985, 5775.364709881909, 5800.477956983892, 5864.882702345929, 5877.0, 5912.054071348563, 5915.70421478933, 5925.229720136354, 4447.155040542287, 4517.41273634432, 4527.117212143667, 4529.207388707029, 4544.023035047415, 4074.6536544394057, 4080.3063479208013, 4113.568075352105, 4124.257633625916, 4147.97926010368, 5521.5306698930235, 5530.446955304437, 5546.611737178439, 5547.44525547442, 5547.972260138754, 5801.6519008859605, 5905.350411454737, 5914.585978981516, 5977.0, 5980.641161530322, 5401.081816091274, 5450.672959622435, 5461.371942226695, 5476.205950137208, 5482.780688772485, 5243.790248390098, 5254.028004819121, 5263.0, 5269.1569348903995, 5309.5752339812725, 5911.586188966731, 5970.731317090655, 6057.727402266997, 6077.301110372364, 6147.323794382614, 5747.367789543064, 5823.505002074871, 5862.267216597926, 5875.294964604275, 5896.380880007538, 5950.940490595039, 5969.224000879858, 5972.910406343822, 6029.0, 6050.606710563799, 5672.376038635664, 5773.942260577341, 5805.564582656233, 5818.418158184148, 5844.853878653068, 5750.166225897138, 5780.479756821906, 5783.16144159103, 5784.5083167929515, 5819.330776960704, 5742.942570574408, 5812.82561523155, 5834.416558344132, 5869.207656966255, 5874.5887787854435, 5646.85882852932, 5761.5102716269585, 5811.79658711943, 5837.94162058374, 5889.823305300848, 5599.636023658449, 5612.579056570692, 5640.774369025357, 5644.8024319148635, 5671.404502527175, 5547.5007249347755, 5590.86022849432, 5718.25662663851, 5719.57103217252, 5766.1350797379055, 5648.068068768607, 5674.546036317167, 5679.062954612443, 5727.369989301257, 5741.684207368635], "mootools.html": [1213.8422005139341, 1697.1938329293587, 1800.1089460716946, 1815.0924537731134, 1847.6581832361014, 7222.638868056596, 7514.286142816437, 7811.140774514806, 7920.247576480239, 7942.682292708299, 7854.293113619788, 7909.644066017028, 8004.839903201932, 8006.0, 8007.63965621547, 1978.8021197880241, 2048.7336646235967, 2221.566794475078, 2248.1344682297354, 2252.831037672173, 2231.3975226688785, 2273.465735552144, 2275.533515629292, 2276.0326861084054, 2280.498290376123, 2210.5910406574753, 2229.6544035674497, 2278.6100478707976, 2279.680844681746, 2282.2924893283052, 1940.4566721318054, 2044.1414605865573, 2176.379731776444, 2191.1454532732246, 2237.765034671352, 2181.727284089489, 2194.7695491973273, 2200.460887082675, 2201.625723626987, 2204.041242059693, 7997.680092796281, 8069.677212911476, 8078.596070196525, 8080.838383232362, 8081.151479094669, 4819.734914579697, 4888.266759985995, 4895.902081958341, 4898.338724272213, 4906.362172917534, 2819.675737290197, 2880.971190288112, 2911.7670586353042, 2930.5311150216075, 2933.325335172901, 867.6509320041934, 888.9733308000706, 895.7536677413698, 913.8674892140668, 937.6765016069445, 10364.11904988077, 10498.737531561772, 10518.631847885288, 10530.47347632623, 10546.419946902917, 4137.420761093449, 4206.663466922639, 4312.504062032906, 4323.292299541664, 4330.437043184366, 9045.140711632515, 9067.09329067088, 9121.635134594675, 9148.405353651991, 9162.496062716615, 4820.975895120572, 4850.272459131088, 4911.9754401227765, 4913.434954980152, 4929.630277729185, 4430.933535996963, 4445.777711114431, 4455.4876189238, 4468.285074388083, 4488.708233964847, 3683.0, 3753.5871054184017, 3762.473253744478, 3776.4712940188397, 3786.6213378662464, 1218.5795900414344, 1230.0933552993004, 1230.3786587773118, 1237.6782036670531, 1255.9811602825964, 1076.2412499188054, 1102.399192440122, 1107.3909349857547, 1238.504598160725, 1346.0846624295573, 7145.0, 7268.45486588508, 7698.884516732253, 7708.614569271514, 7801.375889928792, 643.6395618453587, 644.2140588482044, 651.9511036672269, 673.5655502201053, 679.3614002837317, 5821.214136091573, 5890.234269545017, 5928.0, 6016.819495415145, 6023.578349515579, 9162.312826538036, 9304.581293841658, 9374.671886484077, 9394.342396032349, 9497.477638729799, 9250.121238482334, 9340.673076442292, 9390.295727820441, 9414.623415063457, 9427.670031549, 7185.784426467214, 7351.375133113638, 7428.591427471541, 7460.85078298431, 7464.552126872405, 7193.280671932974, 7225.530340527849, 7254.274572542915, 7257.745978890925, 7273.818154546178, 8208.548529830916, 8258.463199891989, 8284.0, 8303.6678532858, 8310.293625041939, 8355.832883342178, 8536.658533658832, 8696.78258043554, 8712.172343627346, 8726.781830454289, 6935.930640693528, 6962.1297337832775, 6988.6505674715045, 7032.894506582303, 7033.191183013814, 7558.811029724301, 7620.80947976305, 7624.542527448149, 7634.312911837961, 7637.0, 7005.0893383859775, 7058.54119482232, 7117.43060555144, 7250.673719682522, 7263.527870688388, 6937.549059311129, 6950.131233595801, 6953.061336719478, 7029.507934444539, 7104.360607545345, 7076.150861896605, 7097.7160913562875, 7132.393746531396, 7163.785086447415, 7168.4265258780215, 6492.285848556749, 6507.349265073455, 6575.967120164369, 6576.112224849584, 6587.176602924635, 6292.937070629235, 6588.176477940257, 6635.369639884203, 6649.035889795856, 6650.235222949229], "ext.html": [553.1509133480106, 553.8559974406654, 566.0744682444204, 569.2144840120638, 573.7131434282859, 31277.843610781943, 32031.0, 38670.80664596673, 39095.41356879642, 39178.0, 42116.0, 42460.0, 42484.15031699364, 42609.360859587054, 42716.0, 7441.330280274774, 9202.125798049192, 9357.67248146315, 9383.155516003559, 9385.061493850628, 8401.621927013299, 11171.329720216812, 11398.658040258806, 11405.20163588549, 11429.0, 10972.23194376394, 11187.272827266203, 11210.831837522444, 11263.085275503143, 11273.718157046098, 8582.22759951601, 8639.697610583662, 11064.889351106507, 11157.386343751132, 11252.099832013419, 10756.300840445347, 10934.507947142398, 11044.779104417947, 11048.834267485994, 11070.944645276802, 39593.20813583741, 39749.20501589952, 39819.60180398188, 40176.39735403971, 40221.59778402208, 3010.7892447528684, 3055.3125546752026, 3183.4906414973725, 3214.0, 3368.528406023159, 27786.861065694746, 27881.16356509308, 28184.295392615142, 28338.2915427116, 28509.85745071282, 2318.860868347888, 2341.976580234193, 2388.3551441110803, 2405.290439320405, 2487.179230853814, 269077.0, 269998.65000675066, 270887.0, 271722.0, 272241.0, 56743.432565674644, 57764.0, 59768.0, 60258.698706507064, 65944.67027664927, 61856.0, 62390.0, 62609.373906261266, 62683.05975410373, 62798.37201628017, 16946.152692365333, 17153.228104735317, 17153.228104735317, 17160.914195428944, 17169.828301717072, 12879.871201288055, 12998.220106793622, 13026.218426894417, 13033.218006919615, 13040.413181406859, 20416.387508374773, 20705.89647051785, 20709.0, 20713.171473141207, 20716.896415517826, 8595.484270943763, 8824.823503530022, 8851.867221991675, 8919.725470005107, 8922.910770892207, 904.6381447420953, 1009.2380252909006, 1081.9288903984998, 1088.3415533602056, 1123.8424422844482, 27690.10831912895, 27702.861485692443, 27838.0, 28388.148355549365, 28422.573661395094, 1018.8267994440963, 1038.8130136575337, 1068.8076146293743, 1085.5006696919506, 1168.9649310520697, 14293.213873236864, 14325.928370358082, 14377.0, 14454.277286135652, 14479.92760036193, 400567.0, 410589.0, 411010.0, 412134.0, 412288.0, 53753.0, 54351.72824135933, 54352.45647543553, 54374.728126359114, 54444.727776360865, 1156.9942150289362, 1262.9684257893625, 1360.7890776929592, 1383.7094210215766, 1401.2013152503382, 30049.248768780082, 30433.391332173676, 30682.0, 30693.693063069084, 30991.535126973566, 41440.0, 48426.0, 49502.0, 49525.504744953534, 49551.256731149784, 198560.0, 200480.0, 200673.0, 200999.0, 276256.0, 30590.84704576463, 31446.21384465315, 31488.69368716252, 31527.36945261036, 31527.369452611278, 39026.0, 39575.40636890391, 39662.2067558653, 39986.400203997546, 40195.79902100588, 34213.0, 34451.65548344485, 34635.13412164716, 34737.13157171091, 40186.598134018284, 37707.43438848474, 37758.62241377551, 37989.81005094957, 38412.0, 38471.615283846804, 38305.4254186193, 38323.233535329695, 38585.2282954345, 38803.223935521695, 38867.6113238864, 33275.500867486524, 33309.83345083259, 33896.15259618529, 33978.0, 34045.27637789021, 25216.621750674123, 25305.240842774747, 25551.0, 25595.232143035737, 25712.614310785728], "prototype.html": [291.94015226878486, 306.0527666871033, 321.06249750727886, 331.9468884978404, 334.9581302337208, 6103.7182191739785, 6112.755489780415, 6118.265808103023, 6145.416185462385, 6150.169727086842, 5793.4785869271755, 5914.733836977335, 5931.466168044875, 6052.546059045567, 6074.301455332638, 4753.287006948968, 4770.950390913993, 4775.379200703904, 4776.832810851621, 4804.639652026094, 4568.497465278817, 4772.403449568804, 4788.138135135674, 4790.041991601676, 4791.185498465252, 4620.376249206348, 4625.5836974672275, 4678.508756580561, 4704.976475117637, 4720.740359280238, 4696.483386827446, 4701.059788042371, 4707.576318131368, 4719.0, 4724.031573527419, 4072.9592704073175, 4082.9795851020854, 4096.9795151024355, 4099.323611604082, 4120.196561670476, 5838.12428135783, 5856.795012174596, 5857.092150716646, 5868.2664666916635, 5891.941080589182, 5154.175331946871, 5168.612354073422, 5170.121079416508, 5173.482651734834, 5174.896502069938, 6364.363563643645, 6368.77709280173, 6378.107065010902, 6382.521310901655, 6389.105525226472, 4230.386593943861, 4232.259354612961, 4236.894077648052, 4237.300845360512, 4241.066965267636, 6563.146790917151, 6591.176102987127, 6636.8672626547195, 6640.0, 6645.534812563123, 4344.087741574242, 4364.585364390377, 4375.234333991539, 4376.474823021194, 4381.18947994622, 4434.0245146068455, 4435.445569303837, 4442.267025940748, 4463.196624607537, 4480.820767169342, 5183.2743415921805, 5196.45437229093, 5198.636095473356, 5200.2199670049795, 5207.192885102815, 6220.813375598649, 6316.526260530479, 6330.0, 6340.239171299381, 6398.232212134573, 1574.0241050548734, 1594.186964648038, 1594.4658539389434, 1594.9681006379808, 1596.4173076826874, 1000.3347773730533, 1008.9899101009042, 1010.4139599032543, 1020.73460900165, 1021.7547788530848, 6064.4845188158615, 6065.332813390523, 6071.939280607226, 6078.513718902477, 6079.544034197453, 6518.478521718251, 6681.732730690718, 6690.163729533809, 6708.463322934153, 6709.194896612437, 6047.15339852421, 6066.817995460143, 6109.14471973924, 6135.601185922901, 6175.814725558151, 3611.6930060945115, 3692.51997240357, 3702.629737026276, 3703.2963736889906, 3707.5180226570915, 6584.012398140221, 6837.555558888656, 6844.794656160323, 6848.623325717133, 6853.931460685429, 6781.287964763727, 6802.965985170043, 6806.55757375769, 6808.523403361816, 6893.75871844493, 6881.724731010803, 6899.793006209822, 6910.689018994158, 6918.515703900679, 6940.167179938439, 6604.438622717123, 6730.25967143604, 6752.189737231563, 6773.458123350219, 6789.4568434524135, 6573.046908198189, 6573.57271777333, 6578.276389597237, 6581.736730530725, 6599.67001649906, 6826.590404575742, 6840.760573379908, 6853.554518956252, 6860.622665753432, 6862.382385585322, 4366.170427618742, 4427.800748966369, 4430.313301438282, 4436.933445998248, 4438.533953934791, 6535.183102112236, 6612.0743095965645, 6662.167229096363, 6681.997700344987, 6687.230968438692, 6478.773242936474, 6492.123563318892, 6500.5449618526245, 6508.739650413931, 6512.446442052478, 6408.9038664421005, 6505.837354066186, 6514.315996820265, 6524.0, 6549.967250163719, 6340.873182536416, 6342.016987366781, 6342.746290148342, 6358.809235722936, 6369.20384951881, 6486.772962946275, 6487.870242595216, 6501.609903405811, 6503.642299673564, 6508.544401891822, 6170.3212646607935, 6376.39424254695, 6396.808095757135, 6397.168368112116, 6401.167848179894], "yui.html": [686.8900975843866, 751.4364226829878, 770.4221833624778, 794.4399198565012, 841.0496139362522, 13392.732145357088, 13805.792913106287, 13815.65460863479, 13816.654583635414, 13829.792553111698, 12572.874271257284, 13027.869721302784, 13034.804477932816, 13057.347132643354, 13078.019148563872, 716.2694052066888, 725.408791834653, 897.4794619120911, 916.3539704508306, 916.5234078279291, 892.6027917576681, 897.6723495923974, 908.7500937242278, 911.731039343392, 911.9817603647956, 924.4638109896244, 948.0188005414398, 948.2414068745011, 948.7059011706393, 949.933504654671, 749.052448652455, 757.0650246945046, 916.7891384981492, 928.4939707859232, 936.7564433247405, 684.9828754281133, 692.3388164303078, 696.5994553131919, 697.0833354139342, 697.2051860878603, 13503.12229705066, 13653.795193072112, 13655.180689158682, 13655.248961307125, 13707.383167757474, 11561.768764624745, 11685.474153663106, 11741.0, 11926.403679816061, 11969.601645745297, 9421.38760980534, 9542.761430964212, 9561.330706850524, 9680.854787178198, 10101.848472272923, 3324.7173990210863, 3422.0418282880833, 3425.9828700856337, 3437.7937323760652, 3440.0, 47038.29442558364, 47075.76462117702, 47826.28260576094, 47883.52116478825, 48094.0, 8951.641934322553, 8981.236594889377, 9084.091590840862, 9121.361504694607, 9132.406393584395, 18906.243750249836, 18928.81071189298, 18937.715934260996, 18942.337018204296, 18962.52593685169, 6950.687219075154, 7036.050133231948, 7088.822779430556, 7122.465815063891, 7222.349988501061, 3778.5843557208686, 3800.657940785343, 3813.3707938189887, 3820.6943444524372, 3930.8231129599235, 2966.0805150403444, 2997.985010074936, 3003.3692924485667, 3003.5494675798805, 3010.4731671957757, 415.08680902015084, 419.09057345560205, 419.5762280097124, 435.80388825028865, 437.58210908582225, 544.8174861421389, 555.8526990347561, 558.9157035351486, 606.3269770554681, 610.8075956073823, 7458.32875041238, 7575.507592006502, 7664.6934122635585, 7903.170167132484, 7904.28861402465, 475.9690620109682, 508.4635709326696, 509.35566508366946, 528.5348892974158, 582.5397935630889, 3477.3045390921916, 3501.2122272488486, 3529.94705079424, 3622.3660859349507, 3729.533808273966, 57795.71102144462, 58198.709006454694, 58276.41723582795, 58310.416895831346, 58464.707676461345, 49763.0, 50063.0, 50292.74853625709, 50445.747771261646, 50740.74629626902, 44657.77671111689, 44800.0, 46003.0, 46281.30578041332, 46938.76530617393, 7656.846863062819, 7671.2712292332135, 7694.730684426018, 7760.961195194213, 7789.844203116019, 34735.652643473244, 35162.0, 35201.1199720009, 35261.29477410386, 35949.64050359463, 44518.777406112764, 44941.77529112333, 45206.77396612996, 46538.301925471824, 46640.0, 6849.1438570178725, 7289.562626242442, 7339.119305683352, 7462.8507429850015, 7840.725574604861, 10957.56169753201, 11122.110231181325, 11197.44012799373, 11789.404231709412, 11849.703757406134, 10540.367577945348, 10788.298760580537, 10791.514381852678, 10829.620963266563, 10945.562177512811, 10749.677509674722, 10874.130069594255, 10885.23803333759, 10998.780024399628, 11077.390743509184, 10337.844932326172, 10365.429901355497, 10469.31949423285, 10656.62701805433, 10670.62652807148, 9072.319576031692, 9182.449053056838, 9197.402168859002, 9211.170994610517, 9537.189338906272, 8788.736337909873, 9054.63781448761, 9224.077592240723, 9283.257339412965, 9460.668876589287]}, "summary": {"lowerIsBetter": false, "suite": 6813.057901919571, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7580.052661382312, "unit": "ms", "value": 7580.052661382312}, "dojo.html": {"lowerIsBetter": false, "filtered": 5444.271067680327, "unit": "ms", "value": 5444.271067680327}, "mootools.html": {"lowerIsBetter": false, "filtered": 4443.17706022129, "unit": "ms", "value": 4443.17706022129}, "ext.html": {"lowerIsBetter": false, "filtered": 18865.452984894077, "unit": "ms", "value": 18865.452984894077}, "prototype.html": {"lowerIsBetter": false, "filtered": 4816.265583832225, "unit": "ms", "value": 4816.265583832225}, "yui.html": {"lowerIsBetter": false, "filtered": 6002.488720661747, "unit": "ms", "value": 6002.488720661747}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447259615, "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": "20151111071631", "branch": "Mozilla-Inbound", "revision": "af5c9cf6898b0e2931a809774387cad5953363c3"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 164.0, 161.0], "ai-astar": [108.0, 107.0, 104.0, 108.0, 107.0, 107.0, 107.0, 107.0, 101.0, 109.0], "imaging-gaussian-blur": [120.0, 116.0, 114.0, 114.0, 120.0, 114.0, 120.0, 119.0, 115.0, 115.0], "audio-beat-detection": [159.0, 131.0, 152.0, 165.0, 128.0, 151.0, 149.0, 126.0, 165.0, 128.0], "json-stringify-tinderbox": [65.0, 67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [151.0, 141.0, 153.0, 152.0, 154.0, 139.0, 155.0, 153.0, 150.0, 142.0], "json-parse-financial": [59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 69.0, 58.0, 58.0], "stanford-crypto-sha256-iterative": [71.0, 72.0, 70.0, 71.0, 72.0, 71.0, 71.0, 73.0, 71.0, 73.0], "audio-fft": [78.0, 76.0, 83.0, 84.0, 67.0, 69.0, 70.0, 81.0, 83.0, 66.0], "imaging-darkroom": [125.0, 125.0, 125.0, 125.0, 124.0, 125.0, 124.0, 125.0, 124.0, 125.0], "stanford-crypto-ccm": [130.0, 125.0, 123.0, 126.0, 130.0, 123.0, 136.0, 120.0, 131.0, 126.0], "audio-oscillator": [97.0, 95.0, 142.0, 90.0, 89.0, 90.0, 134.0, 89.0, 88.0, 136.0], "stanford-crypto-aes": [90.0, 87.0, 88.0, 87.0, 89.0, 89.0, 87.0, 87.0, 87.0, 87.0], "imaging-desaturate": [100.0, 101.0, 101.0, 100.0, 101.0, 101.0, 101.0, 100.0, 100.0, 99.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 75.7, "unit": "ms", "value": 75.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.0, "unit": "ms", "value": 149.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 127.0, "unit": "ms", "value": 127.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 124.7, "unit": "ms", "value": 124.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.7, "unit": "ms", "value": 59.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.0, "unit": "ms", "value": 105.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 106.5, "unit": "ms", "value": 106.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.2, "unit": "ms", "value": 162.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.5, "unit": "ms", "value": 71.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 116.7, "unit": "ms", "value": 116.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.8, "unit": "ms", "value": 87.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 100.4, "unit": "ms", "value": 100.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447259615, "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": "20151111071631", "branch": "Mozilla-Inbound", "revision": "af5c9cf6898b0e2931a809774387cad5953363c3"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.68865487780647], "Encrypt": [325.8390355164549], "NavierStokes": [5786.127167630058], "Decrypt": [5758.620689655172], "Splay": [680.2721088435375], "Richards": [166.41704110500916], "RegExp": [29794.117647058825], "Earley": [934.5794392523364], "Boyer": [12268.292682926829], "RayTrace": [1936.1702127659576]}, "summary": {"lowerIsBetter": false, "suite": 18143.9225185995, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 332.77189399999986, "unit": "score", "value": 332.77189399999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 816.9094890000002, "unit": "score", "value": 816.9094890000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 256.4755244755246, "unit": "score", "value": 256.4755244755246}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.22304790419163, "unit": "score", "value": 46.22304790419163}, "Splay": {"lowerIsBetter": false, "filtered": 119.79176999999999, "unit": "score", "value": 119.79176999999999}, "RegExp": {"lowerIsBetter": false, "filtered": 30.576001974333657, "unit": "score", "value": 30.576001974333657}, "Richards": {"lowerIsBetter": false, "filtered": 212.1297179999999, "unit": "score", "value": 212.1297179999999}, "Earley": {"lowerIsBetter": false, "filtered": 713.1154100000002, "unit": "score", "value": 713.1154100000002}, "Boyer": {"lowerIsBetter": false, "filtered": 54.32402186878729, "unit": "score", "value": 54.32402186878729}, "RayTrace": {"lowerIsBetter": false, "filtered": 382.19212087912075, "unit": "score", "value": 382.19212087912075}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447259615, "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": "20151111071631", "branch": "Mozilla-Inbound", "revision": "af5c9cf6898b0e2931a809774387cad5953363c3"}}] 08:53:46 INFO - RETURN: dromaeo_css: 6813.06 08:53:46 INFO - RETURN: kraken: 1498.50 08:53:46 INFO - RETURN: v8_7: 18143.92 08:53:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "18143.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1498.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6813.06"}}} 08:53:46 INFO - Return code: 0 08:53:46 INFO - # TBPL SUCCESS # 08:53:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:46 INFO - 2015-11-11 08:53:46.419 screenresolution[2552:24118] starting screenresolution argv=screenresolution get 08:53:46 INFO - 2015-11-11 08:53:46.422 screenresolution[2552:24118] Display 0: 1600x1200x32@60 08:53:46 INFO - 2015-11-11 08:53:46.429 screenresolution[2553:24122] starting screenresolution argv=screenresolution list 08:53:46 INFO - Available Modes on Display 0 08:53:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:46 INFO - Intel HD Graphics 3000: 08:53:46 INFO - Chipset Model: Intel HD Graphics 3000 08:53:46 INFO - Type: GPU 08:53:46 INFO - Bus: Built-In 08:53:46 INFO - VRAM (Total): 512 MB 08:53:46 INFO - VRAM (Dynamic, Max): 10 08:53:46 INFO - Vendor: Intel (0x8086) 08:53:46 INFO - Device ID: 0x0116 08:53:46 INFO - Revision ID: 0x0009 08:53:46 INFO - Displays: 08:53:46 INFO - Display: 08:53:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:46 INFO - Display Serial Number: 1600x1200 60 08:53:46 INFO - Main Display: Yes 08:53:46 INFO - Mirror: Off 08:53:46 INFO - Online: Yes 08:53:46 INFO - Rotation: Supported 08:53:46 INFO - Return code: 0 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - Running post-run listener: _resource_record_post_run 08:53:47 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 40960; Write bytes: 687119360; Read time: 51; Write time: 56248 08:53:47 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 336603648; Write bytes: 336234496; Read time: 30609; Write time: 9016 08:53:47 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 36864; Write bytes: 339690496; Read time: 42; Write time: 46586 08:53:47 INFO - Running post-run listener: _upload_blobber_files 08:53:47 INFO - Blob upload gear active. 08:53:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:53:47 INFO - Copying logs to upload dir... 08:53:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1294.335714 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2015-11-11 08:53:47.838924) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 08:53:47.842085) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010104 build_url: 'https://queue.taskcluster.net/v1/task/-BOtQRAHTUWi0SGAPzxVZg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 08:53:47.868237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:53:47.868575) ========= 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.RjiWtg1h2c/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.nRzCuvUAiW/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.005196 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:53:47.920015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 08:53:47.920350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 08:53:47.920813) ========= ========= Total master_lag: 0.23 =========