builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0041 starttime: 1447979653.67 results: success (0) buildid: 20151119135111 builduid: 96f7efb7a6704da0b5a50b9f3aff177e revision: 0920dee3c3036861bfe0f32342cdced4cabfb8df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.673719) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.674150) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.674451) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005894 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.694609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.694904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.709493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.709834) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005276 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.758254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.758580) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.758925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.759193) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 16:34:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-19 16:34:13 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.881554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.882074) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:13.933857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 16:34:13.934458) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0920dee3c3036861bfe0f32342cdced4cabfb8df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0920dee3c3036861bfe0f32342cdced4cabfb8df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 16:34:14,009 truncating revision to first 12 chars 2015-11-19 16:34:14,009 Setting DEBUG logging. 2015-11-19 16:34:14,009 attempt 1/10 2015-11-19 16:34:14,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0920dee3c303?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 16:34:14,966 unpacking tar archive at: fx-team-0920dee3c303/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196348 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 16:34:15.145174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:15.145520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:15.156305) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:15.156690) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 16:34:15.157161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 16:34:15.157486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:34:15 INFO - MultiFileLogger online at 20151119 16:34:15 in /builds/slave/test 16:34:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:34:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:15 INFO - {'append_to_log': False, 16:34:15 INFO - 'base_work_dir': '/builds/slave/test', 16:34:15 INFO - 'blob_upload_branch': 'Fx-Team', 16:34:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:15 INFO - 'branch': 'Fx-Team', 16:34:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:15 INFO - 'config_files': ('talos/mac_config.py',), 16:34:15 INFO - 'default_actions': ('clobber', 16:34:15 INFO - 'read-buildbot-config', 16:34:15 INFO - 'download-and-extract', 16:34:15 INFO - 'populate-webroot', 16:34:15 INFO - 'create-virtualenv', 16:34:15 INFO - 'install', 16:34:15 INFO - 'run-tests'), 16:34:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:15 INFO - 'download_minidump_stackwalk': True, 16:34:15 INFO - 'download_symbols': 'ondemand', 16:34:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:15 INFO - 'installer_path': 'installer.exe', 16:34:15 INFO - 'log_level': 'info', 16:34:15 INFO - 'log_name': 'talos', 16:34:15 INFO - 'log_to_console': True, 16:34:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:15 INFO - 'opt_config_files': (), 16:34:15 INFO - 'pip_index': False, 16:34:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:15 INFO - 'cmd': ('bash', 16:34:15 INFO - '-c', 16:34:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:15 INFO - 'enabled': True, 16:34:15 INFO - 'halt_on_failure': False, 16:34:15 INFO - 'name': 'check_screen_resolution'},), 16:34:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:15 INFO - 'cmd': ('bash', 16:34:15 INFO - '-c', 16:34:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:15 INFO - 'enabled': True, 16:34:15 INFO - 'halt_on_failure': False, 16:34:15 INFO - 'name': 'check_screen_resolution'},), 16:34:15 INFO - 'run_cmd_checks_enabled': True, 16:34:15 INFO - 'sps_profile': False, 16:34:15 INFO - 'sps_profile_interval': 0, 16:34:15 INFO - 'suite': 'dromaeojs', 16:34:15 INFO - 'system_bits': '64', 16:34:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:15 INFO - 'title': 't-yosemite-r7-0041', 16:34:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:15 INFO - 'use_talos_json': True, 16:34:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:15 INFO - 'work_dir': 'build'} 16:34:15 INFO - ##### 16:34:15 INFO - ##### Running clobber step. 16:34:15 INFO - ##### 16:34:15 INFO - Running pre-action listener: _resource_record_pre_action 16:34:15 INFO - Running main action method: clobber 16:34:15 INFO - rmtree: /builds/slave/test/build 16:34:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:16 INFO - Running post-action listener: _resource_record_post_action 16:34:16 INFO - ##### 16:34:16 INFO - ##### Running read-buildbot-config step. 16:34:16 INFO - ##### 16:34:16 INFO - Running pre-action listener: _resource_record_pre_action 16:34:16 INFO - Running main action method: read_buildbot_config 16:34:16 INFO - Using buildbot properties: 16:34:16 INFO - { 16:34:16 INFO - "properties": { 16:34:16 INFO - "buildnumber": 3, 16:34:16 INFO - "product": "firefox", 16:34:16 INFO - "script_repo_revision": "production", 16:34:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:34:16 INFO - "repository": "", 16:34:16 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:34:16 INFO - "buildid": "20151119135111", 16:34:16 INFO - "slavename": "t-yosemite-r7-0041", 16:34:16 INFO - "pgo_build": "False", 16:34:16 INFO - "basedir": "/builds/slave/test", 16:34:16 INFO - "project": "", 16:34:16 INFO - "platform": "yosemite_r7", 16:34:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:34:16 INFO - "slavebuilddir": "test", 16:34:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:34:16 INFO - "branch": "fx-team", 16:34:16 INFO - "repo_path": "integration/fx-team", 16:34:16 INFO - "stage_platform": "macosx64", 16:34:16 INFO - "builduid": "96f7efb7a6704da0b5a50b9f3aff177e", 16:34:16 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 16:34:16 INFO - }, 16:34:16 INFO - "sourcestamp": { 16:34:16 INFO - "repository": "", 16:34:16 INFO - "hasPatch": false, 16:34:16 INFO - "project": "", 16:34:16 INFO - "branch": "fx-team-macosx64-talos", 16:34:16 INFO - "changes": [ 16:34:16 INFO - { 16:34:16 INFO - "category": null, 16:34:16 INFO - "files": [ 16:34:16 INFO - { 16:34:16 INFO - "url": null, 16:34:16 INFO - "name": "https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:34:16 INFO - } 16:34:16 INFO - ], 16:34:16 INFO - "repository": "", 16:34:16 INFO - "rev": "3e7e43113775c7af1076908eb33b8664241c0af9", 16:34:16 INFO - "who": "mdeboer@mozilla.com", 16:34:16 INFO - "when": 1447973902, 16:34:16 INFO - "number": 6685564, 16:34:16 INFO - "comments": "No bug: Array.slice not supported by Chrome, which the link clicker doesn't like. Use Array.prototype.slice instead. rs=Standard8", 16:34:16 INFO - "project": "", 16:34:16 INFO - "at": "Thu 19 Nov 2015 14:58:22", 16:34:16 INFO - "branch": "fx-team-macosx64-talos", 16:34:16 INFO - "revlink": "", 16:34:16 INFO - "properties": [ 16:34:16 INFO - [ 16:34:16 INFO - "buildid", 16:34:16 INFO - "20151119131411", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "builduid", 16:34:16 INFO - "3e485fdec53b4a5fb7cdd2775c91ef0e", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "pgo_build", 16:34:16 INFO - "False", 16:34:16 INFO - "Change" 16:34:16 INFO - ] 16:34:16 INFO - ], 16:34:16 INFO - "revision": "3e7e43113775c7af1076908eb33b8664241c0af9" 16:34:16 INFO - }, 16:34:16 INFO - { 16:34:16 INFO - "category": null, 16:34:16 INFO - "files": [ 16:34:16 INFO - { 16:34:16 INFO - "url": null, 16:34:16 INFO - "name": "https://queue.taskcluster.net/v1/task/Fn3ioeCpRPWYg3F_fy_ePQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:34:16 INFO - } 16:34:16 INFO - ], 16:34:16 INFO - "repository": "", 16:34:16 INFO - "rev": "dd9778ba38d0c7dd4d3e6d22cc847a37240d8f9b", 16:34:16 INFO - "who": "mbanner@mozilla.com", 16:34:16 INFO - "when": 1447974809, 16:34:16 INFO - "number": 6685678, 16:34:16 INFO - "comments": "Bug 1226156 - Multiple requests and updates happening when opening a Loop room - make getAll handle multiple requests at a time. r=mikedeboer", 16:34:16 INFO - "project": "", 16:34:16 INFO - "at": "Thu 19 Nov 2015 15:13:29", 16:34:16 INFO - "branch": "fx-team-macosx64-talos", 16:34:16 INFO - "revlink": "", 16:34:16 INFO - "properties": [ 16:34:16 INFO - [ 16:34:16 INFO - "buildid", 16:34:16 INFO - "20151119133409", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "builduid", 16:34:16 INFO - "f0832a86410b4e7eac72d630cbc2da24", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "pgo_build", 16:34:16 INFO - "False", 16:34:16 INFO - "Change" 16:34:16 INFO - ] 16:34:16 INFO - ], 16:34:16 INFO - "revision": "dd9778ba38d0c7dd4d3e6d22cc847a37240d8f9b" 16:34:16 INFO - }, 16:34:16 INFO - { 16:34:16 INFO - "category": null, 16:34:16 INFO - "files": [ 16:34:16 INFO - { 16:34:16 INFO - "url": null, 16:34:16 INFO - "name": "https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:34:16 INFO - } 16:34:16 INFO - ], 16:34:16 INFO - "repository": "", 16:34:16 INFO - "rev": "0920dee3c3036861bfe0f32342cdced4cabfb8df", 16:34:16 INFO - "who": "mbrubeck@mozilla.com", 16:34:16 INFO - "when": 1447976940, 16:34:16 INFO - "number": 6685893, 16:34:16 INFO - "comments": "Bug 967982 - Show findbar after unsuccessful Find Again [r=mikedeboer]", 16:34:16 INFO - "project": "", 16:34:16 INFO - "at": "Thu 19 Nov 2015 15:49:00", 16:34:16 INFO - "branch": "fx-team-macosx64-talos", 16:34:16 INFO - "revlink": "", 16:34:16 INFO - "properties": [ 16:34:16 INFO - [ 16:34:16 INFO - "buildid", 16:34:16 INFO - "20151119135111", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "builduid", 16:34:16 INFO - "96f7efb7a6704da0b5a50b9f3aff177e", 16:34:16 INFO - "Change" 16:34:16 INFO - ], 16:34:16 INFO - [ 16:34:16 INFO - "pgo_build", 16:34:16 INFO - "False", 16:34:16 INFO - "Change" 16:34:16 INFO - ] 16:34:16 INFO - ], 16:34:16 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 16:34:16 INFO - } 16:34:16 INFO - ], 16:34:16 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 16:34:16 INFO - } 16:34:16 INFO - } 16:34:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:34:16 INFO - Running post-action listener: _resource_record_post_action 16:34:16 INFO - ##### 16:34:16 INFO - ##### Running download-and-extract step. 16:34:16 INFO - ##### 16:34:16 INFO - Running pre-action listener: _resource_record_pre_action 16:34:16 INFO - Running main action method: download_and_extract 16:34:16 INFO - mkdir: /builds/slave/test/build/tests 16:34: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')]} 16:34:16 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:34:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json 16:34:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json 16:34:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:34:23 INFO - Downloaded 1149 bytes. 16:34:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:34:23 INFO - Using the following test package requirements: 16:34:23 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:34:23 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:34:23 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'jsshell-mac.zip'], 16:34:23 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:34:23 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:34:23 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:34:23 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:34:23 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:34:23 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:34:23 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:34:23 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:34:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:34:23 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')]} 16:34:23 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:24 INFO - Downloaded 17524860 bytes. 16:34:24 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 16:34:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:34:27 INFO - Return code: 0 16:34:27 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 16:34: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')]} 16:34:27 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:28 INFO - Downloaded 17524860 bytes. 16:34:28 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 16:34:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:34:31 INFO - Return code: 0 16:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:31 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:34:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:33 INFO - Downloaded 11130997 bytes. 16:34:33 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 16:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:34:33 INFO - Return code: 0 16:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:33 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 16:34:36 INFO - Downloaded 109368599 bytes. 16:34:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:36 INFO - mkdir: /builds/slave/test/properties 16:34:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:36 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:36 INFO - Contents: 16:34:36 INFO - build_url:https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:36 INFO - Running post-action listener: _resource_record_post_action 16:34:36 INFO - Running post-action listener: set_extra_try_arguments 16:34:36 INFO - ##### 16:34:36 INFO - ##### Running populate-webroot step. 16:34:36 INFO - ##### 16:34:36 INFO - Running pre-action listener: _resource_record_pre_action 16:34:36 INFO - Running main action method: populate_webroot 16:34:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:34:36 INFO - '../fennec_ids.txt'], 16:34:36 INFO - 'tests': ['tcheck2']}, 16:34:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:36 INFO - '--tppagecycles', 16:34:36 INFO - '7'], 16:34:36 INFO - 'tests': ['tsvgm']}}, 16:34:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:34:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'tests': ['damp', 'tps']}, 16:34:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['damp', 'tps']}, 16:34:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:34:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:36 INFO - 'other': {'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'other_l64': {'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'other_nol64': {'tests': ['a11yr', 16:34:36 INFO - 'ts_paint', 16:34:36 INFO - 'tpaint', 16:34:36 INFO - 'sessionrestore', 16:34:36 INFO - 'sessionrestore_no_auto_restore']}, 16:34:36 INFO - 'svgr': {'tests': ['tsvgx', 16:34:36 INFO - 'tsvgr_opacity', 16:34:36 INFO - 'tart', 16:34:36 INFO - 'tscrollx', 16:34:36 INFO - 'cart']}, 16:34:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['tsvgx', 16:34:36 INFO - 'tsvgr_opacity', 16:34:36 INFO - 'tart', 16:34:36 INFO - 'tscrollx', 16:34:36 INFO - 'cart']}, 16:34:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'tests': ['tp5o']}, 16:34:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'talos_options': ['--e10s'], 16:34:36 INFO - 'tests': ['tp5o']}, 16:34:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'talos_options': ['--xperf_path', 16:34:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:36 INFO - 'tests': ['tp5n']}, 16:34:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:36 INFO - 'talos_options': ['--e10s', 16:34:36 INFO - '--xperf_path', 16:34:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:36 INFO - 'tests': ['tp5n']}}, 16:34:36 INFO - 'talos.zip': {'path': '', 16:34:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:36 INFO - Running post-action listener: _resource_record_post_action 16:34:36 INFO - ##### 16:34:36 INFO - ##### Running create-virtualenv step. 16:34:36 INFO - ##### 16:34:36 INFO - Running pre-action listener: _resource_record_pre_action 16:34:36 INFO - Running main action method: create_virtualenv 16:34:36 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:36 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 16:34:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:36 INFO - Using real prefix '/tools/python27' 16:34:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:37 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:40 INFO - Installing pip.................done. 16:34:40 INFO - Return code: 0 16:34:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34:40 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')]} 16:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 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')]} 16:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:40 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 16:34:40 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 16:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:40 INFO - 'HOME': '/Users/cltbld', 16:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:40 INFO - 'LOGNAME': 'cltbld', 16:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:40 INFO - 'MOZ_NO_REMOTE': '1', 16:34:40 INFO - 'NO_EM_RESTART': '1', 16:34:40 INFO - 'PAGER': '/bin/cat', 16:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:40 INFO - 'PWD': '/builds/slave/test', 16:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:40 INFO - 'SHELL': '/bin/bash', 16:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:40 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:40 INFO - 'USER': 'cltbld', 16:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:40 INFO - 'XPC_FLAGS': '0x0', 16:34:40 INFO - 'XPC_SERVICE_NAME': '0', 16:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:40 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 16:34:40 INFO - Cleaning up... 16:34:40 INFO - Return code: 0 16:34:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:34:40 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')]} 16:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 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')]} 16:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:40 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 16:34:40 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 16:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:40 INFO - 'HOME': '/Users/cltbld', 16:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:40 INFO - 'LOGNAME': 'cltbld', 16:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:40 INFO - 'MOZ_NO_REMOTE': '1', 16:34:40 INFO - 'NO_EM_RESTART': '1', 16:34:40 INFO - 'PAGER': '/bin/cat', 16:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:40 INFO - 'PWD': '/builds/slave/test', 16:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:40 INFO - 'SHELL': '/bin/bash', 16:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:40 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:40 INFO - 'USER': 'cltbld', 16:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:40 INFO - 'XPC_FLAGS': '0x0', 16:34:40 INFO - 'XPC_SERVICE_NAME': '0', 16:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:40 INFO - Downloading/unpacking psutil>=0.7.1 16:34:40 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 16:34:40 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 16:34:40 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 16:34:40 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 16:34:40 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 16:34:40 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 16:34:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:34:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:43 INFO - Installing collected packages: psutil 16:34:43 INFO - Running setup.py install for psutil 16:34:43 INFO - building 'psutil._psutil_osx' extension 16:34:43 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 16:34:43 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 16:34:43 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 16:34:43 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 16:34:43 INFO - building 'psutil._psutil_posix' extension 16:34:43 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 16:34:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:43 INFO - ^ 16:34:43 INFO - 1 warning generated. 16:34:43 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 16:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:44 INFO - Successfully installed psutil 16:34:44 INFO - Cleaning up... 16:34:44 INFO - Return code: 0 16:34:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:44 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 16:34:44 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 16:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:44 INFO - 'HOME': '/Users/cltbld', 16:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:44 INFO - 'LOGNAME': 'cltbld', 16:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:44 INFO - 'MOZ_NO_REMOTE': '1', 16:34:44 INFO - 'NO_EM_RESTART': '1', 16:34:44 INFO - 'PAGER': '/bin/cat', 16:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:44 INFO - 'PWD': '/builds/slave/test', 16:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:44 INFO - 'SHELL': '/bin/bash', 16:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:44 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:44 INFO - 'USER': 'cltbld', 16:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:44 INFO - 'XPC_FLAGS': '0x0', 16:34:44 INFO - 'XPC_SERVICE_NAME': '0', 16:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:34:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:34:46 INFO - Installing collected packages: mozsystemmonitor 16:34:46 INFO - Running setup.py install for mozsystemmonitor 16:34:46 INFO - Successfully installed mozsystemmonitor 16:34:46 INFO - Cleaning up... 16:34:46 INFO - Return code: 0 16:34:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:46 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')]} 16:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:46 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')]} 16:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:46 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:46 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 16:34:46 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 16:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:46 INFO - 'HOME': '/Users/cltbld', 16:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:46 INFO - 'LOGNAME': 'cltbld', 16:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:46 INFO - 'MOZ_NO_REMOTE': '1', 16:34:46 INFO - 'NO_EM_RESTART': '1', 16:34:46 INFO - 'PAGER': '/bin/cat', 16:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:46 INFO - 'PWD': '/builds/slave/test', 16:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:46 INFO - 'SHELL': '/bin/bash', 16:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:46 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:46 INFO - 'USER': 'cltbld', 16:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:46 INFO - 'XPC_FLAGS': '0x0', 16:34:46 INFO - 'XPC_SERVICE_NAME': '0', 16:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:49 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 16:34:50 INFO - Downloading docopt-0.6.1.tar.gz 16:34:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:50 INFO - Running setup.py install for blobuploader 16:34:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:50 INFO - Running setup.py install for requests 16:34:50 INFO - Running setup.py install for docopt 16:34:51 INFO - Successfully installed blobuploader requests docopt 16:34:51 INFO - Cleaning up... 16:34:51 INFO - Return code: 0 16:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:51 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:51 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 16:34:51 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 16:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:51 INFO - 'HOME': '/Users/cltbld', 16:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:51 INFO - 'LOGNAME': 'cltbld', 16:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:51 INFO - 'MOZ_NO_REMOTE': '1', 16:34:51 INFO - 'NO_EM_RESTART': '1', 16:34:51 INFO - 'PAGER': '/bin/cat', 16:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:51 INFO - 'PWD': '/builds/slave/test', 16:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:51 INFO - 'SHELL': '/bin/bash', 16:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:51 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:51 INFO - 'USER': 'cltbld', 16:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:51 INFO - 'XPC_FLAGS': '0x0', 16:34:51 INFO - 'XPC_SERVICE_NAME': '0', 16:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-EHX8Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-iVIyQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-FWohv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-56hY3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ug52EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:51 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-tksHBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-QqqBdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-UXXNQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Ff_UUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-gDbJrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-A0Ulqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-WtNEID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Oyi2Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-KT7eiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:52 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-2nZvi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:53 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-tBoX_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:53 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-MjOrNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:53 INFO - Running setup.py install for manifestparser 16:34:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:53 INFO - Running setup.py install for mozcrash 16:34:53 INFO - Running setup.py install for mozdebug 16:34:53 INFO - Running setup.py install for mozdevice 16:34:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:53 INFO - Running setup.py install for mozfile 16:34:53 INFO - Running setup.py install for mozhttpd 16:34:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Running setup.py install for mozinfo 16:34:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Running setup.py install for mozInstall 16:34:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Running setup.py install for mozleak 16:34:54 INFO - Running setup.py install for mozlog 16:34:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Running setup.py install for moznetwork 16:34:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:54 INFO - Running setup.py install for mozprocess 16:34:55 INFO - Running setup.py install for mozprofile 16:34:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Running setup.py install for mozrunner 16:34:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Running setup.py install for mozscreenshot 16:34:55 INFO - Running setup.py install for moztest 16:34:55 INFO - Running setup.py install for mozversion 16:34:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:55 INFO - Cleaning up... 16:34:55 INFO - Return code: 0 16:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:55 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')]} 16:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:55 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')]} 16:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:55 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:55 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 16:34:55 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 16:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:55 INFO - 'HOME': '/Users/cltbld', 16:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:55 INFO - 'LOGNAME': 'cltbld', 16:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:55 INFO - 'MOZ_NO_REMOTE': '1', 16:34:55 INFO - 'NO_EM_RESTART': '1', 16:34:55 INFO - 'PAGER': '/bin/cat', 16:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:55 INFO - 'PWD': '/builds/slave/test', 16:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:55 INFO - 'SHELL': '/bin/bash', 16:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:34:55 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:55 INFO - 'USER': 'cltbld', 16:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:55 INFO - 'XPC_FLAGS': '0x0', 16:34:55 INFO - 'XPC_SERVICE_NAME': '0', 16:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-vnpNI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-pfYGKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-FYSxc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-vtZIxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-yU1Izx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-B0mktw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-KHGcZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-5KFVsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:56 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)) 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:56 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-BBo9NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-V82Uss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-MZJ3TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-k_yN9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-RL6xm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-uKhp60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-S0TJ8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Ja4xz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:57 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)) 16:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:57 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-GHP2B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:57 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)) 16:34:57 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)) 16:34:57 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)) 16:34:57 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)) 16:34:57 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)) 16:34:57 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)) 16:34:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:59 INFO - Downloading blessings-1.5.1.tar.gz 16:34:59 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 16:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:00 INFO - Installing collected packages: blessings 16:35:00 INFO - Running setup.py install for blessings 16:35:00 INFO - Successfully installed blessings 16:35:00 INFO - Cleaning up... 16:35:00 INFO - Return code: 0 16:35:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:00 INFO - Reading from file tmpfile_stdout 16:35:00 INFO - Current package versions: 16:35:00 INFO - blessings == 1.5.1 16:35:00 INFO - blobuploader == 1.2.4 16:35:00 INFO - docopt == 0.6.1 16:35:00 INFO - manifestparser == 1.1 16:35:00 INFO - mozInstall == 1.12 16:35:00 INFO - mozcrash == 0.16 16:35:00 INFO - mozdebug == 0.1 16:35:00 INFO - mozdevice == 0.47 16:35:00 INFO - mozfile == 1.2 16:35:00 INFO - mozhttpd == 0.7 16:35:00 INFO - mozinfo == 0.9 16:35:00 INFO - mozleak == 0.1 16:35:00 INFO - mozlog == 3.0 16:35:00 INFO - moznetwork == 0.27 16:35:00 INFO - mozprocess == 0.22 16:35:00 INFO - mozprofile == 0.27 16:35:00 INFO - mozrunner == 6.11 16:35:00 INFO - mozscreenshot == 0.1 16:35:00 INFO - mozsystemmonitor == 0.0 16:35:00 INFO - moztest == 0.7 16:35:00 INFO - mozversion == 1.4 16:35:00 INFO - psutil == 3.1.1 16:35:00 INFO - requests == 1.2.3 16:35:00 INFO - wsgiref == 0.1.2 16:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:00 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 0x105260490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10523d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea54fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/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.0fLdEDp861/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:35:00 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 16:35:00 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 16:35:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:35:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:00 INFO - 'HOME': '/Users/cltbld', 16:35:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:00 INFO - 'LOGNAME': 'cltbld', 16:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:00 INFO - 'MOZ_NO_REMOTE': '1', 16:35:00 INFO - 'NO_EM_RESTART': '1', 16:35:00 INFO - 'PAGER': '/bin/cat', 16:35:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:00 INFO - 'PWD': '/builds/slave/test', 16:35:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:00 INFO - 'SHELL': '/bin/bash', 16:35:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:35:00 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:35:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:00 INFO - 'USER': 'cltbld', 16:35:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:00 INFO - 'XPC_FLAGS': '0x0', 16:35:00 INFO - 'XPC_SERVICE_NAME': '0', 16:35:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 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)) 16:35:00 INFO - Cleaning up... 16:35:00 INFO - Return code: 0 16:35:00 INFO - Running post-action listener: _resource_record_post_action 16:35:00 INFO - Running post-action listener: _start_resource_monitoring 16:35:00 INFO - Starting resource monitoring. 16:35:00 INFO - ##### 16:35:00 INFO - ##### Running install step. 16:35:00 INFO - ##### 16:35:00 INFO - Running pre-action listener: _resource_record_pre_action 16:35:00 INFO - Running main action method: install 16:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:01 INFO - Reading from file tmpfile_stdout 16:35:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:01 INFO - Reading from file tmpfile_stdout 16:35:01 INFO - Output received: 16:35:01 INFO - Usage: mozinstall [options] installer 16:35:01 INFO - Options: 16:35:01 INFO - -h, --help show this help message and exit 16:35:01 INFO - -d DEST, --destination=DEST 16:35:01 INFO - Directory to install application into. [default: 16:35:01 INFO - "/builds/slave/test"] 16:35:01 INFO - --app=APP Application being installed. [default: firefox] 16:35:01 INFO - mkdir: /builds/slave/test/build/application 16:35:01 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'] 16:35:01 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 16:35:31 INFO - Reading from file tmpfile_stdout 16:35:31 INFO - Output received: 16:35:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:35:31 INFO - Running post-action listener: _resource_record_post_action 16:35:31 INFO - ##### 16:35:31 INFO - ##### Running run-tests step. 16:35:31 INFO - ##### 16:35:31 INFO - Running pre-action listener: _resource_record_pre_action 16:35:31 INFO - Running main action method: run_tests 16:35:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:31 INFO - 2015-11-19 16:35:31.936 screenresolution[2224:18516] starting screenresolution argv=screenresolution get 16:35:31 INFO - 2015-11-19 16:35:31.939 screenresolution[2224:18516] Display 0: 1600x1200x32@60 16:35:31 INFO - 2015-11-19 16:35:31.945 screenresolution[2225:18518] starting screenresolution argv=screenresolution list 16:35:31 INFO - Available Modes on Display 0 16:35:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:32 INFO - Intel Iris: 16:35:32 INFO - Chipset Model: Intel Iris 16:35:32 INFO - Type: GPU 16:35:32 INFO - Bus: Built-In 16:35:32 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:32 INFO - Vendor: Intel (0x8086) 16:35:32 INFO - Device ID: 0x0a2e 16:35:32 INFO - Revision ID: 0x0009 16:35:32 INFO - Displays: 16:35:32 INFO - Display: 16:35:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:32 INFO - Display Serial Number: 1600x1200 60 16:35:32 INFO - Main Display: Yes 16:35:32 INFO - Mirror: Off 16:35:32 INFO - Online: Yes 16:35:32 INFO - Rotation: Supported 16:35:32 INFO - Return code: 0 16:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:35:32 INFO - Python 2.7.3 16:35:32 INFO - Return code: 0 16:35:32 INFO - grabbing minidump binary from tooltool 16:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051849f0>, '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 0x104ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051778c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:35:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:35:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:35:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:32 INFO - Return code: 0 16:35:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:35:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:35:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:35:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:35:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--webServer', 'localhost'] in /builds/slave/test/build 16:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0041 --webServer localhost 16:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tWNf4C3IOA/Render', 16:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:32 INFO - 'HOME': '/Users/cltbld', 16:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:32 INFO - 'LOGNAME': 'cltbld', 16:35:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:35:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:32 INFO - 'MOZ_NO_REMOTE': '1', 16:35:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:35:32 INFO - 'NO_EM_RESTART': '1', 16:35:32 INFO - 'PAGER': '/bin/cat', 16:35:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:32 INFO - 'PWD': '/builds/slave/test', 16:35:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:32 INFO - 'SHELL': '/bin/bash', 16:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fLdEDp861/Listeners', 16:35:32 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 16:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:32 INFO - 'USER': 'cltbld', 16:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:32 INFO - 'XPC_FLAGS': '0x0', 16:35:32 INFO - 'XPC_SERVICE_NAME': '0', 16:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--webServer', 'localhost'] with output_timeout 3600 16:35:32 INFO - mozversion INFO | application_buildid: 20151119135111 16:35:32 INFO - mozversion INFO | application_changeset: 0920dee3c3036861bfe0f32342cdced4cabfb8df 16:35:32 INFO - mozversion INFO | application_display_name: Nightly 16:35:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:32 INFO - mozversion INFO | application_name: Firefox 16:35:32 INFO - mozversion INFO | application_remotingname: firefox 16:35:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:35:32 INFO - mozversion INFO | application_vendor: Mozilla 16:35:32 INFO - mozversion INFO | application_version: 45.0a1 16:35:32 INFO - mozversion INFO | platform_buildid: 20151119135111 16:35:32 INFO - mozversion INFO | platform_changeset: 0920dee3c3036861bfe0f32342cdced4cabfb8df 16:35:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:35:32 INFO - mozversion INFO | platform_version: 45.0a1 16:35:32 INFO - 2015-11-19 16:35:32,489 DEBUG : using testdate: 1447979732 16:35:32 INFO - 2015-11-19 16:35:32,489 DEBUG : actual date: 1447979732 16:35:32 INFO - 2015-11-19 16:35:32,938 INFO : starting webserver on 'localhost:50115' 16:35:32 INFO - 2015-11-19 16:35:32,939 INFO : Starting test suite t-yosemite-r7-0041 16:35:32 INFO - 2015-11-19 16:35:32,939 INFO : Starting test dromaeo_css 16:35:32 INFO - 2015-11-19 16:35:32,939 DEBUG : operating with platform_type : mac_ 16:35:32 INFO - 2015-11-19 16:35:32,940 INFO : Initialising browser for dromaeo_css test... 16:35:32 INFO - 2015-11-19 16:35:32,952 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmprLwAQY/profile http://localhost:50115/getInfo.html 16:35:34 INFO - 2015-11-19 16:35:34,919 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:35:34 INFO - 2015-11-19 16:35:34,920 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:35:34 INFO - 2015-11-19 16:35:34,920 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:35:34 INFO - 2015-11-19 16:35:34,920 DEBUG : BROWSER_OUTPUT: __metrics 16:35:34 INFO - 2015-11-19 16:35:34,935 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:35 INFO - 2015-11-19 16:35:35,735 INFO : Browser initialized. 16:35:35 INFO - 2015-11-19 16:35:35,736 INFO : Running cycle 1/1 for dromaeo_css test... 16:35:35 INFO - 2015-11-19 16:35:35,736 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmprLwAQY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:35:47 INFO - 2015-11-19 16:35:47,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 225951744 16:35:47 INFO - 2015-11-19 16:35:47,627 DEBUG : BROWSER_OUTPUT: 16:36:38 INFO - 2015-11-19 16:36:38,769 DEBUG : BROWSER_OUTPUT: 1447979798766 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] 16:38:49 INFO - 2015-11-19 16:38:49,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50115/tests/dromaeo/cssquery-ext.html) 16:38:51 INFO - 2015-11-19 16:38:51,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 367927296 16:38:51 INFO - 2015-11-19 16:38:51,298 DEBUG : BROWSER_OUTPUT: 16:41:54 INFO - 2015-11-19 16:41:54,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-ext.html (next: http://localhost:50115/tests/dromaeo/cssquery-jquery.html) 16:41:54 INFO - 2015-11-19 16:41:54,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 364060672 16:41:54 INFO - 2015-11-19 16:41:54,703 DEBUG : BROWSER_OUTPUT: 16:44:56 INFO - 2015-11-19 16:44:56,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50115/tests/dromaeo/cssquery-mootools.html) 16:44:57 INFO - 2015-11-19 16:44:57,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 337895424 16:44:57 INFO - 2015-11-19 16:44:57,341 DEBUG : BROWSER_OUTPUT: 16:47:59 INFO - 2015-11-19 16:47:59,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50115/tests/dromaeo/cssquery-prototype.html) 16:47:59 INFO - 2015-11-19 16:47:59,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 322048000 16:47:59 INFO - 2015-11-19 16:47:59,935 DEBUG : BROWSER_OUTPUT: 16:51:02 INFO - 2015-11-19 16:51:02,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50115/tests/dromaeo/cssquery-yui.html) 16:51:03 INFO - 2015-11-19 16:51:03,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 326651904 16:51:03 INFO - 2015-11-19 16:51:03,453 DEBUG : BROWSER_OUTPUT: 16:54:05 INFO - 2015-11-19 16:54:05,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/dromaeo/cssquery-yui.html (next: http://localhost:50115/tests/dromaeo/cssquery-dojo.html) 16:54:06 INFO - 2015-11-19 16:54:06,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 366768128 16:54:06 INFO - 2015-11-19 16:54:06,081 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2946.5432857907026;3494.6505349465074;3530.064532898782;3535.71714262859;3550.467429885516;5786.768529258835;5875.059990401536;6073.149759033733;6111.969440152804;6125.479334256588;5992.250968628921;6003.819885403434;6062.787802426916;6067.696615169235;6114.449440885034;5350.2777125088105;5396.43337449568;5401.594880383967;5406.59450541209;5444.8366549003595;5474.7810087596645;5486.945130548704;5537.307836520435;5545.223668686367;5570.108782594785;5265.210218467222;5266.2100684897;5355.384130824966;5383.973080134574;5455.809046683366;5428.565714742811;5430.022595932731;5449.972750136264;5460.6177567570285;5464.23500709901;5355.6251062425645;5365.624406291561;5388.5958553108285;5411.134218525017;5416.539594134503;5791.681457519835;5870.97064514679;5926.703664816785;5965.313988891289;6080.087986801971;6353.174087368612;6366.140571022946;6375.45808606269;6380.968095159541;6390.13733146024;6432.131662225634;6441.935580644227;6442.452391546724;6455.289918109004;6469.967650161719;5962.612430192067;6037.09443583466;6139.662318572521;6210.161628180228;6225.501959843247;5423.240746295522;6624.900626490607;6625.3374662534325;6646.8005959821285;6663.36698013688;6244.344343843922;6297.748090076438;6308.148399966038;6308.432241098323;6308.905366419507;6218.129461875341;6312.400321969406;6366.331535188831;6428.5178611604315;6437.356264373525;6270.184875966095;6271.4669253114;6278.811635650938;6283.937160628427;6293.842653933688;6194.690265486708;6244.344343843922;6272.3100458949475;6283.497320214372;6287.931051721218;5117.667351622133;5147.613928955268;5163.225516172604;5190.2993095932325;5192.428832828386;4546.431696037996;4637.582617564435;4647.279671650899;4667.696599721007;4684.906301874012;5979.940200597938;6003.369646187088;6121.204243448323;6125.142480052797;6131.50947924165;6365.968170159213;6413.3266007069515;6415.582987105823;6416.454601358937;6429.678516074177;5879;6051.939480605226;6089.8477538061015;6127.969360153171;6169.383061693885;5548.472895074961;5581.49766521015;5589.916151257735;5599.720013999284;5667.886642267132;6626.244045327992;6652.467802575879;6653.234877988996;6655.134832471845;6681.599104053772;6210.223722034746;6278.4035516625845;6416.743330266737;6428.035794630843;6430.48556115519;6394.168758061608;6481.870362592627;6490.740370385131;6492;6496.317886622026;6230.470410015199;6257.342978987141;6266.905996410149;6285.49716022708;6312.558120931674;6414.326495717883;6447.4197322241225;6472;6480.773172938924;6491.902621460777;6123.608384081089;6293.244810622571;6310.936890631035;6313.779017734541;6319.3364696706185;5147.742612869416;6198.721057552511;6204.255489341308;6324.747010119728;6329.303776584664;6277.497800176066;6295.874082518416;6301.684915754286;6318.526110541819;6345.809625711236;6170.660613666291;6323.241211054703;6334.841628959313;6352.682365881595;6371.96814015927;6153.261608606996;6205.100260462117;6212.099245609271;6300.180976473029;6327.588706734047 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |1;ext.html;527.7269841871395;561.7865211219736;605.8091701114149;614.2260751453168;633.8288662061246;31637.525437118435;32217.677823221733;32369.982652688843;32696.836515817446;40863.77408677737;43655;43741.68774936749;44089.89775255612;44102.55897441025;44105;9721.31950763447;9919.156871665917;9944.15474684649;9951.75120621983;9957.402555846636;8900.154485323885;8955.596998135099;8980.46117232965;8981.191692747652;9693.70918872435;8778.078301778318;8847.911520884772;11893.762124757499;12020.21868578544;12021.398930053507;11761.882381176165;11843.881561184364;11851.288922664668;11854.762904741858;11864.110191735654;8316;10123.696289111338;11121.443927803577;11856;11868.991135753471;31872.043838684876;32207.51688724671;40786.59213407858;40818.9795255118;40897;3260.675006463666;3327.7005069543857;3334.233126380946;3472.5485686860798;3544.4151714967;28115.57826632602;28663;28777.712222877923;28818.85590572034;28958.986435474657;2568.576184929503;2580.8193426460157;2609.699884513286;2647.6293318935363;2739.301478123086;451233;452725;453688.4631153679;453794.73102634604;454399.7280013612;64260;64515.67742161259;64546;64569;64713;66877.66561167163;67072.6646366765;67107.66446167836;67113;67182;15388.846111538965;16385.42651007209;16563.42028029013;16571.6685666286;16579.91710041442;11496.77006459866;11524.654260372203;11544.88455115455;11562.01722853567;11564.306141631529;17178.15687653869;21796.74963382157;22573.54852902933;22580.322590322317;22626.773732262795;7835.138134805167;8784.912150878537;8911.108889111038;8971.730848074569;8984.281257499384;867.5662168915542;931.1945167430259;966.4539535162611;969.2536746704998;1140.3386036099043;30125;32859.17852053718;32881.3423731524;33676.494852577234;33843.830780845936;906.5059542549326;1022.4325499347784;1069.6256310291492;1093.797647435227;1222.45600707686;14625.78061329081;14782.556523304318;14879.33043013067;14926;15259.160746158846;673590;681202;681529;682069;682823;58137.709311453174;58368.4163158363;58404.12393814096;58443;58463.70768146132;1413.6748547834056;1424.8361438434713;1432.427029188333;1432.4986254810733;1577.668689575202;28775.54873262378;28831.5675264867;29088.854555727085;29182.708172918;29224.41551168922;50395.49604504055;50968.98062038665;50989.235161471865;51057;51115.488845111075;510477;510967;512348;526529.3673531607;537170;28819.135425937257;33294;33370.499442508866;33432;33464.832675836464;40660.59339406568;41191.382129267484;41332;41617.58382416137;41805.58194418017;35238.471422929186;35333.469997949534;35892;36217.094572634844;36230.81884590666;34403.4839477403;34848.47727284143;34992.125196870285;36037;36422.63577364192;35009;35466.64533354634;36007.45988810118;36036.457348682765;36348;30518.542221866246;32296.031119066465;32322.83838580792;32349.35301293914;32388.83805580957;20829.373564583755;24052.87973560121;24295.63556546618;24312.839330886873;24657.63013554834 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.3920916813912;354.459449339757;359.5326076101068;359.99640003599956;365.93961996270616;15330.310136043878;16516.42192523262;19664.508387290323;20170.798292017076;20872.582548349044;15643;17639.5590110247;20119.899400503014;20316.796832031676;20519.897400513015;5726.599138060337;5730.255066841326;5860.296764388279;5872.17789509469;5876.08920617305;4254.4469219001485;4373.1690978714105;4374.475062992446;5816.680082595455;5887.8233652990475;6250.312465628777;6368.267649220353;6424;6429.35706429358;6431.163948686688;6231.5326350523665;6388.744450221986;6401.807945761635;6405.8398540036405;6429.260635026938;5517.420670829545;5522.972385138089;5527.170924361338;5530.2810634617645;5551.195076713894;13673.111247768864;13768.105073170213;13770.65573360664;14063.695031667652;14112.858871411257;1878.2205384765307;1938.6510428122933;1946.3577019583645;1986.483514286296;2058.8147066763913;9537.618495260182;9538.570764315622;9595.13643772064;9939.105480506716;10241.84637230442;1591.077175238359;1601.767743677172;1625.325489921681;1627.8453546913142;1656.9088700121488;90062.09937900669;92964.53517732368;94557;95226.52386738022;95911.0408895909;6669.899951500732;6688.264290927994;6704.463642908556;6762.4928130389435;6777.1189745332795;6709.597424154566;7707.383409327241;7725.304722574995;7726.690932362755;7733.033370828646;5623.887522249532;5645.689487078168;5656.575756818255;5679.943200568024;5706.115552089433;6092.878142437126;6130.693465326716;6150.569460137747;6163.229596300463;6171.5988460750805;2983.612130423031;2997.895073672411;3000.969990300069;3022.6070610820893;3024;917.7017469322363;1043.7651528406047;1086.41333679812;1109.2734259060328;1135.8807325230732;429.64554242749233;452.38927447945014;452.86187712747267;463.7866581372539;464.64454692160524;12045.578404755792;12250.774922507679;12282;12329.383530823423;12366.010719142447;431.7927394850489;483.9709617422966;485.85181519636143;487.9756012199376;494.70317809314844;5050.3434553507805;6342.1931880516995;6531.575447595986;6623.801285961429;6625.204975402886;660300.9849507601;758767;764777;779426;779431;114790.85209147968;118589;119136;119425.61148776975;121122;523.3876364653364;543.1364131031679;543.6873797566415;543.7335705504354;544.8882978989297;11611.941940290244;11783.351915644722;11903.761924761284;11918.761624767629;12135.696607584881;49651.25523117228;52492.95014099773;52791.20813187882;53158.73420632872;53498;63043;72366.63816680883;73119;74256.51486970339;74606.50786984121;6347.873042539031;6378.744850206125;6463.903041454476;6465.870682586416;6466;12479.939205167662;12670.366481676063;12776.36118194068;12783;12816.87183128194;11023.559057637605;11114.499847507042;11146.665600032013;11234.831477528007;11332.263402878787;10842.837357439486;10905.963933426312;10984.231103822656;11162.55349786032;11304.434778261219;9391.765205869635;9441.433513989183;11098.389588572383;11287.548498059985;11350.432478376213;6187.257529096537;6347.127121167124;6462.838429039311;6469.967650161719;6483.4164925156965;10625.990530899553;10756.83864742045;10819;11055.889441105486;11082.722931926766 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1403.3474434388008;1563.9530814075574;1565.9608509787254;1727.2054854766807;1911.149538455387;7247.782566522999;7619.771406857796;8000.479968802024;8096;8105.635246413911;7084.8583028339535;7610.592040472517;8341.791455213608;8344.958275208615;8351.74944751657;2086.0508468646804;2128.3082998025625;2361.8700971446565;2383.1539803369815;2384.4515761374896;2140.165335519149;2370.9762902370926;2387.617981123021;2390.5457962987066;2402.4354276744953;2317.385892738426;2340.508493216427;2356.1282325539573;2382.273406610983;2387.9880600597057;2084.1663334666105;2132.4668832791804;2137.241279345825;2347.6830627865274;2380.1907351500486;2137.7648458669532;2137.8824164670937;2328.2665960222644;2360.3745007573007;2366.19549353219;8360.874586881202;8469.95765021177;8470.78823029423;8478.06741258461;8480.406371553994;5109;5146.253793200002;5160.432352441228;5169.793208271664;5186.5332120109;3440.36353274645;3500.6499350065046;3560.8041557714314;3570.1610121621397;3586.103474131467;1038.8182068138121;1053.8208504554243;1066.7013236293851;1082.4641802307829;1083.2309060567006;11002.559897604166;11016.17378696601;11016.559337626566;11029.44852757359;11033.779324413546;4592.816287348469;4594.908101837945;4615.9076818463445;4648.48866624671;4664.067186562701;9627;9637.313470142697;9638.180754635934;9650.841898972169;9652.469114198786;5177.223416487557;5187.221916712448;5196.350456192976;5200.427952925175;5202.115640341151;4693.296005599119;4737.881552961135;4744.217204161344;4746;4764.356811830427;3741.7567858089137;3828.8851334459455;3853.807309634507;3856.9035774105873;3859.671927886161;1250.6310638361706;1254.6926003129292;1255.4413286087786;1260.9243445393306;1266.9809952850715;1330.8602596727205;1346.1115663661935;1356.966075848092;1362.8773410393112;1371.4651285998468;7680.270374314431;7861.960690196513;7866.606669666494;7868.606569671493;7880.290773830383;501.2831650739405;503.58705861194204;505.05806670559144;509.1192237429194;513.3993227923339;5632.4930756231315;5727.914081288784;6139.57023008394;6213.099100630383;6225.097360882737;9189;9939;9958.15355694774;9986.102640498282;10100;9695.418274903528;9880.802383952425;9948.154406875497;10032.899671003343;10046.397216167054;7764.61176941162;7835.529868207926;7847.882281765778;7902.17027212146;7925.247101525461;7544.47188696786;7732.30409263169;7771.961140194489;7783.104942931635;7785.948896898846;8646.178613031752;8975.147361000956;9023.503707296162;9087.045860184586;9168.083191680778;9129.087091291083;9328.440293582407;9341.11259430353;9392.436453812794;9452.858207126761;7019.508634395544;7238.52949558277;7291.30732580404;7307;7346.816329591803;7849.372050235853;7968.36253099739;7999.640016199169;8002.07976082758;8008.319292860172;7378.409727221702;7502.98709674187;7516.887246691194;7626.504277221963;7662.616869156632;7372.299631534996;7396.704131834666;7435.553866767795;7472.252774722484;7480.850382992418;7463.17905030457;7475.102987641518;7497.512661676974;7520.623968801428;7541.35898448638;6764.3573860483175;6824.351686589766;6844.8973265402055;6865.41643960269;6867.969804529361;6962.094927659372;6997.790066298019;7007.579545227302;7007.614581198083;7012.894806578008 16:54:06 INFO - 2015-11-19 16:54:06,082 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.2417921168407;323.64884100750686;326.2219606239119;327.2734529344854;329.2082541487723;6283.52873534485;6716.462682985368;6983.650817459125;6985.860282794341;6995.930040699592;6879.208890977527;6882.827929301758;6907.205671347797;6908.4818638602055;6961.617111058889;4923.852284431455;5077.517635824591;5082.92375614367;5089.4910508949;5092.618053645972;5048.268001139832;5052.469490703478;5061.316722242487;5062.2406639004075;5109.284700141983;4993.6005119590345;5026.5727413169925;5029.924551131718;5030.37120359955;5038.874028149307;4813.78337974792;4877.219644856806;4914.419929536986;5028.371453568304;5035.295058691786;4151.27352713277;4259.084296876186;4264.552222016675;4265.808038638269;4268.189044081614;6598.736050557972;6670.132882725215;6681.699323530453;6689.364510371555;6697.732090716366;5689.975804355215;5725.198472213893;5839.620424672383;5990.101484777275;5999.790007349722;6893.4140598048725;7357.153927298322;7388.556686598821;7488.251174882523;7492.887606685904;4818.060478206751;4836.153673107192;4836.637252206064;4841.104395686809;4855.028994201174;7701.653425595861;7931.643076061591;7943.443958922878;7951.244631759973;7994;4970.826021089245;4988.251762235621;4990.875228119254;4996.926275595587;5009;5071.239314102841;5088.211327244283;5090.77091530882;5099.515546023122;5099.643024988215;5044.672096313728;6019.428154325332;6020.367861374492;6030.819075427744;6031.095335699592;7334.143498425181;7509.774706758806;7519.511231770027;7522.6614802334025;7539.8115047123165;1732.8440440360428;1757.6221112460883;1759.81521940197;1764.4971183212979;1768.1777973242247;960.9951950240344;969.0715476202307;1136.8294755786699;1137.2494153858413;1147.162571322939;7035.437165026786;7053.294670533009;7068.045813815069;7074.257202993715;7082.256363081905;7777.688892444352;7790.104138024087;7794.805129871798;7799.922000780033;7806.453548251568;6297.4647154992335;6550.246721626979;7036.472264580075;7040.401565866856;7066.823329416806;4012.9598704012587;4091.2022155679356;4100.630943215066;4142.212979533879;4145.79271036447;6403.935960640427;7992.560409177551;8200.917990820015;8211.7947051323;8220.753377398687;8090.919090809134;8152.347812175011;8156.67373305073;8175.427720059539;8191.385646076568;7901.209879012053;8177.754667359989;8187.38594605407;8192;8193.09875913649;6498.252700939263;7873.763787086396;7878.566678832719;7878.72424465141;7883.251091146332;7468.9626551866895;7686.9231307686205;7700.95924579998;7722.575258360844;7728.536287822749;8189.22202390772;8189.631466584137;8189.713360032609;8190.355291895049;8195.590220489072;4782.569568738831;4836.637252206028;4841.903161936812;4842.443119041214;4842.854714358575;6481.740730370921;7641.579713115832;7829.060512738508;7857.528548287121;7880.211978802074;7548.811279717831;7577.621118944141;7587.430942679432;7588.81027974305;7592.240775922363;7277;7526.02161718973;7528.661210245662;7539.886901696588;7547.5848828314965;7372.926270737438;7384.113906331059;7395.223501532261;7396.55620662762;7403.703851845866;7573.2048134945035;7573.545587264782;7575.469717119749;7583.7724868254045;7620.542767433972;7169.068021157216;7403.444741644291;7407.2592740725495;7407.481476296607;7418.332350088518 16:54:06 INFO - 2015-11-19 16:54:06,084 DEBUG : BROWSER_OUTPUT: |5;yui.html;721.5634541102633;727.6325455644899;780.3718007004359;822.5106061893175;844.4468872888252;13046.673833154176;14578.271086445675;15390.461333853304;15391.307391167396;15393.538193854174;13595.999999999975;13669.726605467884;14102.083364581295;14196.929015354935;14220.217888016155;933.6452148183681;954.4082668745388;956.6747305915987;959.6737109382808;960.1742501448748;946.191006689281;958.9904100959005;959.3524371049549;959.4051687953444;960.5149399553216;986.6941248213041;998.8501724741275;1001.224051360198;1001.534286556751;1001.7145113642613;992.3847214726879;993.0764389118117;993.9155171810405;994.2046362909715;996.6013594562161;742.7771668499429;743.9844612104492;745.1951891956674;745.2621904314743;746.1605693594706;13299;13443.193408395528;13581;13593.59219223425;13603.795943060863;10833.458327083614;10917.508712107974;11161.497732602053;11479.081673466186;11520.366379849105;9468.621255149787;9663.130318271318;9675.129238368581;9679.66121185755;10037.447940363278;3404.3361544498835;3454.29187016661;3473.808940508271;3478.7390945679176;3484.494748261488;57884;70719.64640176766;70812;72495.99999999948;79072.20927790707;7120.323569260912;7177.282271772885;7399.778006659809;7464.664090115958;7538.283863033003;12709.17390369623;12751.68120796969;12787.168834025759;12823.166494178035;12930.482780688668;6543.476521878239;6604.306547812506;6620.9006864897065;6621.9337806621315;6843.863122737617;4076.144009757925;4122.175564886975;4124.381342798604;4161.604647558477;4350.499692535335;3072.6005619269354;3084.228942764309;3101.581286526335;3109.8445077746023;3122.8282444465317;494.39930484461553;496.0401622859778;500.3170672032649;509.0760270109739;511.0468975360925;479.6234955559938;486.3580074301958;496.8037625138123;505.4642079395779;531.6517680919004;8175;8504.107068757816;8653.956730216309;8699.478031318142;8876.644934202688;484.13823394357394;494.8812285051562;581.2588949089944;584.5615788158881;616.2204810914197;3212.7590430717323;4025.5974402560096;4040.393940908887;4066.2883995300704;4113.568075352105;72703;72773.636131819;91614.54192728993;93060.06939930649;101591.44429944917;77737;78646.6067669658;79516;82644.58677706693;82750.58624706838;67318.66340668265;73548.26451735522;74696.13259668552;75623.62188189024;75920.24079759132;8472.406931514735;8748;9063.274938005075;9102.386881384542;9175.632974680939;39104.804475977435;50173;50379.99240015106;50879;51715.44853654396;64686.676566616865;69014.65492672505;71759.64120179365;73076.63461682657;76346.85479717697;8076.515409075474;8167.428280020579;8245.010598728191;8308.584570771316;8315.667373305241;11906.76186476283;11922.463489142836;12132.211406258564;12316.384180791103;12538.310392928477;11222.270552414067;11488.253263537843;11586.88413115858;11759.000484958533;11786;11546.896212200365;11575.363355015555;11637.301761893974;11744.354060526754;12083.939580302042;10660.946695266784;10763.031327180592;11095.445227738419;11137.944310278397;11658.6502404928;9748.951255243679;9754.365966212174;9772.413655180711;9936.850947235942;9952.651657192253;9262.629494820132;9306.208972237435;10015.449150296803;10159.7460063499;10160.441175735405 16:54:06 INFO - 2015-11-19 16:54:06,084 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1237 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980846070__endTimestamp 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5949.10 Median:6210.16 stddev:654.86 (10.5%) stddev-sans-first:613.05 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: Values: 2946.5 3494.7 3530.1 3535.7 3550.5 5786.8 5875.1 6073.1 6112.0 6125.5 5992.3 6003.8 6062.8 6067.7 6114.4 5350.3 5396.4 5401.6 5406.6 5444.8 5474.8 5486.9 5537.3 5545.2 5570.1 5265.2 5266.2 5355.4 5384.0 5455.8 5428.6 5430.0 5450.0 5460.6 5464.2 5355.6 5365.6 5388.6 5411.1 5416.5 5791.7 5871.0 5926.7 5965.3 6080.1 6353.2 6366.1 6375.5 6381.0 6390.1 6432.1 6441.9 6442.5 6455.3 6470.0 5962.6 6037.1 6139.7 6210.2 6225.5 5423.2 6624.9 6625.3 6646.8 6663.4 6244.3 6297.7 6308.1 6308.4 6308.9 6218.1 6312.4 6366.3 6428.5 6437.4 6270.2 6271.5 6278.8 6283.9 6293.8 6194.7 6244.3 6272.3 6283.5 6287.9 5117.7 5147.6 5163.2 5190.3 5192.4 4546.4 4637.6 4647.3 4667.7 4684.9 5979.9 6003.4 6121.2 6125.1 6131.5 6366.0 6413.3 6415.6 6416.5 6429.7 5879.0 6051.9 6089.8 6128.0 6169.4 5548.5 5581.5 5589.9 5599.7 5667.9 6626.2 6652.5 6653.2 6655.1 6681.6 6210.2 6278.4 6416.7 6428.0 6430.5 6394.2 6481.9 6490.7 6492.0 6496.3 6230.5 6257.3 6266.9 6285.5 6312.6 6414.3 6447.4 6472.0 6480.8 6491.9 6123.6 6293.2 6310.9 6313.8 6319.3 5147.7 6198.7 6204.3 6324.7 6329.3 6277.5 6295.9 6301.7 6318.5 6345.8 6170.7 6323.2 6334.8 6352.7 6372.0 6153.3 6205.1 6212.1 6300.2 6327.6 16:54:06 INFO - 2015-11-19 16:54:06,085 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,086 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:68631.39 Median:35123.74 stddev:149516.77 (425.7%) stddev-sans-first:149848.77 16:54:06 INFO - 2015-11-19 16:54:06,087 DEBUG : BROWSER_OUTPUT: Values: 527.7 561.8 605.8 614.2 633.8 31637.5 32217.7 32370.0 32696.8 40863.8 43655.0 43741.7 44089.9 44102.6 44105.0 9721.3 9919.2 9944.2 9951.8 9957.4 8900.2 8955.6 8980.5 8981.2 9693.7 8778.1 8847.9 11893.8 12020.2 12021.4 11761.9 11843.9 11851.3 11854.8 11864.1 8316.0 10123.7 11121.4 11856.0 11869.0 31872.0 32207.5 40786.6 40819.0 40897.0 3260.7 3327.7 3334.2 3472.5 3544.4 28115.6 28663.0 28777.7 28818.9 28959.0 2568.6 2580.8 2609.7 2647.6 2739.3 451233.0 452725.0 453688.5 453794.7 454399.7 64260.0 64515.7 64546.0 64569.0 64713.0 66877.7 67072.7 67107.7 67113.0 67182.0 15388.8 16385.4 16563.4 16571.7 16579.9 11496.8 11524.7 11544.9 11562.0 11564.3 17178.2 21796.7 22573.5 22580.3 22626.8 7835.1 8784.9 8911.1 8971.7 8984.3 867.6 931.2 966.5 969.3 1140.3 30125.0 32859.2 32881.3 33676.5 33843.8 906.5 1022.4 1069.6 1093.8 1222.5 14625.8 14782.6 14879.3 14926.0 15259.2 673590.0 681202.0 681529.0 682069.0 682823.0 58137.7 58368.4 58404.1 58443.0 58463.7 1413.7 1424.8 1432.4 1432.5 1577.7 28775.5 28831.6 29088.9 29182.7 29224.4 50395.5 50969.0 50989.2 51057.0 51115.5 510477.0 510967.0 512348.0 526529.4 537170.0 28819.1 33294.0 33370.5 33432.0 33464.8 40660.6 41191.4 41332.0 41617.6 41805.6 35238.5 35333.5 35892.0 36217.1 36230.8 34403.5 34848.5 34992.1 36037.0 36422.6 35009.0 35466.6 36007.5 36036.5 36348.0 30518.5 32296.0 32322.8 32349.4 32388.8 20829.4 24052.9 24295.6 24312.8 24657.6 16:54:06 INFO - 2015-11-19 16:54:06,087 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,087 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36381.36 Median:25072.98 stddev:123701.33 (493.4%) stddev-sans-first:124018.76 16:54:06 INFO - 2015-11-19 16:54:06,088 DEBUG : BROWSER_OUTPUT: Values: 351.4 354.5 359.5 360.0 365.9 15330.3 16516.4 19664.5 20170.8 20872.6 15643.0 17639.6 20119.9 20316.8 20519.9 5726.6 5730.3 5860.3 5872.2 5876.1 4254.4 4373.2 4374.5 5816.7 5887.8 6250.3 6368.3 6424.0 6429.4 6431.2 6231.5 6388.7 6401.8 6405.8 6429.3 5517.4 5523.0 5527.2 5530.3 5551.2 13673.1 13768.1 13770.7 14063.7 14112.9 1878.2 1938.7 1946.4 1986.5 2058.8 9537.6 9538.6 9595.1 9939.1 10241.8 1591.1 1601.8 1625.3 1627.8 1656.9 90062.1 92964.5 94557.0 95226.5 95911.0 6669.9 6688.3 6704.5 6762.5 6777.1 6709.6 7707.4 7725.3 7726.7 7733.0 5623.9 5645.7 5656.6 5679.9 5706.1 6092.9 6130.7 6150.6 6163.2 6171.6 2983.6 2997.9 3001.0 3022.6 3024.0 917.7 1043.8 1086.4 1109.3 1135.9 429.6 452.4 452.9 463.8 464.6 12045.6 12250.8 12282.0 12329.4 12366.0 431.8 484.0 485.9 488.0 494.7 5050.3 6342.2 6531.6 6623.8 6625.2 660301.0 758767.0 764777.0 779426.0 779431.0 114790.9 118589.0 119136.0 119425.6 121122.0 523.4 543.1 543.7 543.7 544.9 11611.9 11783.4 11903.8 11918.8 12135.7 49651.3 52493.0 52791.2 53158.7 53498.0 63043.0 72366.6 73119.0 74256.5 74606.5 6347.9 6378.7 6463.9 6465.9 6466.0 12479.9 12670.4 12776.4 12783.0 12816.9 11023.6 11114.5 11146.7 11234.8 11332.3 10842.8 10906.0 10984.2 11162.6 11304.4 9391.8 9441.4 11098.4 11287.5 11350.4 6187.3 6347.1 6462.8 6470.0 6483.4 10626.0 10756.8 10819.0 11055.9 11082.7 16:54:06 INFO - 2015-11-19 16:54:06,088 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,088 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5782.56 Median:6176.33 stddev:3019.27 (48.9%) stddev-sans-first:3009.80 16:54:06 INFO - 2015-11-19 16:54:06,090 DEBUG : BROWSER_OUTPUT: Values: 1403.3 1564.0 1566.0 1727.2 1911.1 7247.8 7619.8 8000.5 8096.0 8105.6 7084.9 7610.6 8341.8 8345.0 8351.7 2086.1 2128.3 2361.9 2383.2 2384.5 2140.2 2371.0 2387.6 2390.5 2402.4 2317.4 2340.5 2356.1 2382.3 2388.0 2084.2 2132.5 2137.2 2347.7 2380.2 2137.8 2137.9 2328.3 2360.4 2366.2 8360.9 8470.0 8470.8 8478.1 8480.4 5109.0 5146.3 5160.4 5169.8 5186.5 3440.4 3500.6 3560.8 3570.2 3586.1 1038.8 1053.8 1066.7 1082.5 1083.2 11002.6 11016.2 11016.6 11029.4 11033.8 4592.8 4594.9 4615.9 4648.5 4664.1 9627.0 9637.3 9638.2 9650.8 9652.5 5177.2 5187.2 5196.4 5200.4 5202.1 4693.3 4737.9 4744.2 4746.0 4764.4 3741.8 3828.9 3853.8 3856.9 3859.7 1250.6 1254.7 1255.4 1260.9 1267.0 1330.9 1346.1 1357.0 1362.9 1371.5 7680.3 7862.0 7866.6 7868.6 7880.3 501.3 503.6 505.1 509.1 513.4 5632.5 5727.9 6139.6 6213.1 6225.1 9189.0 9939.0 9958.2 9986.1 10100.0 9695.4 9880.8 9948.2 10032.9 10046.4 7764.6 7835.5 7847.9 7902.2 7925.2 7544.5 7732.3 7772.0 7783.1 7785.9 8646.2 8975.1 9023.5 9087.0 9168.1 9129.1 9328.4 9341.1 9392.4 9452.9 7019.5 7238.5 7291.3 7307.0 7346.8 7849.4 7968.4 7999.6 8002.1 8008.3 7378.4 7503.0 7516.9 7626.5 7662.6 7372.3 7396.7 7435.6 7472.3 7480.9 7463.2 7475.1 7497.5 7520.6 7541.4 6764.4 6824.4 6844.9 6865.4 6868.0 6962.1 6997.8 7007.6 7007.6 7012.9 16:54:06 INFO - 2015-11-19 16:54:06,090 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,090 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6117.08 Median:6972.63 stddev:1985.82 (28.5%) stddev-sans-first:1943.09 16:54:06 INFO - 2015-11-19 16:54:06,090 DEBUG : BROWSER_OUTPUT: Values: 317.2 323.6 326.2 327.3 329.2 6283.5 6716.5 6983.7 6985.9 6995.9 6879.2 6882.8 6907.2 6908.5 6961.6 4923.9 5077.5 5082.9 5089.5 5092.6 5048.3 5052.5 5061.3 5062.2 5109.3 4993.6 5026.6 5029.9 5030.4 5038.9 4813.8 4877.2 4914.4 5028.4 5035.3 4151.3 4259.1 4264.6 4265.8 4268.2 6598.7 6670.1 6681.7 6689.4 6697.7 5690.0 5725.2 5839.6 5990.1 5999.8 6893.4 7357.2 7388.6 7488.3 7492.9 4818.1 4836.2 4836.6 4841.1 4855.0 7701.7 7931.6 7943.4 7951.2 7994.0 4970.8 4988.3 4990.9 4996.9 5009.0 5071.2 5088.2 5090.8 5099.5 5099.6 5044.7 6019.4 6020.4 6030.8 6031.1 7334.1 7509.8 7519.5 7522.7 7539.8 1732.8 1757.6 1759.8 1764.5 1768.2 961.0 969.1 1136.8 1137.2 1147.2 7035.4 7053.3 7068.0 7074.3 7082.3 7777.7 7790.1 7794.8 7799.9 7806.5 6297.5 6550.2 7036.5 7040.4 7066.8 4013.0 4091.2 4100.6 4142.2 4145.8 6403.9 7992.6 8200.9 8211.8 8220.8 8090.9 8152.3 8156.7 8175.4 8191.4 7901.2 8177.8 8187.4 8192.0 8193.1 6498.3 7873.8 7878.6 7878.7 7883.3 7469.0 7686.9 7701.0 7722.6 7728.5 8189.2 8189.6 8189.7 8190.4 8195.6 4782.6 4836.6 4841.9 4842.4 4842.9 6481.7 7641.6 7829.1 7857.5 7880.2 7548.8 7577.6 7587.4 7588.8 7592.2 7277.0 7526.0 7528.7 7539.9 7547.6 7372.9 7384.1 7395.2 7396.6 7403.7 7573.2 7573.5 7575.5 7583.8 7620.5 7169.1 7403.4 7407.3 7407.5 7418.3 16:54:06 INFO - 2015-11-19 16:54:06,090 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,091 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17583.00 Median:29232.63 stddev:25235.05 (86.3%) stddev-sans-first:25274.08 16:54:06 INFO - 2015-11-19 16:54:06,092 DEBUG : BROWSER_OUTPUT: Values: 721.6 727.6 780.4 822.5 844.4 13046.7 14578.3 15390.5 15391.3 15393.5 13596.0 13669.7 14102.1 14196.9 14220.2 933.6 954.4 956.7 959.7 960.2 946.2 959.0 959.4 959.4 960.5 986.7 998.9 1001.2 1001.5 1001.7 992.4 993.1 993.9 994.2 996.6 742.8 744.0 745.2 745.3 746.2 13299.0 13443.2 13581.0 13593.6 13603.8 10833.5 10917.5 11161.5 11479.1 11520.4 9468.6 9663.1 9675.1 9679.7 10037.4 3404.3 3454.3 3473.8 3478.7 3484.5 57884.0 70719.6 70812.0 72496.0 79072.2 7120.3 7177.3 7399.8 7464.7 7538.3 12709.2 12751.7 12787.2 12823.2 12930.5 6543.5 6604.3 6620.9 6621.9 6843.9 4076.1 4122.2 4124.4 4161.6 4350.5 3072.6 3084.2 3101.6 3109.8 3122.8 494.4 496.0 500.3 509.1 511.0 479.6 486.4 496.8 505.5 531.7 8175.0 8504.1 8654.0 8699.5 8876.6 484.1 494.9 581.3 584.6 616.2 3212.8 4025.6 4040.4 4066.3 4113.6 72703.0 72773.6 91614.5 93060.1 101591.4 77737.0 78646.6 79516.0 82644.6 82750.6 67318.7 73548.3 74696.1 75623.6 75920.2 8472.4 8748.0 9063.3 9102.4 9175.6 39104.8 50173.0 50380.0 50879.0 51715.4 64686.7 69014.7 71759.6 73076.6 76346.9 8076.5 8167.4 8245.0 8308.6 8315.7 11906.8 11922.5 12132.2 12316.4 12538.3 11222.3 11488.3 11586.9 11759.0 11786.0 11546.9 11575.4 11637.3 11744.4 12083.9 10660.9 10763.0 11095.4 11137.9 11658.7 9749.0 9754.4 9772.4 9936.9 9952.7 9262.6 9306.2 10015.4 10159.7 10160.4 16:54:06 INFO - 2015-11-19 16:54:06,093 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:54:06 INFO - 2015-11-19 16:54:06,093 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,530 INFO : Browser exited with error code: 0 16:54:06 INFO - 2015-11-19 16:54:06,555 INFO : Completed test dromaeo_css (00:18:33) 16:54:06 INFO - 2015-11-19 16:54:06,555 INFO : Starting test kraken 16:54:06 INFO - 2015-11-19 16:54:06,556 DEBUG : operating with platform_type : mac_ 16:54:06 INFO - 2015-11-19 16:54:06,556 INFO : Initialising browser for kraken test... 16:54:06 INFO - 2015-11-19 16:54:06,568 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpv5rFqT/profile http://localhost:50115/getInfo.html 16:54:08 INFO - 2015-11-19 16:54:08,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:08 INFO - 2015-11-19 16:54:08,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:08 INFO - 2015-11-19 16:54:08,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:54:08 INFO - 2015-11-19 16:54:08,585 DEBUG : BROWSER_OUTPUT: __metrics 16:54:08 INFO - 2015-11-19 16:54:08,602 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:09 INFO - 2015-11-19 16:54:09,228 INFO : Browser initialized. 16:54:09 INFO - 2015-11-19 16:54:09,229 INFO : Running cycle 1/1 for kraken test... 16:54:09 INFO - 2015-11-19 16:54:09,229 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpv5rFqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:20 INFO - 2015-11-19 16:54:20,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 225624064 16:54:20 INFO - 2015-11-19 16:54:20,994 DEBUG : BROWSER_OUTPUT: 16:54:23 INFO - 2015-11-19 16:54:23,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50115/tests/kraken/driver.html?testName=audio-beat-detection) 16:54:24 INFO - 2015-11-19 16:54:24,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 275271680 16:54:24 INFO - 2015-11-19 16:54:24,112 DEBUG : BROWSER_OUTPUT: 16:54:26 INFO - 2015-11-19 16:54:26,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50115/tests/kraken/driver.html?testName=audio-dft) 16:54:27 INFO - 2015-11-19 16:54:27,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 289013760 16:54:27 INFO - 2015-11-19 16:54:27,228 DEBUG : BROWSER_OUTPUT: 16:54:30 INFO - 2015-11-19 16:54:30,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50115/tests/kraken/driver.html?testName=audio-fft) 16:54:31 INFO - 2015-11-19 16:54:31,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 273776640 16:54:31 INFO - 2015-11-19 16:54:31,041 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50115/tests/kraken/driver.html?testName=audio-oscillator) 16:54:33 INFO - 2015-11-19 16:54:33,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 276459520 16:54:33 INFO - 2015-11-19 16:54:33,497 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2015-11-19 16:54:35,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:36 INFO - 2015-11-19 16:54:36,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 279040000 16:54:36 INFO - 2015-11-19 16:54:36,080 DEBUG : BROWSER_OUTPUT: 16:54:38 INFO - 2015-11-19 16:54:38,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50115/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:39 INFO - 2015-11-19 16:54:39,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 279789568 16:54:39 INFO - 2015-11-19 16:54:39,494 DEBUG : BROWSER_OUTPUT: 16:54:42 INFO - 2015-11-19 16:54:42,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50115/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:42 INFO - 2015-11-19 16:54:42,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 279896064 16:54:42 INFO - 2015-11-19 16:54:42,896 DEBUG : BROWSER_OUTPUT: 16:54:45 INFO - 2015-11-19 16:54:45,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50115/tests/kraken/driver.html?testName=json-parse-financial) 16:54:46 INFO - 2015-11-19 16:54:46,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 279617536 16:54:46 INFO - 2015-11-19 16:54:46,332 DEBUG : BROWSER_OUTPUT: 16:54:47 INFO - 2015-11-19 16:54:47,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:48 INFO - 2015-11-19 16:54:48,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 312487936 16:54:48 INFO - 2015-11-19 16:54:48,429 DEBUG : BROWSER_OUTPUT: 16:54:50 INFO - 2015-11-19 16:54:50,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:50 INFO - 2015-11-19 16:54:50,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 312147968 16:54:50 INFO - 2015-11-19 16:54:50,829 DEBUG : BROWSER_OUTPUT: 16:54:52 INFO - 2015-11-19 16:54:52,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:53 INFO - 2015-11-19 16:54:53,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 321306624 16:54:53 INFO - 2015-11-19 16:54:53,466 DEBUG : BROWSER_OUTPUT: 16:54:55 INFO - 2015-11-19 16:54:55,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:56 INFO - 2015-11-19 16:54:56,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 322592768 16:54:56 INFO - 2015-11-19 16:54:56,579 DEBUG : BROWSER_OUTPUT: 16:54:59 INFO - 2015-11-19 16:54:59,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:59 INFO - 2015-11-19 16:54:59,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 321794048 16:54:59 INFO - 2015-11-19 16:54:59,645 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50115/tests/kraken/driver.html?testName=ai-astar) 16:55:01 INFO - 2015-11-19 16:55:01,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 381468672 16:55:01 INFO - 2015-11-19 16:55:01,690 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,690 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;110;111;111;110;111;102;110 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;121;143;155;120;133;139;116;155;121 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;184;183;181;184;184;186;183;187;181 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;65;72;73;55;56;58;72;80;53 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;84;118;75;74;75;113;74;75;114 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;88;87;89;80;123;124;102;86;89 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;95;93;95;95;93;94;103;123;92 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;89;87;85;100;121;124;131;86;87 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;55;54;55;56;57;66;54;54 16:55:01 INFO - 2015-11-19 16:55:01,691 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;67;68;67;67;66;69 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;84;81;84;81;81;82;84;82 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;118;112;126;118;121;123;106;119;123 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;108;140;170;142;137;137;137;135;125 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;67;84;86;86;88;73;65;65 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1090 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980901684__endTimestamp 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:55:01 INFO - 2015-11-19 16:55:01,692 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.13 (2.8%) stddev-sans-first:3.32 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 110.0 111.0 111.0 110.0 111.0 102.0 110.0 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.40 Median:141.00 stddev:15.33 (10.9%) stddev-sans-first:15.19 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: Values: 151.0 121.0 143.0 155.0 120.0 133.0 139.0 116.0 155.0 121.0 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.89 (1.0%) stddev-sans-first:2.00 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: Values: 184.0 184.0 183.0 181.0 184.0 184.0 186.0 183.0 187.0 181.0 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.30 Median:70.50 stddev:9.29 (13.2%) stddev-sans-first:9.75 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: Values: 69.0 65.0 72.0 73.0 55.0 56.0 58.0 72.0 80.0 53.0 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,693 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.70 Median:75.00 stddev:18.62 (24.8%) stddev-sans-first:19.70 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 118.0 75.0 74.0 75.0 113.0 74.0 75.0 114.0 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:87.50 stddev:15.67 (17.9%) stddev-sans-first:16.38 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 87.0 89.0 80.0 123.0 124.0 102.0 86.0 89.0 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:97.70 Median:94.00 stddev:9.39 (10.0%) stddev-sans-first:9.87 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 93.0 95.0 95.0 93.0 94.0 103.0 123.0 92.0 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:99.50 Median:85.50 stddev:18.50 (21.6%) stddev-sans-first:18.86 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: Values: 85.0 89.0 87.0 85.0 100.0 121.0 124.0 131.0 86.0 87.0 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:3.62 (6.4%) stddev-sans-first:3.81 16:55:01 INFO - 2015-11-19 16:55:01,694 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 55.0 54.0 55.0 56.0 57.0 66.0 54.0 54.0 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:67.00 stddev:1.89 (2.8%) stddev-sans-first:1.86 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 67.0 68.0 67.0 67.0 66.0 69.0 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 84.0 81.0 84.0 81.0 81.0 82.0 84.0 82.0 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:122.00 stddev:6.06 (5.0%) stddev-sans-first:6.15 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: Values: 124.0 118.0 112.0 126.0 118.0 121.0 123.0 106.0 119.0 123.0 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.80 Median:138.50 stddev:15.65 (11.3%) stddev-sans-first:16.25 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: Values: 147.0 108.0 140.0 170.0 142.0 137.0 137.0 137.0 135.0 125.0 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: 16:55:01 INFO - 2015-11-19 16:55:01,695 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:78.50 stddev:10.21 (13.0%) stddev-sans-first:10.36 16:55:01 INFO - 2015-11-19 16:55:01,696 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 84.0 86.0 86.0 88.0 73.0 65.0 65.0 16:55:01 INFO - 2015-11-19 16:55:01,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:01 INFO - 2015-11-19 16:55:01,696 DEBUG : BROWSER_OUTPUT: 16:55:02 INFO - 2015-11-19 16:55:02,330 INFO : Browser exited with error code: 0 16:55:02 INFO - 2015-11-19 16:55:02,377 INFO : Completed test kraken (00:00:55) 16:55:02 INFO - 2015-11-19 16:55:02,377 INFO : Starting test v8_7 16:55:02 INFO - 2015-11-19 16:55:02,377 DEBUG : operating with platform_type : mac_ 16:55:02 INFO - 2015-11-19 16:55:02,377 INFO : Initialising browser for v8_7 test... 16:55:02 INFO - 2015-11-19 16:55:02,389 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmp2bbOJZ/profile http://localhost:50115/getInfo.html 16:55:04 INFO - 2015-11-19 16:55:04,336 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:55:04 INFO - 2015-11-19 16:55:04,336 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:55:04 INFO - 2015-11-19 16:55:04,336 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:55:04 INFO - 2015-11-19 16:55:04,336 DEBUG : BROWSER_OUTPUT: __metrics 16:55:04 INFO - 2015-11-19 16:55:04,352 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:05 INFO - 2015-11-19 16:55:05,036 INFO : Browser initialized. 16:55:05 INFO - 2015-11-19 16:55:05,036 INFO : Running cycle 1/1 for v8_7 test... 16:55:05 INFO - 2015-11-19 16:55:05,036 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmp2bbOJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:55:16 INFO - 2015-11-19 16:55:16,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 228356096 16:55:16 INFO - 2015-11-19 16:55:16,934 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50115/tests/v8_7/run.html (next: http://localhost:50115/tests/v8_7/run.html) 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 586858496 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: |0;Richards;146.37002341920376 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.26431220770843 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.8489289740699 16:55:38 INFO - 2015-11-19 16:55:38,627 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4822.115384615385 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1705.281090289608 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |6;Boyer;12662.5 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |8;Splay;750.1875468867216 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980938622__endTimestamp 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.37 Median:146.37 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,628 DEBUG : BROWSER_OUTPUT: Values: 146.4 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.26 Median:161.26 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: Values: 161.3 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: Values: 281.8 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: Values: 4822.1 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1705.28 Median:1705.28 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: Values: 1705.3 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,629 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: Values: 789.9 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12662.50 Median:12662.50 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: Values: 12662.5 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: Values: 27189.2 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:750.19 Median:750.19 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: Values: 750.2 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: Values: 4533.9 16:55:38 INFO - 2015-11-19 16:55:38,630 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:38 INFO - 2015-11-19 16:55:38,631 DEBUG : BROWSER_OUTPUT: 16:55:39 INFO - 2015-11-19 16:55:39,406 INFO : Browser exited with error code: 0 16:55:39 INFO - 2015-11-19 16:55:39,423 INFO : Completed test v8_7 (00:00:37) 16:55:39 INFO - 2015-11-19 16:55:39,721 INFO : Completed test suite (00:20:06) 16:55:39 INFO - 2015-11-19 16:55:39,721 DEBUG : Working with test: dromaeo_css 16:55:39 INFO - 2015-11-19 16:55:39,721 DEBUG : Generating results file: dromaeo_css 16:55:39 INFO - 2015-11-19 16:55:39,722 DEBUG : Working with test: kraken 16:55:39 INFO - 2015-11-19 16:55:39,722 DEBUG : Generating results file: kraken 16:55:39 INFO - 2015-11-19 16:55:39,722 INFO : javascript benchmark 16:55:39 INFO - 2015-11-19 16:55:39,722 DEBUG : Working with test: v8_7 16:55:39 INFO - 2015-11-19 16:55:39,722 DEBUG : Generating results file: v8_7 16:55:39 INFO - 2015-11-19 16:55:39,723 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:39 INFO - 2015-11-19 16:55:39,773 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:55:39 INFO - 2015-11-19 16:55:39,774 DEBUG : process_Request line: dromaeo_css 7290.08 graph.html#tests=[[72,64,59]] 16:55:39 INFO - 2015-11-19 16:55:39,774 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:39 INFO - 2015-11-19 16:55:39,802 DEBUG : process_Request line: kraken 1410.80 graph.html#tests=[[232,64,59]] 16:55:39 INFO - 2015-11-19 16:55:39,803 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:39 INFO - 2015-11-19 16:55:39,835 DEBUG : process_Request line: v8_7 20373.94 graph.html#tests=[[230,64,59]] 16:55:39 INFO - 2015-11-19 16:55:39,836 INFO : javascript benchmark 16:55:39 INFO - 2015-11-19 16:55:39,838 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2946.5432857907026, 3494.6505349465074, 3530.064532898782, 3535.71714262859, 3550.467429885516, 5786.768529258835, 5875.059990401536, 6073.149759033733, 6111.969440152804, 6125.479334256588, 5992.250968628921, 6003.819885403434, 6062.787802426916, 6067.696615169235, 6114.449440885034, 5350.2777125088105, 5396.43337449568, 5401.594880383967, 5406.59450541209, 5444.8366549003595, 5474.7810087596645, 5486.945130548704, 5537.307836520435, 5545.223668686367, 5570.108782594785, 5265.210218467222, 5266.2100684897, 5355.384130824966, 5383.973080134574, 5455.809046683366, 5428.565714742811, 5430.022595932731, 5449.972750136264, 5460.6177567570285, 5464.23500709901, 5355.6251062425645, 5365.624406291561, 5388.5958553108285, 5411.134218525017, 5416.539594134503, 5791.681457519835, 5870.97064514679, 5926.703664816785, 5965.313988891289, 6080.087986801971, 6353.174087368612, 6366.140571022946, 6375.45808606269, 6380.968095159541, 6390.13733146024, 6432.131662225634, 6441.935580644227, 6442.452391546724, 6455.289918109004, 6469.967650161719, 5962.612430192067, 6037.09443583466, 6139.662318572521, 6210.161628180228, 6225.501959843247, 5423.240746295522, 6624.900626490607, 6625.3374662534325, 6646.8005959821285, 6663.36698013688, 6244.344343843922, 6297.748090076438, 6308.148399966038, 6308.432241098323, 6308.905366419507, 6218.129461875341, 6312.400321969406, 6366.331535188831, 6428.5178611604315, 6437.356264373525, 6270.184875966095, 6271.4669253114, 6278.811635650938, 6283.937160628427, 6293.842653933688, 6194.690265486708, 6244.344343843922, 6272.3100458949475, 6283.497320214372, 6287.931051721218, 5117.667351622133, 5147.613928955268, 5163.225516172604, 5190.2993095932325, 5192.428832828386, 4546.431696037996, 4637.582617564435, 4647.279671650899, 4667.696599721007, 4684.906301874012, 5979.940200597938, 6003.369646187088, 6121.204243448323, 6125.142480052797, 6131.50947924165, 6365.968170159213, 6413.3266007069515, 6415.582987105823, 6416.454601358937, 6429.678516074177, 5879.0, 6051.939480605226, 6089.8477538061015, 6127.969360153171, 6169.383061693885, 5548.472895074961, 5581.49766521015, 5589.916151257735, 5599.720013999284, 5667.886642267132, 6626.244045327992, 6652.467802575879, 6653.234877988996, 6655.134832471845, 6681.599104053772, 6210.223722034746, 6278.4035516625845, 6416.743330266737, 6428.035794630843, 6430.48556115519, 6394.168758061608, 6481.870362592627, 6490.740370385131, 6492.0, 6496.317886622026, 6230.470410015199, 6257.342978987141, 6266.905996410149, 6285.49716022708, 6312.558120931674, 6414.326495717883, 6447.4197322241225, 6472.0, 6480.773172938924, 6491.902621460777, 6123.608384081089, 6293.244810622571, 6310.936890631035, 6313.779017734541, 6319.3364696706185, 5147.742612869416, 6198.721057552511, 6204.255489341308, 6324.747010119728, 6329.303776584664, 6277.497800176066, 6295.874082518416, 6301.684915754286, 6318.526110541819, 6345.809625711236, 6170.660613666291, 6323.241211054703, 6334.841628959313, 6352.682365881595, 6371.96814015927, 6153.261608606996, 6205.100260462117, 6212.099245609271, 6300.180976473029, 6327.588706734047], "unit": "ms", "name": "dojo.html", "value": 5907.2147502098505}, {"lowerIsBetter": false, "replicates": [527.7269841871395, 561.7865211219736, 605.8091701114149, 614.2260751453168, 633.8288662061246, 31637.525437118435, 32217.677823221733, 32369.982652688843, 32696.836515817446, 40863.77408677737, 43655.0, 43741.68774936749, 44089.89775255612, 44102.55897441025, 44105.0, 9721.31950763447, 9919.156871665917, 9944.15474684649, 9951.75120621983, 9957.402555846636, 8900.154485323885, 8955.596998135099, 8980.46117232965, 8981.191692747652, 9693.70918872435, 8778.078301778318, 8847.911520884772, 11893.762124757499, 12020.21868578544, 12021.398930053507, 11761.882381176165, 11843.881561184364, 11851.288922664668, 11854.762904741858, 11864.110191735654, 8316.0, 10123.696289111338, 11121.443927803577, 11856.0, 11868.991135753471, 31872.043838684876, 32207.51688724671, 40786.59213407858, 40818.9795255118, 40897.0, 3260.675006463666, 3327.7005069543857, 3334.233126380946, 3472.5485686860798, 3544.4151714967, 28115.57826632602, 28663.0, 28777.712222877923, 28818.85590572034, 28958.986435474657, 2568.576184929503, 2580.8193426460157, 2609.699884513286, 2647.6293318935363, 2739.301478123086, 451233.0, 452725.0, 453688.4631153679, 453794.73102634604, 454399.7280013612, 64260.0, 64515.67742161259, 64546.0, 64569.0, 64713.0, 66877.66561167163, 67072.6646366765, 67107.66446167836, 67113.0, 67182.0, 15388.846111538965, 16385.42651007209, 16563.42028029013, 16571.6685666286, 16579.91710041442, 11496.77006459866, 11524.654260372203, 11544.88455115455, 11562.01722853567, 11564.306141631529, 17178.15687653869, 21796.74963382157, 22573.54852902933, 22580.322590322317, 22626.773732262795, 7835.138134805167, 8784.912150878537, 8911.108889111038, 8971.730848074569, 8984.281257499384, 867.5662168915542, 931.1945167430259, 966.4539535162611, 969.2536746704998, 1140.3386036099043, 30125.0, 32859.17852053718, 32881.3423731524, 33676.494852577234, 33843.830780845936, 906.5059542549326, 1022.4325499347784, 1069.6256310291492, 1093.797647435227, 1222.45600707686, 14625.78061329081, 14782.556523304318, 14879.33043013067, 14926.0, 15259.160746158846, 673590.0, 681202.0, 681529.0, 682069.0, 682823.0, 58137.709311453174, 58368.4163158363, 58404.12393814096, 58443.0, 58463.70768146132, 1413.6748547834056, 1424.8361438434713, 1432.427029188333, 1432.4986254810733, 1577.668689575202, 28775.54873262378, 28831.5675264867, 29088.854555727085, 29182.708172918, 29224.41551168922, 50395.49604504055, 50968.98062038665, 50989.235161471865, 51057.0, 51115.488845111075, 510477.0, 510967.0, 512348.0, 526529.3673531607, 537170.0, 28819.135425937257, 33294.0, 33370.499442508866, 33432.0, 33464.832675836464, 40660.59339406568, 41191.382129267484, 41332.0, 41617.58382416137, 41805.58194418017, 35238.471422929186, 35333.469997949534, 35892.0, 36217.094572634844, 36230.81884590666, 34403.4839477403, 34848.47727284143, 34992.125196870285, 36037.0, 36422.63577364192, 35009.0, 35466.64533354634, 36007.45988810118, 36036.457348682765, 36348.0, 30518.542221866246, 32296.031119066465, 32322.83838580792, 32349.35301293914, 32388.83805580957, 20829.373564583755, 24052.87973560121, 24295.63556546618, 24312.839330886873, 24657.63013554834], "unit": "ms", "name": "ext.html", "value": 20025.57474415517}, {"lowerIsBetter": false, "replicates": [351.3920916813912, 354.459449339757, 359.5326076101068, 359.99640003599956, 365.93961996270616, 15330.310136043878, 16516.42192523262, 19664.508387290323, 20170.798292017076, 20872.582548349044, 15643.0, 17639.5590110247, 20119.899400503014, 20316.796832031676, 20519.897400513015, 5726.599138060337, 5730.255066841326, 5860.296764388279, 5872.17789509469, 5876.08920617305, 4254.4469219001485, 4373.1690978714105, 4374.475062992446, 5816.680082595455, 5887.8233652990475, 6250.312465628777, 6368.267649220353, 6424.0, 6429.35706429358, 6431.163948686688, 6231.5326350523665, 6388.744450221986, 6401.807945761635, 6405.8398540036405, 6429.260635026938, 5517.420670829545, 5522.972385138089, 5527.170924361338, 5530.2810634617645, 5551.195076713894, 13673.111247768864, 13768.105073170213, 13770.65573360664, 14063.695031667652, 14112.858871411257, 1878.2205384765307, 1938.6510428122933, 1946.3577019583645, 1986.483514286296, 2058.8147066763913, 9537.618495260182, 9538.570764315622, 9595.13643772064, 9939.105480506716, 10241.84637230442, 1591.077175238359, 1601.767743677172, 1625.325489921681, 1627.8453546913142, 1656.9088700121488, 90062.09937900669, 92964.53517732368, 94557.0, 95226.52386738022, 95911.0408895909, 6669.899951500732, 6688.264290927994, 6704.463642908556, 6762.4928130389435, 6777.1189745332795, 6709.597424154566, 7707.383409327241, 7725.304722574995, 7726.690932362755, 7733.033370828646, 5623.887522249532, 5645.689487078168, 5656.575756818255, 5679.943200568024, 5706.115552089433, 6092.878142437126, 6130.693465326716, 6150.569460137747, 6163.229596300463, 6171.5988460750805, 2983.612130423031, 2997.895073672411, 3000.969990300069, 3022.6070610820893, 3024.0, 917.7017469322363, 1043.7651528406047, 1086.41333679812, 1109.2734259060328, 1135.8807325230732, 429.64554242749233, 452.38927447945014, 452.86187712747267, 463.7866581372539, 464.64454692160524, 12045.578404755792, 12250.774922507679, 12282.0, 12329.383530823423, 12366.010719142447, 431.7927394850489, 483.9709617422966, 485.85181519636143, 487.9756012199376, 494.70317809314844, 5050.3434553507805, 6342.1931880516995, 6531.575447595986, 6623.801285961429, 6625.204975402886, 660300.9849507601, 758767.0, 764777.0, 779426.0, 779431.0, 114790.85209147968, 118589.0, 119136.0, 119425.61148776975, 121122.0, 523.3876364653364, 543.1364131031679, 543.6873797566415, 543.7335705504354, 544.8882978989297, 11611.941940290244, 11783.351915644722, 11903.761924761284, 11918.761624767629, 12135.696607584881, 49651.25523117228, 52492.95014099773, 52791.20813187882, 53158.73420632872, 53498.0, 63043.0, 72366.63816680883, 73119.0, 74256.51486970339, 74606.50786984121, 6347.873042539031, 6378.744850206125, 6463.903041454476, 6465.870682586416, 6466.0, 12479.939205167662, 12670.366481676063, 12776.36118194068, 12783.0, 12816.87183128194, 11023.559057637605, 11114.499847507042, 11146.665600032013, 11234.831477528007, 11332.263402878787, 10842.837357439486, 10905.963933426312, 10984.231103822656, 11162.55349786032, 11304.434778261219, 9391.765205869635, 9441.433513989183, 11098.389588572383, 11287.548498059985, 11350.432478376213, 6187.257529096537, 6347.127121167124, 6462.838429039311, 6469.967650161719, 6483.4164925156965, 10625.990530899553, 10756.83864742045, 10819.0, 11055.889441105486, 11082.722931926766], "unit": "ms", "name": "jquery.html", "value": 7584.138294318914}, {"lowerIsBetter": false, "replicates": [1403.3474434388008, 1563.9530814075574, 1565.9608509787254, 1727.2054854766807, 1911.149538455387, 7247.782566522999, 7619.771406857796, 8000.479968802024, 8096.0, 8105.635246413911, 7084.8583028339535, 7610.592040472517, 8341.791455213608, 8344.958275208615, 8351.74944751657, 2086.0508468646804, 2128.3082998025625, 2361.8700971446565, 2383.1539803369815, 2384.4515761374896, 2140.165335519149, 2370.9762902370926, 2387.617981123021, 2390.5457962987066, 2402.4354276744953, 2317.385892738426, 2340.508493216427, 2356.1282325539573, 2382.273406610983, 2387.9880600597057, 2084.1663334666105, 2132.4668832791804, 2137.241279345825, 2347.6830627865274, 2380.1907351500486, 2137.7648458669532, 2137.8824164670937, 2328.2665960222644, 2360.3745007573007, 2366.19549353219, 8360.874586881202, 8469.95765021177, 8470.78823029423, 8478.06741258461, 8480.406371553994, 5109.0, 5146.253793200002, 5160.432352441228, 5169.793208271664, 5186.5332120109, 3440.36353274645, 3500.6499350065046, 3560.8041557714314, 3570.1610121621397, 3586.103474131467, 1038.8182068138121, 1053.8208504554243, 1066.7013236293851, 1082.4641802307829, 1083.2309060567006, 11002.559897604166, 11016.17378696601, 11016.559337626566, 11029.44852757359, 11033.779324413546, 4592.816287348469, 4594.908101837945, 4615.9076818463445, 4648.48866624671, 4664.067186562701, 9627.0, 9637.313470142697, 9638.180754635934, 9650.841898972169, 9652.469114198786, 5177.223416487557, 5187.221916712448, 5196.350456192976, 5200.427952925175, 5202.115640341151, 4693.296005599119, 4737.881552961135, 4744.217204161344, 4746.0, 4764.356811830427, 3741.7567858089137, 3828.8851334459455, 3853.807309634507, 3856.9035774105873, 3859.671927886161, 1250.6310638361706, 1254.6926003129292, 1255.4413286087786, 1260.9243445393306, 1266.9809952850715, 1330.8602596727205, 1346.1115663661935, 1356.966075848092, 1362.8773410393112, 1371.4651285998468, 7680.270374314431, 7861.960690196513, 7866.606669666494, 7868.606569671493, 7880.290773830383, 501.2831650739405, 503.58705861194204, 505.05806670559144, 509.1192237429194, 513.3993227923339, 5632.4930756231315, 5727.914081288784, 6139.57023008394, 6213.099100630383, 6225.097360882737, 9189.0, 9939.0, 9958.15355694774, 9986.102640498282, 10100.0, 9695.418274903528, 9880.802383952425, 9948.154406875497, 10032.899671003343, 10046.397216167054, 7764.61176941162, 7835.529868207926, 7847.882281765778, 7902.17027212146, 7925.247101525461, 7544.47188696786, 7732.30409263169, 7771.961140194489, 7783.104942931635, 7785.948896898846, 8646.178613031752, 8975.147361000956, 9023.503707296162, 9087.045860184586, 9168.083191680778, 9129.087091291083, 9328.440293582407, 9341.11259430353, 9392.436453812794, 9452.858207126761, 7019.508634395544, 7238.52949558277, 7291.30732580404, 7307.0, 7346.816329591803, 7849.372050235853, 7968.36253099739, 7999.640016199169, 8002.07976082758, 8008.319292860172, 7378.409727221702, 7502.98709674187, 7516.887246691194, 7626.504277221963, 7662.616869156632, 7372.299631534996, 7396.704131834666, 7435.553866767795, 7472.252774722484, 7480.850382992418, 7463.17905030457, 7475.102987641518, 7497.512661676974, 7520.623968801428, 7541.35898448638, 6764.3573860483175, 6824.351686589766, 6844.8973265402055, 6865.41643960269, 6867.969804529361, 6962.094927659372, 6997.790066298019, 7007.579545227302, 7007.614581198083, 7012.894806578008], "unit": "ms", "name": "mootools.html", "value": 4656.895465962391}, {"lowerIsBetter": false, "replicates": [317.2417921168407, 323.64884100750686, 326.2219606239119, 327.2734529344854, 329.2082541487723, 6283.52873534485, 6716.462682985368, 6983.650817459125, 6985.860282794341, 6995.930040699592, 6879.208890977527, 6882.827929301758, 6907.205671347797, 6908.4818638602055, 6961.617111058889, 4923.852284431455, 5077.517635824591, 5082.92375614367, 5089.4910508949, 5092.618053645972, 5048.268001139832, 5052.469490703478, 5061.316722242487, 5062.2406639004075, 5109.284700141983, 4993.6005119590345, 5026.5727413169925, 5029.924551131718, 5030.37120359955, 5038.874028149307, 4813.78337974792, 4877.219644856806, 4914.419929536986, 5028.371453568304, 5035.295058691786, 4151.27352713277, 4259.084296876186, 4264.552222016675, 4265.808038638269, 4268.189044081614, 6598.736050557972, 6670.132882725215, 6681.699323530453, 6689.364510371555, 6697.732090716366, 5689.975804355215, 5725.198472213893, 5839.620424672383, 5990.101484777275, 5999.790007349722, 6893.4140598048725, 7357.153927298322, 7388.556686598821, 7488.251174882523, 7492.887606685904, 4818.060478206751, 4836.153673107192, 4836.637252206064, 4841.104395686809, 4855.028994201174, 7701.653425595861, 7931.643076061591, 7943.443958922878, 7951.244631759973, 7994.0, 4970.826021089245, 4988.251762235621, 4990.875228119254, 4996.926275595587, 5009.0, 5071.239314102841, 5088.211327244283, 5090.77091530882, 5099.515546023122, 5099.643024988215, 5044.672096313728, 6019.428154325332, 6020.367861374492, 6030.819075427744, 6031.095335699592, 7334.143498425181, 7509.774706758806, 7519.511231770027, 7522.6614802334025, 7539.8115047123165, 1732.8440440360428, 1757.6221112460883, 1759.81521940197, 1764.4971183212979, 1768.1777973242247, 960.9951950240344, 969.0715476202307, 1136.8294755786699, 1137.2494153858413, 1147.162571322939, 7035.437165026786, 7053.294670533009, 7068.045813815069, 7074.257202993715, 7082.256363081905, 7777.688892444352, 7790.104138024087, 7794.805129871798, 7799.922000780033, 7806.453548251568, 6297.4647154992335, 6550.246721626979, 7036.472264580075, 7040.401565866856, 7066.823329416806, 4012.9598704012587, 4091.2022155679356, 4100.630943215066, 4142.212979533879, 4145.79271036447, 6403.935960640427, 7992.560409177551, 8200.917990820015, 8211.7947051323, 8220.753377398687, 8090.919090809134, 8152.347812175011, 8156.67373305073, 8175.427720059539, 8191.385646076568, 7901.209879012053, 8177.754667359989, 8187.38594605407, 8192.0, 8193.09875913649, 6498.252700939263, 7873.763787086396, 7878.566678832719, 7878.72424465141, 7883.251091146332, 7468.9626551866895, 7686.9231307686205, 7700.95924579998, 7722.575258360844, 7728.536287822749, 8189.22202390772, 8189.631466584137, 8189.713360032609, 8190.355291895049, 8195.590220489072, 4782.569568738831, 4836.637252206028, 4841.903161936812, 4842.443119041214, 4842.854714358575, 6481.740730370921, 7641.579713115832, 7829.060512738508, 7857.528548287121, 7880.211978802074, 7548.811279717831, 7577.621118944141, 7587.430942679432, 7588.81027974305, 7592.240775922363, 7277.0, 7526.02161718973, 7528.661210245662, 7539.886901696588, 7547.5848828314965, 7372.926270737438, 7384.113906331059, 7395.223501532261, 7396.55620662762, 7403.703851845866, 7573.2048134945035, 7573.545587264782, 7575.469717119749, 7583.7724868254045, 7620.542767433972, 7169.068021157216, 7403.444741644291, 7407.2592740725495, 7407.481476296607, 7418.332350088518], "unit": "ms", "name": "prototype.html", "value": 5439.538304586284}, {"lowerIsBetter": false, "replicates": [721.5634541102633, 727.6325455644899, 780.3718007004359, 822.5106061893175, 844.4468872888252, 13046.673833154176, 14578.271086445675, 15390.461333853304, 15391.307391167396, 15393.538193854174, 13595.999999999975, 13669.726605467884, 14102.083364581295, 14196.929015354935, 14220.217888016155, 933.6452148183681, 954.4082668745388, 956.6747305915987, 959.6737109382808, 960.1742501448748, 946.191006689281, 958.9904100959005, 959.3524371049549, 959.4051687953444, 960.5149399553216, 986.6941248213041, 998.8501724741275, 1001.224051360198, 1001.534286556751, 1001.7145113642613, 992.3847214726879, 993.0764389118117, 993.9155171810405, 994.2046362909715, 996.6013594562161, 742.7771668499429, 743.9844612104492, 745.1951891956674, 745.2621904314743, 746.1605693594706, 13299.0, 13443.193408395528, 13581.0, 13593.59219223425, 13603.795943060863, 10833.458327083614, 10917.508712107974, 11161.497732602053, 11479.081673466186, 11520.366379849105, 9468.621255149787, 9663.130318271318, 9675.129238368581, 9679.66121185755, 10037.447940363278, 3404.3361544498835, 3454.29187016661, 3473.808940508271, 3478.7390945679176, 3484.494748261488, 57884.0, 70719.64640176766, 70812.0, 72495.99999999948, 79072.20927790707, 7120.323569260912, 7177.282271772885, 7399.778006659809, 7464.664090115958, 7538.283863033003, 12709.17390369623, 12751.68120796969, 12787.168834025759, 12823.166494178035, 12930.482780688668, 6543.476521878239, 6604.306547812506, 6620.9006864897065, 6621.9337806621315, 6843.863122737617, 4076.144009757925, 4122.175564886975, 4124.381342798604, 4161.604647558477, 4350.499692535335, 3072.6005619269354, 3084.228942764309, 3101.581286526335, 3109.8445077746023, 3122.8282444465317, 494.39930484461553, 496.0401622859778, 500.3170672032649, 509.0760270109739, 511.0468975360925, 479.6234955559938, 486.3580074301958, 496.8037625138123, 505.4642079395779, 531.6517680919004, 8175.0, 8504.107068757816, 8653.956730216309, 8699.478031318142, 8876.644934202688, 484.13823394357394, 494.8812285051562, 581.2588949089944, 584.5615788158881, 616.2204810914197, 3212.7590430717323, 4025.5974402560096, 4040.393940908887, 4066.2883995300704, 4113.568075352105, 72703.0, 72773.636131819, 91614.54192728993, 93060.06939930649, 101591.44429944917, 77737.0, 78646.6067669658, 79516.0, 82644.58677706693, 82750.58624706838, 67318.66340668265, 73548.26451735522, 74696.13259668552, 75623.62188189024, 75920.24079759132, 8472.406931514735, 8748.0, 9063.274938005075, 9102.386881384542, 9175.632974680939, 39104.804475977435, 50173.0, 50379.99240015106, 50879.0, 51715.44853654396, 64686.676566616865, 69014.65492672505, 71759.64120179365, 73076.63461682657, 76346.85479717697, 8076.515409075474, 8167.428280020579, 8245.010598728191, 8308.584570771316, 8315.667373305241, 11906.76186476283, 11922.463489142836, 12132.211406258564, 12316.384180791103, 12538.310392928477, 11222.270552414067, 11488.253263537843, 11586.88413115858, 11759.000484958533, 11786.0, 11546.896212200365, 11575.363355015555, 11637.301761893974, 11744.354060526754, 12083.939580302042, 10660.946695266784, 10763.031327180592, 11095.445227738419, 11137.944310278397, 11658.6502404928, 9748.951255243679, 9754.365966212174, 9772.413655180711, 9936.850947235942, 9952.651657192253, 9262.629494820132, 9306.208972237435, 10015.449150296803, 10159.7460063499, 10160.441175735405], "unit": "ms", "name": "yui.html", "value": 6604.314682462294}], "name": "dromaeo_css", "value": 7290.081101207771}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 110.0, 111.0, 111.0, 110.0, 111.0, 102.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [151.0, 121.0, 143.0, 155.0, 120.0, 133.0, 139.0, 116.0, 155.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 183.0, 181.0, 184.0, 184.0, 186.0, 183.0, 187.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 183.7}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 72.0, 73.0, 55.0, 56.0, 58.0, 72.0, 80.0, 53.0], "unit": "ms", "name": "audio-fft", "value": 65.3}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 118.0, 75.0, 74.0, 75.0, 113.0, 74.0, 75.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.7}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 87.0, 89.0, 80.0, 123.0, 124.0, 102.0, 86.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 93.0, 95.0, 95.0, 93.0, 94.0, 103.0, 123.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 97.7}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 87.0, 85.0, 100.0, 121.0, 124.0, 131.0, 86.0, 87.0], "unit": "ms", "name": "imaging-desaturate", "value": 99.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 55.0, 54.0, 55.0, 56.0, 57.0, 66.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 67.0, 68.0, 67.0, 67.0, 66.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 84.0, 81.0, 84.0, 81.0, 81.0, 82.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [124.0, 118.0, 112.0, 126.0, 118.0, 121.0, 123.0, 106.0, 119.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [147.0, 108.0, 140.0, 170.0, 142.0, 137.0, 137.0, 137.0, 135.0, 125.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 84.0, 86.0, 86.0, 88.0, 73.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 74.5}], "name": "kraken", "value": 1410.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.37002341920376], "unit": "score", "name": "Richards", "value": 241.18326399999992}, {"lowerIsBetter": false, "replicates": [161.26431220770843], "unit": "score", "name": "DeltaBlue", "value": 409.99771799999996}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "Decrypt", "value": 55.20004785643067}, {"lowerIsBetter": false, "replicates": [1705.281090289608], "unit": "score", "name": "RayTrace", "value": 433.93960339660345}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12662.5], "unit": "score", "name": "Boyer", "value": 52.632813425468896}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [750.1875468867216], "unit": "score", "name": "Splay", "value": 108.62750299999996}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 20373.939909658344}]} 16:55:39 INFO - RETURN: dromaeo_css: 7290.08 16:55:39 INFO - RETURN: kraken: 1410.80 16:55:39 INFO - RETURN: v8_7: 20373.94 16:55:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20373.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1410.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7290.08"}}} 16:55:39 INFO - Return code: 0 16:55:39 INFO - # TBPL SUCCESS # 16:55:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:39 INFO - 2015-11-19 16:55:39.934 screenresolution[2248:20907] starting screenresolution argv=screenresolution get 16:55:39 INFO - 2015-11-19 16:55:39.938 screenresolution[2248:20907] Display 0: 1600x1200x32@60 16:55:39 INFO - 2015-11-19 16:55:39.944 screenresolution[2249:20910] starting screenresolution argv=screenresolution list 16:55:39 INFO - Available Modes on Display 0 16:55:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:40 INFO - Intel Iris: 16:55:40 INFO - Chipset Model: Intel Iris 16:55:40 INFO - Type: GPU 16:55:40 INFO - Bus: Built-In 16:55:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:40 INFO - Vendor: Intel (0x8086) 16:55:40 INFO - Device ID: 0x0a2e 16:55:40 INFO - Revision ID: 0x0009 16:55:40 INFO - Displays: 16:55:40 INFO - Display: 16:55:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:40 INFO - Display Serial Number: 1600x1200 60 16:55:40 INFO - Main Display: Yes 16:55:40 INFO - Mirror: Off 16:55:40 INFO - Online: Yes 16:55:40 INFO - Rotation: Supported 16:55:40 INFO - Return code: 0 16:55:40 INFO - Running post-action listener: _resource_record_post_action 16:55:40 INFO - Running post-run listener: _resource_record_post_run 16:55:41 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 233472; Write bytes: 691925504; Read time: 2; Write time: 2226 16:55:41 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 344457728; Write bytes: 349423616; Read time: 27097; Write time: 700 16:55:41 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 233472; Write bytes: 341436928; Read time: 2; Write time: 1521 16:55:41 INFO - Running post-run listener: _upload_blobber_files 16:55:41 INFO - Blob upload gear active. 16:55:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:55:41 INFO - Copying logs to upload dir... 16:55:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.114814 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 16:55:41.303102) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:41.306718) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009408 build_url: 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:41.329064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:41.329353) ========= 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.tWNf4C3IOA/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.0fLdEDp861/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005137 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:41.381172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:55:41.381965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:55:41.382846) ========= ========= Total master_lag: 0.21 =========