builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0013 starttime: 1447340887.52 results: success (0) buildid: 20151112061647 builduid: c38158eb344d4004a9eb26fb18f12190 revision: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.522715) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.523165) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.523459) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006288 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.594035) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.594349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.756181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.756553) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005572 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.823818) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.824142) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.824545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:07.824934) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-12 07:08:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-12 07:08:07 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153556 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.010892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.011180) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019817 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.067657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.067978) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb --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 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-12 07:08:08,154 truncating revision to first 12 chars 2015-11-12 07:08:08,154 Setting DEBUG logging. 2015-11-12 07:08:08,154 attempt 1/10 2015-11-12 07:08:08,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/73119a9a7da2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 07:08:08,400 unpacking tar archive at: fx-team-73119a9a7da2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.493274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.583480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.583779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.597573) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.597893) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 07:08:08.598311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-11-12 07:08:08.598615) ========= /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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 07:08:08 INFO - MultiFileLogger online at 20151112 07:08:08 in /builds/slave/test 07:08:08 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 07:08:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:08 INFO - {'append_to_log': False, 07:08:08 INFO - 'base_work_dir': '/builds/slave/test', 07:08:08 INFO - 'blob_upload_branch': 'Fx-Team', 07:08:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:08 INFO - 'branch': 'Fx-Team', 07:08:08 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:08 INFO - 'config_files': ('talos/mac_config.py',), 07:08:08 INFO - 'default_actions': ('clobber', 07:08:08 INFO - 'read-buildbot-config', 07:08:08 INFO - 'download-and-extract', 07:08:08 INFO - 'populate-webroot', 07:08:08 INFO - 'create-virtualenv', 07:08:08 INFO - 'install', 07:08:08 INFO - 'run-tests'), 07:08:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:08 INFO - 'download_minidump_stackwalk': True, 07:08:08 INFO - 'download_symbols': 'ondemand', 07:08:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:08 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:08 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:08 INFO - 'installer_path': 'installer.exe', 07:08:08 INFO - 'log_level': 'info', 07:08:08 INFO - 'log_name': 'talos', 07:08:08 INFO - 'log_to_console': True, 07:08:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:08:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:08:08 INFO - 'opt_config_files': (), 07:08:08 INFO - 'pip_index': False, 07:08:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:08:08 INFO - 'cmd': ('bash', 07:08:08 INFO - '-c', 07:08:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:08:08 INFO - 'enabled': True, 07:08:08 INFO - 'halt_on_failure': False, 07:08:08 INFO - 'name': 'check_screen_resolution'},), 07:08:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:08:08 INFO - 'cmd': ('bash', 07:08:08 INFO - '-c', 07:08:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:08:08 INFO - 'enabled': True, 07:08:08 INFO - 'halt_on_failure': False, 07:08:08 INFO - 'name': 'check_screen_resolution'},), 07:08:08 INFO - 'run_cmd_checks_enabled': True, 07:08:08 INFO - 'sps_profile': False, 07:08:08 INFO - 'sps_profile_interval': 0, 07:08:08 INFO - 'suite': 'dromaeojs', 07:08:08 INFO - 'system_bits': '64', 07:08:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:08 INFO - 'title': 't-yosemite-r5-0013', 07:08:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:08 INFO - 'use_talos_json': True, 07:08:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:08 INFO - 'work_dir': 'build'} 07:08:08 INFO - ##### 07:08:08 INFO - ##### Running clobber step. 07:08:08 INFO - ##### 07:08:08 INFO - Running pre-action listener: _resource_record_pre_action 07:08:08 INFO - Running main action method: clobber 07:08:08 INFO - rmtree: /builds/slave/test/build 07:08:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:10 INFO - Running post-action listener: _resource_record_post_action 07:08:10 INFO - ##### 07:08:10 INFO - ##### Running read-buildbot-config step. 07:08:10 INFO - ##### 07:08:10 INFO - Running pre-action listener: _resource_record_pre_action 07:08:10 INFO - Running main action method: read_buildbot_config 07:08:10 INFO - Using buildbot properties: 07:08:10 INFO - { 07:08:10 INFO - "properties": { 07:08:10 INFO - "buildnumber": 1232, 07:08:10 INFO - "product": "firefox", 07:08:10 INFO - "script_repo_revision": "production", 07:08:10 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 07:08:10 INFO - "repository": "", 07:08:10 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 07:08:10 INFO - "buildid": "20151112061647", 07:08:10 INFO - "slavename": "t-yosemite-r5-0013", 07:08:10 INFO - "pgo_build": "False", 07:08:10 INFO - "basedir": "/builds/slave/test", 07:08:10 INFO - "project": "", 07:08:10 INFO - "platform": "yosemite", 07:08:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:08:10 INFO - "slavebuilddir": "test", 07:08:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:08:10 INFO - "branch": "fx-team", 07:08:10 INFO - "repo_path": "integration/fx-team", 07:08:10 INFO - "stage_platform": "macosx64", 07:08:10 INFO - "builduid": "c38158eb344d4004a9eb26fb18f12190", 07:08:10 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 07:08:10 INFO - }, 07:08:10 INFO - "sourcestamp": { 07:08:10 INFO - "repository": "", 07:08:10 INFO - "hasPatch": false, 07:08:10 INFO - "project": "", 07:08:10 INFO - "branch": "fx-team-macosx64-talos", 07:08:10 INFO - "changes": [ 07:08:10 INFO - { 07:08:10 INFO - "category": null, 07:08:10 INFO - "files": [ 07:08:10 INFO - { 07:08:10 INFO - "url": null, 07:08:10 INFO - "name": "https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:08:10 INFO - } 07:08:10 INFO - ], 07:08:10 INFO - "repository": "", 07:08:10 INFO - "rev": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb", 07:08:10 INFO - "who": "paolo.mozmail@amadzone.org", 07:08:10 INFO - "when": 1447340504, 07:08:10 INFO - "number": 6653593, 07:08:10 INFO - "comments": "Bug 1206244 - Replace globe with the \"i\" icon, keep separate lock for secure pages. r=past", 07:08:10 INFO - "project": "", 07:08:10 INFO - "at": "Thu 12 Nov 2015 07:01:44", 07:08:10 INFO - "branch": "fx-team-macosx64-talos", 07:08:10 INFO - "revlink": "", 07:08:10 INFO - "properties": [ 07:08:10 INFO - [ 07:08:10 INFO - "buildid", 07:08:10 INFO - "20151112061647", 07:08:10 INFO - "Change" 07:08:10 INFO - ], 07:08:10 INFO - [ 07:08:10 INFO - "builduid", 07:08:10 INFO - "c38158eb344d4004a9eb26fb18f12190", 07:08:10 INFO - "Change" 07:08:10 INFO - ], 07:08:10 INFO - [ 07:08:10 INFO - "pgo_build", 07:08:10 INFO - "False", 07:08:10 INFO - "Change" 07:08:10 INFO - ] 07:08:10 INFO - ], 07:08:10 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 07:08:10 INFO - } 07:08:10 INFO - ], 07:08:10 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 07:08:10 INFO - } 07:08:10 INFO - } 07:08:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:08:10 INFO - Running post-action listener: _resource_record_post_action 07:08:10 INFO - ##### 07:08:10 INFO - ##### Running download-and-extract step. 07:08:10 INFO - ##### 07:08:10 INFO - Running pre-action listener: _resource_record_pre_action 07:08:10 INFO - Running main action method: download_and_extract 07:08:10 INFO - mkdir: /builds/slave/test/build/tests 07:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:10 INFO - https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/test_packages.json 07:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/test_packages.json 07:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:08:13 INFO - Downloaded 1149 bytes. 07:08:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:08:13 INFO - Using the following test package requirements: 07:08:13 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:08:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:08:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'jsshell-mac.zip'], 07:08:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:08:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:08:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:08:13 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:08:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:08:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:08:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:08:13 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:08:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:13 INFO - https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:08:14 INFO - Downloaded 17454888 bytes. 07:08:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 07:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:08:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:08:19 INFO - Return code: 0 07:08:19 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 07:08:19 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')]} 07:08:19 INFO - https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:09:20 INFO - Downloaded 17454888 bytes. 07:09:20 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 07:09:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:09:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:09:25 INFO - Return code: 0 07:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:25 INFO - https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:09:32 INFO - Downloaded 11131693 bytes. 07:09:32 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 07:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:09:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:09:32 INFO - Return code: 0 07:09: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')]} 07:09:32 INFO - https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/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 07:09:50 INFO - Downloaded 108706103 bytes. 07:09:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:09:50 INFO - mkdir: /builds/slave/test/properties 07:09:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:50 INFO - Contents: 07:09:50 INFO - build_url:https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:09:50 INFO - Running post-action listener: _resource_record_post_action 07:09:50 INFO - Running post-action listener: set_extra_try_arguments 07:09:50 INFO - ##### 07:09:50 INFO - ##### Running populate-webroot step. 07:09:50 INFO - ##### 07:09:50 INFO - Running pre-action listener: _resource_record_pre_action 07:09:50 INFO - Running main action method: populate_webroot 07:09:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:09:50 INFO - '../fennec_ids.txt'], 07:09:50 INFO - 'tests': ['tcheck2']}, 07:09:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:50 INFO - '--tppagecycles', 07:09:50 INFO - '7'], 07:09:50 INFO - 'tests': ['tsvgm']}}, 07:09:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:09:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:09:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:09:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['damp', 'tps']}, 07:09:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['damp', 'tps']}, 07:09:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:09:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:50 INFO - 'other': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'other_l64': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'other_nol64': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore']}, 07:09:50 INFO - 'svgr': {'tests': ['tsvgx', 07:09:50 INFO - 'tsvgr_opacity', 07:09:50 INFO - 'tart', 07:09:50 INFO - 'tscrollx', 07:09:50 INFO - 'cart']}, 07:09:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['tsvgx', 07:09:50 INFO - 'tsvgr_opacity', 07:09:50 INFO - 'tart', 07:09:50 INFO - 'tscrollx', 07:09:50 INFO - 'cart']}, 07:09:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['tp5o']}, 07:09:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--e10s'], 07:09:50 INFO - 'tests': ['tp5o']}, 07:09:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--xperf_path', 07:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:50 INFO - 'tests': ['tp5n']}, 07:09:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--e10s', 07:09:50 INFO - '--xperf_path', 07:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:50 INFO - 'tests': ['tp5n']}}, 07:09:50 INFO - 'talos.zip': {'path': '', 07:09:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:50 INFO - Running post-action listener: _resource_record_post_action 07:09:50 INFO - ##### 07:09:50 INFO - ##### Running create-virtualenv step. 07:09:50 INFO - ##### 07:09:50 INFO - Running pre-action listener: _resource_record_pre_action 07:09:50 INFO - Running main action method: create_virtualenv 07:09:50 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:50 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 07:09:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:50 INFO - Using real prefix '/tools/python27' 07:09:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:54 INFO - Installing pip.................done. 07:09:54 INFO - Return code: 0 07:09:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:54 INFO - 'HOME': '/Users/cltbld', 07:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:54 INFO - 'LOGNAME': 'cltbld', 07:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:54 INFO - 'MOZ_NO_REMOTE': '1', 07:09:54 INFO - 'NO_EM_RESTART': '1', 07:09:54 INFO - 'PAGER': '/bin/cat', 07:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:54 INFO - 'PWD': '/builds/slave/test', 07:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:54 INFO - 'SHELL': '/bin/bash', 07:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:09:54 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:54 INFO - 'USER': 'cltbld', 07:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:54 INFO - 'XPC_FLAGS': '0x0', 07:09:54 INFO - 'XPC_SERVICE_NAME': '0', 07:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:54 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 07:09:54 INFO - Cleaning up... 07:09:54 INFO - Return code: 0 07:09:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:54 INFO - 'HOME': '/Users/cltbld', 07:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:54 INFO - 'LOGNAME': 'cltbld', 07:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:54 INFO - 'MOZ_NO_REMOTE': '1', 07:09:54 INFO - 'NO_EM_RESTART': '1', 07:09:54 INFO - 'PAGER': '/bin/cat', 07:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:54 INFO - 'PWD': '/builds/slave/test', 07:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:54 INFO - 'SHELL': '/bin/bash', 07:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:09:54 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:54 INFO - 'USER': 'cltbld', 07:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:54 INFO - 'XPC_FLAGS': '0x0', 07:09:54 INFO - 'XPC_SERVICE_NAME': '0', 07:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:54 INFO - Downloading/unpacking psutil>=0.7.1 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:09:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:57 INFO - Installing collected packages: psutil 07:09:57 INFO - Running setup.py install for psutil 07:09:57 INFO - building 'psutil._psutil_osx' extension 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 INFO - building 'psutil._psutil_posix' extension 07:09:57 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 07:09:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:09:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:09:58 INFO - ^ 07:09:58 INFO - 1 warning generated. 07:09:58 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 07:09:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:58 INFO - Successfully installed psutil 07:09:58 INFO - Cleaning up... 07:09:58 INFO - Return code: 0 07:09:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:09:58 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 07:09:58 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 07:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:58 INFO - 'HOME': '/Users/cltbld', 07:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:58 INFO - 'LOGNAME': 'cltbld', 07:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:58 INFO - 'MOZ_NO_REMOTE': '1', 07:09:58 INFO - 'NO_EM_RESTART': '1', 07:09:58 INFO - 'PAGER': '/bin/cat', 07:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:58 INFO - 'PWD': '/builds/slave/test', 07:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:58 INFO - 'SHELL': '/bin/bash', 07:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:09:58 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:58 INFO - 'USER': 'cltbld', 07:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:58 INFO - 'XPC_FLAGS': '0x0', 07:09:58 INFO - 'XPC_SERVICE_NAME': '0', 07:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:09:58 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 07:09:58 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 07:09:58 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 07:09:58 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 07:09:58 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 07:09:58 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 07:10:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:10:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:10:01 INFO - Installing collected packages: mozsystemmonitor 07:10:01 INFO - Running setup.py install for mozsystemmonitor 07:10:01 INFO - Successfully installed mozsystemmonitor 07:10:01 INFO - Cleaning up... 07:10:01 INFO - Return code: 0 07:10:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:01 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')]} 07:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:01 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')]} 07:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:01 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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:01 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 07:10:01 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 07:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:01 INFO - 'HOME': '/Users/cltbld', 07:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:01 INFO - 'LOGNAME': 'cltbld', 07:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:01 INFO - 'MOZ_NO_REMOTE': '1', 07:10:01 INFO - 'NO_EM_RESTART': '1', 07:10:01 INFO - 'PAGER': '/bin/cat', 07:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:01 INFO - 'PWD': '/builds/slave/test', 07:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:01 INFO - 'SHELL': '/bin/bash', 07:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:10:01 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:01 INFO - 'USER': 'cltbld', 07:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:01 INFO - 'XPC_FLAGS': '0x0', 07:10:01 INFO - 'XPC_SERVICE_NAME': '0', 07:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:01 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:04 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 07:10:05 INFO - Downloading docopt-0.6.1.tar.gz 07:10:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:05 INFO - Running setup.py install for blobuploader 07:10:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:05 INFO - Running setup.py install for requests 07:10:06 INFO - Running setup.py install for docopt 07:10:06 INFO - Successfully installed blobuploader requests docopt 07:10:06 INFO - Cleaning up... 07:10:06 INFO - Return code: 0 07:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:06 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 07:10:06 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 07:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:06 INFO - 'HOME': '/Users/cltbld', 07:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:06 INFO - 'LOGNAME': 'cltbld', 07:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:06 INFO - 'MOZ_NO_REMOTE': '1', 07:10:06 INFO - 'NO_EM_RESTART': '1', 07:10:06 INFO - 'PAGER': '/bin/cat', 07:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:06 INFO - 'PWD': '/builds/slave/test', 07:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:06 INFO - 'SHELL': '/bin/bash', 07:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:10:06 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:06 INFO - 'USER': 'cltbld', 07:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:06 INFO - 'XPC_FLAGS': '0x0', 07:10:06 INFO - 'XPC_SERVICE_NAME': '0', 07:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:06 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-W7oKn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:06 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-3_VIDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:06 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-J8o3pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:06 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-guurHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-t33VHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-A7Xb8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-WZ4x59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-L5S4Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-u_quX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Bh0v4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-9t_Bol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:07 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-CUN72U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:08 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-lIFD7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:08 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Dc_h37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:08 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-_QVFOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:08 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-2UC7fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:08 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-b3QEPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:08 INFO - Running setup.py install for manifestparser 07:10:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:08 INFO - Running setup.py install for mozcrash 07:10:08 INFO - Running setup.py install for mozdebug 07:10:09 INFO - Running setup.py install for mozdevice 07:10:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Running setup.py install for mozfile 07:10:09 INFO - Running setup.py install for mozhttpd 07:10:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Running setup.py install for mozinfo 07:10:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Running setup.py install for mozInstall 07:10:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:09 INFO - Running setup.py install for mozleak 07:10:10 INFO - Running setup.py install for mozlog 07:10:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Running setup.py install for moznetwork 07:10:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Running setup.py install for mozprocess 07:10:10 INFO - Running setup.py install for mozprofile 07:10:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Running setup.py install for mozrunner 07:10:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:11 INFO - Running setup.py install for mozscreenshot 07:10:11 INFO - Running setup.py install for moztest 07:10:11 INFO - Running setup.py install for mozversion 07:10:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:11 INFO - Cleaning up... 07:10:11 INFO - Return code: 0 07:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:11 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')]} 07:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 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')]} 07:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:11 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 07:10:11 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 07:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:11 INFO - 'HOME': '/Users/cltbld', 07:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:11 INFO - 'LOGNAME': 'cltbld', 07:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:11 INFO - 'MOZ_NO_REMOTE': '1', 07:10:11 INFO - 'NO_EM_RESTART': '1', 07:10:11 INFO - 'PAGER': '/bin/cat', 07:10:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:11 INFO - 'PWD': '/builds/slave/test', 07:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:11 INFO - 'SHELL': '/bin/bash', 07:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:10:11 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:11 INFO - 'USER': 'cltbld', 07:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:11 INFO - 'XPC_FLAGS': '0x0', 07:10:11 INFO - 'XPC_SERVICE_NAME': '0', 07:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:11 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-6kf_BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:11 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)) 07:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-0e7uZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-nog_mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Eclz4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-mnAcX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-jXWDZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-7pE11A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-1PE7jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Kg2ieF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:12 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)) 07:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:12 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-0gT7m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-hiazvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-tIcJw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-dkWgq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-J7eUZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-m_QGi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-_OnxVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:13 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)) 07:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:13 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-T0TkIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:13 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)) 07:10:14 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)) 07:10:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:14 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 07:10:14 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 07:10:14 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 07:10:14 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 07:10:14 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 07:10:14 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 07:10:16 INFO - Downloading blessings-1.5.1.tar.gz 07:10:16 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 07:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:16 INFO - Installing collected packages: blessings 07:10:16 INFO - Running setup.py install for blessings 07:10:16 INFO - Successfully installed blessings 07:10:16 INFO - Cleaning up... 07:10:16 INFO - Return code: 0 07:10:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:17 INFO - Reading from file tmpfile_stdout 07:10:17 INFO - Current package versions: 07:10:17 INFO - blessings == 1.5.1 07:10:17 INFO - blobuploader == 1.2.4 07:10:17 INFO - docopt == 0.6.1 07:10:17 INFO - manifestparser == 1.1 07:10:17 INFO - mozInstall == 1.12 07:10:17 INFO - mozcrash == 0.16 07:10:17 INFO - mozdebug == 0.1 07:10:17 INFO - mozdevice == 0.47 07:10:17 INFO - mozfile == 1.2 07:10:17 INFO - mozhttpd == 0.7 07:10:17 INFO - mozinfo == 0.9 07:10:17 INFO - mozleak == 0.1 07:10:17 INFO - mozlog == 3.0 07:10:17 INFO - moznetwork == 0.27 07:10:17 INFO - mozprocess == 0.22 07:10:17 INFO - mozprofile == 0.27 07:10:17 INFO - mozrunner == 6.11 07:10:17 INFO - mozscreenshot == 0.1 07:10:17 INFO - mozsystemmonitor == 0.0 07:10:17 INFO - moztest == 0.7 07:10:17 INFO - mozversion == 1.4 07:10:17 INFO - psutil == 3.1.1 07:10:17 INFO - requests == 1.2.3 07:10:17 INFO - wsgiref == 0.1.2 07:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 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 0x10d9fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d3514ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/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.uThfZzFRYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:17 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 07:10:17 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 07:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:17 INFO - 'HOME': '/Users/cltbld', 07:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:17 INFO - 'LOGNAME': 'cltbld', 07:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:17 INFO - 'MOZ_NO_REMOTE': '1', 07:10:17 INFO - 'NO_EM_RESTART': '1', 07:10:17 INFO - 'PAGER': '/bin/cat', 07:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:17 INFO - 'PWD': '/builds/slave/test', 07:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:17 INFO - 'SHELL': '/bin/bash', 07:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:10:17 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:17 INFO - 'USER': 'cltbld', 07:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:17 INFO - 'XPC_FLAGS': '0x0', 07:10:17 INFO - 'XPC_SERVICE_NAME': '0', 07:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 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)) 07:10:17 INFO - Cleaning up... 07:10:17 INFO - Return code: 0 07:10:17 INFO - Running post-action listener: _resource_record_post_action 07:10:17 INFO - Running post-action listener: _start_resource_monitoring 07:10:17 INFO - Starting resource monitoring. 07:10:17 INFO - ##### 07:10:17 INFO - ##### Running install step. 07:10:17 INFO - ##### 07:10:17 INFO - Running pre-action listener: _resource_record_pre_action 07:10:17 INFO - Running main action method: install 07:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:17 INFO - Reading from file tmpfile_stdout 07:10:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:17 INFO - Reading from file tmpfile_stdout 07:10:17 INFO - Output received: 07:10:17 INFO - Usage: mozinstall [options] installer 07:10:17 INFO - Options: 07:10:17 INFO - -h, --help show this help message and exit 07:10:17 INFO - -d DEST, --destination=DEST 07:10:17 INFO - Directory to install application into. [default: 07:10:17 INFO - "/builds/slave/test"] 07:10:17 INFO - --app=APP Application being installed. [default: firefox] 07:10:17 INFO - mkdir: /builds/slave/test/build/application 07:10:17 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'] 07:10:17 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 07:10:55 INFO - Reading from file tmpfile_stdout 07:10:55 INFO - Output received: 07:10:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:10:55 INFO - Running post-action listener: _resource_record_post_action 07:10:55 INFO - ##### 07:10:55 INFO - ##### Running run-tests step. 07:10:55 INFO - ##### 07:10:55 INFO - Running pre-action listener: _resource_record_pre_action 07:10:55 INFO - Running main action method: run_tests 07:10:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:10:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:10:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:10:55 INFO - 2015-11-12 07:10:55.987 screenresolution[2236:18236] starting screenresolution argv=screenresolution get 07:10:55 INFO - 2015-11-12 07:10:55.990 screenresolution[2236:18236] Display 0: 1600x1200x32@60 07:10:55 INFO - 2015-11-12 07:10:55.997 screenresolution[2237:18238] starting screenresolution argv=screenresolution list 07:10:56 INFO - Available Modes on Display 0 07:10:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:10:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:10:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:10:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:10:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:10:56 INFO - Intel HD Graphics 3000: 07:10:56 INFO - Chipset Model: Intel HD Graphics 3000 07:10:56 INFO - Type: GPU 07:10:56 INFO - Bus: Built-In 07:10:56 INFO - VRAM (Total): 512 MB 07:10:56 INFO - VRAM (Dynamic, Max): 10 07:10:56 INFO - Vendor: Intel (0x8086) 07:10:56 INFO - Device ID: 0x0116 07:10:56 INFO - Revision ID: 0x0009 07:10:56 INFO - Displays: 07:10:56 INFO - Display: 07:10:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:10:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:10:56 INFO - Display Serial Number: 1600x1200 60 07:10:56 INFO - Main Display: Yes 07:10:56 INFO - Mirror: Off 07:10:56 INFO - Online: Yes 07:10:56 INFO - Rotation: Supported 07:10:56 INFO - Return code: 0 07:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:56 INFO - Python 2.7.3 07:10:56 INFO - Return code: 0 07:10:56 INFO - grabbing minidump binary from tooltool 07:10:56 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')]} 07:10:56 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 0x10d91f9f0>, '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 0x10d67fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9138c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:56 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 07:10:56 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 07:10:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:56 INFO - Return code: 0 07:10:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:10:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:10:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:56 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/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] in /builds/slave/test/build 07:10:56 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/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0013 --webServer localhost 07:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5BgPHZFX29/Render', 07:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:56 INFO - 'HOME': '/Users/cltbld', 07:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:56 INFO - 'LOGNAME': 'cltbld', 07:10:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:56 INFO - 'MOZ_NO_REMOTE': '1', 07:10:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:56 INFO - 'NO_EM_RESTART': '1', 07:10:56 INFO - 'PAGER': '/bin/cat', 07:10:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:56 INFO - 'PWD': '/builds/slave/test', 07:10:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:56 INFO - 'SHELL': '/bin/bash', 07:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uThfZzFRYZ/Listeners', 07:10:56 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:56 INFO - 'USER': 'cltbld', 07:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:56 INFO - 'XPC_FLAGS': '0x0', 07:10:56 INFO - 'XPC_SERVICE_NAME': '0', 07:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:10:56 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/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] with output_timeout 3600 07:10:56 INFO - mozversion INFO | application_buildid: 20151112061647 07:10:56 INFO - mozversion INFO | application_changeset: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb 07:10:56 INFO - mozversion INFO | application_display_name: Nightly 07:10:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:56 INFO - mozversion INFO | application_name: Firefox 07:10:56 INFO - mozversion INFO | application_remotingname: firefox 07:10:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:10:56 INFO - mozversion INFO | application_vendor: Mozilla 07:10:56 INFO - mozversion INFO | application_version: 45.0a1 07:10:56 INFO - mozversion INFO | platform_buildid: 20151112061647 07:10:56 INFO - mozversion INFO | platform_changeset: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb 07:10:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:10:56 INFO - mozversion INFO | platform_version: 45.0a1 07:10:56 INFO - 2015-11-12 07:10:56,620 DEBUG : using testdate: 1447341056 07:10:56 INFO - 2015-11-12 07:10:56,620 DEBUG : actual date: 1447341056 07:10:56 INFO - 2015-11-12 07:10:56,704 INFO : starting webserver on 'localhost:50154' 07:10:56 INFO - 2015-11-12 07:10:56,705 INFO : Starting test suite t-yosemite-r5-0013 07:10:56 INFO - 2015-11-12 07:10:56,705 INFO : Starting test dromaeo_css 07:10:56 INFO - 2015-11-12 07:10:56,705 DEBUG : operating with platform_type : mac_ 07:10:56 INFO - 2015-11-12 07:10:56,706 INFO : Initialising browser for dromaeo_css test... 07:10:56 INFO - 2015-11-12 07:10:56,735 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpdn2aOh/profile http://localhost:50154/getInfo.html 07:10:59 INFO - 2015-11-12 07:10:59,738 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:59 INFO - 2015-11-12 07:10:59,738 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:59 INFO - 2015-11-12 07:10:59,738 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:10:59 INFO - 2015-11-12 07:10:59,738 DEBUG : BROWSER_OUTPUT: __metrics 07:10:59 INFO - 2015-11-12 07:10:59,757 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:00 INFO - 2015-11-12 07:11:00,467 INFO : Browser initialized. 07:11:00 INFO - 2015-11-12 07:11:00,467 INFO : Running cycle 1/1 for dromaeo_css test... 07:11:00 INFO - 2015-11-12 07:11:00,467 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpdn2aOh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:12 INFO - 2015-11-12 07:11:12,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 229269504 07:11:12 INFO - 2015-11-12 07:11:12,665 DEBUG : BROWSER_OUTPUT: 07:12:04 INFO - 2015-11-12 07:12:04,406 DEBUG : BROWSER_OUTPUT: 1447341124403 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] 07:14:14 INFO - 2015-11-12 07:14:14,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50154/tests/dromaeo/cssquery-ext.html) 07:14:15 INFO - 2015-11-12 07:14:15,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 324771840 07:14:15 INFO - 2015-11-12 07:14:15,620 DEBUG : BROWSER_OUTPUT: 07:17:18 INFO - 2015-11-12 07:17:18,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-ext.html (next: http://localhost:50154/tests/dromaeo/cssquery-jquery.html) 07:17:18 INFO - 2015-11-12 07:17:18,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 355258368 07:17:18 INFO - 2015-11-12 07:17:18,837 DEBUG : BROWSER_OUTPUT: 07:20:21 INFO - 2015-11-12 07:20:21,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50154/tests/dromaeo/cssquery-mootools.html) 07:20:21 INFO - 2015-11-12 07:20:21,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 342941696 07:20:21 INFO - 2015-11-12 07:20:21,613 DEBUG : BROWSER_OUTPUT: 07:23:23 INFO - 2015-11-12 07:23:23,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50154/tests/dromaeo/cssquery-prototype.html) 07:23:24 INFO - 2015-11-12 07:23:24,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 319967232 07:23:24 INFO - 2015-11-12 07:23:24,247 DEBUG : BROWSER_OUTPUT: 07:26:27 INFO - 2015-11-12 07:26:27,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50154/tests/dromaeo/cssquery-yui.html) 07:26:27 INFO - 2015-11-12 07:26:27,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 320241664 07:26:27 INFO - 2015-11-12 07:26:27,974 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-yui.html (next: http://localhost:50154/tests/dromaeo/cssquery-dojo.html) 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 395386880 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:29:30 INFO - 2015-11-12 07:29:30,878 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:29:30 INFO - 2015-11-12 07:29:30,879 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2807.480616086023;2844.530652442346;2865.7850661200414;2867.2258490207646;3073.738732207762;4569.611583015448;4641.489436162024;4706.4822869484415;4734.526547345268;4781.976090119549;4818.734969576672;4845.685030473017;4951.876203094925;5038.899222015558;5042.672226305297;4492.707973981697;4497.550244975509;4527.615152712024;4543.772811359436;4597.586217240448;4575.588197062264;4671.042436300567;4696.694714843524;4730.455997560291;4829.517048295177;4432.756198409086;4526.4794548627;4540.069285796404;4657.604103651193;4679.461861885893;4534.274516077412;4545.068261006486;4554.316852472156;4556.681032327739;4559.088182363541;4453.376527286183;4544.159330523864;4572.382728331666;4600.539946005406;4639.744814035227;4738.857834264978;4823.927641085352;4835.758212089381;4856.2958371036;4863.1732605457155;5037.596992240612;5064.189729643276;5106.285120083191;5205.115130427836;5223.608229382811;4969.8012079516775;5046.848594542133;5062.291279220912;5069.645124841226;5117.104506711348;4794.9211427428545;4882.121218180726;4903.509649035103;4927.556519913225;4933.876653083702;4913.115639184981;5028.270900719448;5041.8487445376695;5270.367555893317;5327.86680332987;4963.131451995886;5020.673656212334;5045.167547354718;5059.468755780664;5089.185730283137;5219.4780521947505;5269.604779641542;5277.525022747895;5281.12861377876;5319.069162896478;5019.598432125421;5153.201253805666;5169.663971841818;5176.559992400613;5178.249153872667;5148.433672296044;5208.5051920067535;5215.035218484592;5235.502627250406;5254.97372513135;4104.384342348611;4121.155163191538;4141.958580414218;4156.085661154541;4166.416701661769;3629.2197177606413;3723.72072094594;3736.6076561960604;3738.4018557030745;3761.0409345616695;4807.735574543363;4875.317455556225;4888.315635810989;4917.557419832161;4922.1140194765285;5120.92318615221;5136.717480538607;5147.742612869341;5147.897042059138;5181.326427564392;4655.3947986761505;4682.063587282489;4721.952780472151;4779.06808172403;4790.8323208688225;4526.140033393644;4585.151746926829;4587.977060114745;4607.792649330788;4640.605548528413;5364.088105022078;5386.946130538645;5403.918941215964;5406.405295417501;5414.620976531605;4907.656464047483;5018.172001619838;5060.240963855451;5205.869853253699;5240.816571419982;5283.286756288006;5336.199570064521;5338.092524270805;5383.488568585978;5392.838214853561;5196.2465442509865;5205.817796377109;5213.426523082382;5221.216817477409;5263.6052296078715;4903.705777653352;5029.622778291716;5037.823676171316;5283.682979021271;5311.521963023347;4970.552650261494;5016.648834581544;5051.595872330278;5105.617078719037;5156.61325400589;5016.423111342242;5039.118154323052;5046.646734728533;5053.4946505350645;5094.694318340911;4803.735794531334;4948.406191257072;4953.777080031479;4969.850904472872;4976.626752993468;4916.655834091723;4998.4251811042195;4999.500049994971;5030.0945829751;5076.11168045598;4980.153373926369;4984.152694041949;4988.55103040728;4991.15150424436;5037.093323201712 07:29:30 INFO - 2015-11-12 07:29:30,879 DEBUG : BROWSER_OUTPUT: |1;ext.html;496.88323244037645;500.0324372339523;500.7921712489317;505.9949400505994;530.2126342381565;26596.4680706386;29674;29741;29918.401631967346;36448.271034579295;39012;39550.8022459888;39668.80165599175;39701.007474813145;40053.39919901204;8409.66361345547;8580.613872375758;8582.184692454239;8596.8710469343;8597;7618.657160427794;7842.843143137134;8325.66697332106;8456.661733530682;9935.155511781508;9685.854712179324;9808.50957452128;9819.459929703864;9832.852507212398;9859.556319965619;9701.369410988264;9803.068708472754;9840.704778856645;9878.60485580576;9883.70348889538;7120.323569260912;7759.806004849867;9994.950025249827;10171.898281017244;10208.642697505551;36163.638363616294;36402.817985910166;36410.45384319237;36463.08842278938;36835;2655.907043253477;2766.39139389336;2870.2106920596793;2901.782366322513;3030.757539396843;24977.87511062451;25312.493750124893;25639.230823075337;25726;26517.204483865517;2184.7159869217057;2217.8513631271007;2221.7000704904794;2232.408411770882;2306.273523839985;262920;263868;264160;264993.9999999981;267585;54935.72532137314;55311.17033244504;55437.1684424734;56014.71992640011;56106.43893561094;51122.233166502534;52664;62971;64030;64128;15353.769693454607;15536.766948495782;15584.766228506582;15662.216889155497;15682;11823.408829558488;11843.881561184278;11873.762524749629;11894.64316070502;11959.820602690967;17325.826741732675;17455.73816392755;17472.29179477183;17506.21222045011;17559.297628094988;7395.630218489054;7521.473496855277;7528.473006889575;7539.359154471931;7569.886451703229;799.9600019998977;821.3552361396276;854.5556310718391;961.7499450143014;987.3976874106789;25588.360290992874;25891.35271618187;25911;26103.477930441284;26223.082192123184;936.0592604432502;944.6788092048737;1012.2610494339026;1029.2177944762034;1081.3349789879326;13377.933110334581;13452.596422107352;13500.459981600823;13505.662358441117;13506.527271545448;283950;290746;292439;293580;293619;50272.74863625658;50392;50466.49533504618;50795.492045079816;50927.7453612737;1212.9332886691316;1235.8702336254744;1248.1013670157654;1250.5560526013135;1252.6054292897709;25629.615555766304;25888.223353299432;26070;26121.477570448104;26214.73785262199;44113.77943110264;44488.55511444974;44617.10765784731;44843.77578112089;44857.10285794201;269091;272121;273806;274144;274626;28004.719952800213;29014.12957611275;29146.27134321659;29289.85355073211;29785.553216701333;34566.30867382688;34954.65045349616;35255.47116793199;35341.64658353384;36871.262574747816;29629.555556666237;30206.433983356106;30247.69752302537;30384.5442318361;32111.197220069684;25154.62268065944;30685.53971690471;31828.52257216097;32955;33626.83186584051;30365.69634303629;30433.39133217279;30540.84729576338;30651;30973.535396969513;24907.62638560459;27522.311942201606;27963.860180698965;29297;29308.706912930596;20691.68962465534;21112.366629001153;21113.366599002056;21143.682844757033;21149.25977590777 07:29:30 INFO - 2015-11-12 07:29:30,882 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.36995419481684;309.5681524273638;309.60834544301457;314.97007784260495;316.5346939998203;15711.0573365598;16238.999999999985;16999.150042497888;17132.486025419224;17134.914325428355;13208.735825283513;13725.460789753903;13754.518591849288;16021.759673604905;16269;3952.861649842256;4086.8160932758096;4094.0992981544014;4098.282800509914;4098.8565400211;4038.9798051009852;4076.6331030207275;4079.7552146871135;4081.8979525511804;4097.8770636880945;3113.532970054487;3182.443072462321;3210.3739770744714;4358.803853826569;4397;4365.716228445172;4375.2124617568825;4378.562143785628;4379.408779814716;4399.978000110011;3465.3069386122875;3635.4365073413665;3649.033006253345;3673.485712000322;3707.9814600927093;11688.766224675544;11703.707407314885;11901.523939042429;12038.638840834788;12169.087318451064;1666.5250403634907;1681.7813684220973;1716.9484915452556;1741.5646088477881;1766.9646607067916;8365.707200248024;8568.571571421404;8580.785480362978;8820.823583528294;8953.059928707456;1395.5464474045875;1409;1422.239102080382;1454.1929229277746;1475.6827282134393;51120.48879511232;52991.20513192305;53920;53934.73032634851;54058.91882162374;5794.768209271582;5843.444872737083;5873.119032145127;5905.586608937333;5957.404259574095;6761.188657361148;6764.323567643295;6770.526063175629;6780.491463140284;6783.592984420852;4978.303037574742;4992.350994370709;5011.1481048221885;5035.874103147451;5078.4413714491375;5404.351477822686;5419.566434685295;5431.619786614978;5444.183372494078;5461.563074953994;2635.551956167456;2686;2687.0595291648156;2701.3651791828906;2705.9323516912236;931.5481991234246;933.3932943586723;934.5700977550403;936.9578368973413;996.4071377530358;320.85240789236747;380.6973456102405;383.8215229918101;385.7936004237719;397.3602499975038;10178.93121222261;10337.534810933526;10437.32157409766;10501.21240906935;10691.305065170895;404.3712027796804;409.29192496979795;412.55032015103683;421.5721043141214;422.18728946777946;5535.474129957647;5715;5744.827655170351;5752.798652047159;5757.337906140848;339311;439328;448554;477340;490776;63476.36523634705;63714.044289335696;68845;70320.64839675871;75397.24602753902;403.2801449412784;417.95193552741216;418.09273875689826;418.47481410829215;419.49031926209193;9111.908880911105;9183.173514383738;9268.490233037248;9283.582238799136;9435.198008169382;31393.529097063107;32166.35667286688;32729.836350818092;33520.32959340848;33624;44022;44049;44050;44628.33057504075;44758.32862507;6999.335063168991;7103.076600041962;7126.180489243803;7141.178764441948;7141.178764442156;10008.799824003625;10329.74175645615;10642.574297028032;10667.093297069836;10774;7887.092984306878;8813.647454101763;9132.863007055032;9304.813903721752;9366.906330936876;7632.847343052997;8823.250023748053;9152.130547597968;9170.128837760401;9184.908150918673;9355.298352623444;9569.473678947725;9676.742023536895;9696.660616878375;9756.26827987918;6729.1252137221845;6775.085363475868;6872.244053154249;6941.895871561829;6945.062416573698;8847.955760221157;9166.358354915092;9187.127222913812;9230.630774768933;9268.860967085364 07:29:30 INFO - 2015-11-12 07:29:30,884 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1135.199684222623;1509.4943194030002;1604.5988502874281;1621.1002893394166;1660.858826999705;6592.340765923405;6829.965850170748;6885.414739747115;6935.202451718054;6964.6865891034895;7125.073740413739;7150.249223831501;7229.024081748976;7249.963750181241;7266;1714.7427885817103;1755.1224387806096;1946.4841816918529;1966.2528239269059;1973.8519611029158;1988.7712913015043;2029.8782073075588;2033.4408037789578;2034.9084291206857;2036.704677821715;1958.6670266054805;1981.0886991983705;1981.5739615982561;2006.438197304757;2007.5181956330448;1968.4094771568473;1989.7811240763504;2016.5261163626535;2017.7074324222979;2021.181421524285;2031.9796802031938;2062.1854367524893;2062.742157230346;2069.1516478244;2072.7098206251135;6766.966165169192;6777.322267773233;6786.3892249697765;6805.251422343538;6806.4554835613035;4224.831006759726;4338.414314067592;4346.456692913386;4353.151135528573;4371.584699453547;2498.9250322490175;2550.33691240277;2606.504764094816;2610;2629.447815958651;671.228087699145;712.4193782067598;790.8888012342668;797.3541431440494;826.3554427546524;9476.099770521789;9501.572429240701;9501.857472137923;9526.99966503521;9541.666041688508;3704.148045949447;3793.715471339661;3832.1952389997855;3855.036240939765;3855.5566109897723;8229.177082291722;8282.088970213272;8290.751277461686;8299.6680132794;8300.2114799094;4335.566443355639;4343.04453020335;4367.10474352757;4377.343398490252;4380.671449641226;3961.207758448322;3989.1423343981182;3990.960090399117;3995.400689896481;4000.5199376075057;3283.1135593390127;3346.7322614190807;3359.2441700617164;3385.2213990781765;3392.1519620094978;1070.882202957674;1078.7626722121122;1083.6315652678127;1086.6739978006567;1086.8641419822522;1216.5559570756786;1217.5860207529483;1232.4022848918266;1239.727260002798;1245.0910835090435;6735.932640673531;6778.932210677929;6830.453563714891;6861.142357205349;6923.411510021705;1042.1766804224578;1063.6277302943909;1068.9198310126772;1083.3932997521413;1090.4166271044953;5307.840764777063;5340.19897015443;5369.543588794996;5383.7846486140115;5411.080116380225;7998.400119990907;8460.365472589581;8660.39377243587;8709.782255443664;8736.825263494695;7784;7836.255555722311;7912.129665736765;7917.722879699183;7949.364050875916;6818.2159051708695;6894.413974812197;6932.024373053757;6975.093237879043;6988.93011069893;6209;6416.615003099829;6436.356364363526;6443.130177426175;6483.189601299838;7154.856902862018;7170.139583250043;7216.530925489827;7245.601491917995;7299.708011679473;7294.890576641248;7508.211637777955;7526.09686837583;7526.360259378014;7526.811829704082;5997.970010149921;6003.609765365237;6018.789342372996;6033.366496517802;6108.175396321618;6454.386833250834;6497.577657452251;6514.120593719977;6521.608703477807;6577.440917522064;6288.622682639057;6428.517861160338;6432.871342573216;6437.163168788027;6528.347165283433;6309.400606942333;6332;6385.776497822554;6427.903581446376;6432.710528026157;6384.425401713868;6440.742370305135;6472.805815825533;6494.577852439576;6528.67356632176;5867.589268751147;5918.7928422505;5935.0503919372695;5937.554683398676;5952.880942381042;5944.910826337522;6011.338752737282;6012.428819262163;6024.1265016573225;6037.969810150921 07:29:30 INFO - 2015-11-12 07:29:30,885 DEBUG : BROWSER_OUTPUT: |4;prototype.html;264.70882029767245;276.6486562066176;277.1519151396726;284.7437306424218;285.443385398473;5364.973175134119;5434.076207044802;5573.804916827912;5579.0236708575985;5580.8604784880345;5376.677399356041;5444.700541470217;5482;5508.9724551377185;5528.75120619572;4323.848665296715;4330.805113769872;4341.565843415649;4349.521552629209;4350.54319296474;4077.734947228421;4176.102138040321;4249.596288352602;4318.956810431887;4336.631386332166;4233.830646774125;4246.3205887058075;4262.573742625728;4280.785960701953;4318.157959197958;4239.279322515149;4243.6605071594195;4251.766152861592;4252.022034931983;4255.361695745632;3551.1477245460906;3667.064898450878;3671.192337685705;3674.9816250918843;3680.723945704056;5145.536901678867;5323.707196104213;5332.413434522199;5349.679019258818;5359.651622644516;4730;4735.313379559944;4740.525947405266;4763.666543341968;4773.474917759044;5724.771009159628;5734.856628584319;5747.683877386742;5773.624714393593;5798.188253644493;3757.135858752475;3825.101101241234;3838.539375274957;3858.3247931612136;3931.744436611611;5856.32652244993;5891.263592050994;5900.380460051676;5916.171735956969;5922.318933322636;3959.703022273341;3966.8809935701975;3967.583403742623;3973.0464688475136;3983.183447393277;4013.3779264214095;4016.3172260715746;4019.437278780973;4019.9196016079513;4029.395590661424;4518.344839998182;4584.083183363341;4593.655475839326;4670.719756814534;4723.362346083303;5670.432956704297;5728.198052272685;5733.3406658234;5734.713264336767;5749.8275051748515;1401.1242973141786;1403.102014710586;1404.515442172449;1404.768213244803;1405.3465138710549;908.3323757038703;923.9953800230955;932.4451951089227;941.2517048945967;953.9570719317647;5492.80775172867;5525.557955363562;5527.005139075005;5533.253010843485;5543.7782488700805;5997.400259973968;6022.156898034279;6042.486388657014;6047.183630209954;6073.175973172496;5505.862353441196;5514.944850551443;5528.944710552843;5532.806351777668;5612.270404847343;3215.469447541176;3315;3316.9834150829574;3329.1011426914597;3331.850066746954;6150.600210986271;6159.938400616026;6164.815055548341;6167.907481387782;6196.504279657616;6156.29202641702;6169.167162433104;6191.907121393183;6205.565610407228;6219.657918814509;6057.848553786279;6113.84715382119;6182.721777520022;6219.47134493564;6226.346233645583;6043.365446628217;6049.852302432749;6107.144999699956;6125.356837531995;6127.448529632355;5709.8287051388525;5803.274590676166;5858.794942177004;5940.138679891478;5965.791197308074;6127.632342059491;6129.80468808578;6152.507799376129;6161.44546990755;6242.563020588515;3915.6084391560616;3948.565657777585;3953.1895961328432;3953.743006704555;3968.3452230381663;5740.598158128891;5985.730642121028;5991.88016239664;5998.640081595118;6054.122152287981;5743.167240750151;5887.087501437284;5896.174535564938;5906.350301466921;5911.940880591139;5868.061110222344;5870.354261031198;5879.382664820303;5884.0585506318785;5886.352501224947;5720.799772008127;5740.655560666373;5745.540356771532;5748.885022299447;5750.108733146369;5677.233573467694;5856.765729370777;5888.94111058901;5903.586748927534;5928.584999050025;5749.252597162342;5759.078547432391;5763;5765.798197063083;5772.105323674838 07:29:30 INFO - 2015-11-12 07:29:30,887 DEBUG : BROWSER_OUTPUT: |5;yui.html;585.1690599348924;639.830444932093;640.9487241020719;680.3502654964508;688.874771698563;12359.752804943906;12725.109242353039;12758.298293593849;12761.23432594045;12773.169743966659;11677.124215683814;11808.055355571556;11808.7638247235;11816.704582385444;11872.940635296833;637.5919411576594;644.2977154901157;797.6251161953872;800.8198155415014;810.9837803243931;799.1010113622175;802.83541873916;806.2501873257868;811.5860910935436;813.3818298093462;777.817212954958;825.6532256452305;837.0541288344193;850.2985037344184;854.3336197765752;657.7730682914411;666.0808084842935;816.5182542300072;843.5360551696542;846.551327796269;629.4492319220682;633.787681126823;635.2599221906473;636.0332294911755;639.7536948274901;12323.198992065576;12502.812457813048;12523.060770442162;12526.248425094524;12580.622581322576;10400.531976061095;10735.892641073568;10792.838107428317;10879.66896220854;10957.726056848564;8521.786955326166;8599.785005374853;8699.217070463625;8722.345824063157;9030.548472576345;2921.2842853500815;2978.4192082543914;3001.1896787867154;3027.7577793776445;3035.6964303569466;43140.35289470661;43174.13651726948;43556.56443435557;43626.34560481627;43757.34363984543;8020.35837133028;8111.432199746079;8168.183181681903;8226;8322.16778322175;17459.825401746075;17467.30130794754;17560.648787024442;17589.560260993323;17690.5577360567;5665.943340566624;5972.731227094704;6061.242344706911;6470.22357317125;6791.422729068085;3415.351083294166;3481.8781342652887;3543.7342199335153;3630.146915474861;3666.211764470652;2428.890699918508;2447.0701133569128;2463.310273123528;2467.617519284478;2478.5042991401792;379.9696024318048;383.14558534467733;384.18360982911315;386.69837526729196;390.79873864959;446.72749622730106;470.88463326484543;472.614818922577;547.5947798628986;565.428916794041;7031.92968070323;7103;7294.70821167158;7504.812379690551;7520.172780994087;527.2118183315968;530.5779118324834;562.7608266486727;572.9775434582527;580.3355158343758;3374.8650053997567;3434.9313013739584;3459.8270086495572;3470.554375657506;3537.5754909411035;52999.47000529945;53915.19127213095;54318.18522722162;54386.728066359414;54450.455495445334;44769.77615111903;45069;45418.31872521915;45581.31628025582;45758.54241457609;40957.79521102375;41332;41355;42072;42157;6934.618595977269;6969.756058537927;7124.964375178091;7184.640767961477;7243.239459856639;30169.849150754108;31192.37615247637;31774;31849.36301274008;31892.521612175373;38825.41761873518;41312.58687413087;41778.79110604428;41788.3731744018;41922;6190.102435146969;6324.146240257506;6368.0766288886925;6368.076628888878;6466.579672321284;8680.565971701515;9058.456492610465;9145.542722863964;9275.489848058422;9609.471479068718;8354.45696029756;8604.913950860411;8752.64989400417;9003.594838232426;9022.684206052756;8919.464832110094;8980.281577473655;9028.09719028092;9052.637894484411;9133;8466.333105071883;8490.363222758195;8500.53247071417;8893.421927574687;8958.148975847284;7484.738034168778;7629.427792915442;7781.105172904962;7800.063992320957;7848.960755196187;7724.8455030900195;7850.803729906798;7862.685492580233;7890.48711833729;7991.041075071029 07:29:30 INFO - 2015-11-12 07:29:30,887 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:29:30 INFO - 2015-11-12 07:29:30,887 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:29:30 INFO - 2015-11-12 07:29:30,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,856 07:29:30 INFO - 2015-11-12 07:29:30,888 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:29:30 INFO - 2015-11-12 07:29:30,888 DEBUG : BROWSER_OUTPUT: __startTimestamp1447342170873__endTimestamp 07:29:30 INFO - 2015-11-12 07:29:30,888 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,888 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:29:30 INFO - 2015-11-12 07:29:30,889 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:29:30 INFO - 2015-11-12 07:29:30,889 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,889 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4833.42 Median:4969.85 stddev:491.15 (9.9%) stddev-sans-first:466.23 07:29:30 INFO - 2015-11-12 07:29:30,890 DEBUG : BROWSER_OUTPUT: Values: 2807.5 2844.5 2865.8 2867.2 3073.7 4569.6 4641.5 4706.5 4734.5 4782.0 4818.7 4845.7 4951.9 5038.9 5042.7 4492.7 4497.6 4527.6 4543.8 4597.6 4575.6 4671.0 4696.7 4730.5 4829.5 4432.8 4526.5 4540.1 4657.6 4679.5 4534.3 4545.1 4554.3 4556.7 4559.1 4453.4 4544.2 4572.4 4600.5 4639.7 4738.9 4823.9 4835.8 4856.3 4863.2 5037.6 5064.2 5106.3 5205.1 5223.6 4969.8 5046.8 5062.3 5069.6 5117.1 4794.9 4882.1 4903.5 4927.6 4933.9 4913.1 5028.3 5041.8 5270.4 5327.9 4963.1 5020.7 5045.2 5059.5 5089.2 5219.5 5269.6 5277.5 5281.1 5319.1 5019.6 5153.2 5169.7 5176.6 5178.2 5148.4 5208.5 5215.0 5235.5 5255.0 4104.4 4121.2 4142.0 4156.1 4166.4 3629.2 3723.7 3736.6 3738.4 3761.0 4807.7 4875.3 4888.3 4917.6 4922.1 5120.9 5136.7 5147.7 5147.9 5181.3 4655.4 4682.1 4722.0 4779.1 4790.8 4526.1 4585.2 4588.0 4607.8 4640.6 5364.1 5386.9 5403.9 5406.4 5414.6 4907.7 5018.2 5060.2 5205.9 5240.8 5283.3 5336.2 5338.1 5383.5 5392.8 5196.2 5205.8 5213.4 5221.2 5263.6 4903.7 5029.6 5037.8 5283.7 5311.5 4970.6 5016.6 5051.6 5105.6 5156.6 5016.4 5039.1 5046.6 5053.5 5094.7 4803.7 4948.4 4953.8 4969.9 4976.6 4916.7 4998.4 4999.5 5030.1 5076.1 4980.2 4984.2 4988.6 4991.2 5037.1 07:29:30 INFO - 2015-11-12 07:29:30,890 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,890 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42989.61 Median:30227.07 stddev:72283.82 (239.1%) stddev-sans-first:72416.18 07:29:30 INFO - 2015-11-12 07:29:30,892 DEBUG : BROWSER_OUTPUT: Values: 496.9 500.0 500.8 506.0 530.2 26596.5 29674.0 29741.0 29918.4 36448.3 39012.0 39550.8 39668.8 39701.0 40053.4 8409.7 8580.6 8582.2 8596.9 8597.0 7618.7 7842.8 8325.7 8456.7 9935.2 9685.9 9808.5 9819.5 9832.9 9859.6 9701.4 9803.1 9840.7 9878.6 9883.7 7120.3 7759.8 9995.0 10171.9 10208.6 36163.6 36402.8 36410.5 36463.1 36835.0 2655.9 2766.4 2870.2 2901.8 3030.8 24977.9 25312.5 25639.2 25726.0 26517.2 2184.7 2217.9 2221.7 2232.4 2306.3 262920.0 263868.0 264160.0 264994.0 267585.0 54935.7 55311.2 55437.2 56014.7 56106.4 51122.2 52664.0 62971.0 64030.0 64128.0 15353.8 15536.8 15584.8 15662.2 15682.0 11823.4 11843.9 11873.8 11894.6 11959.8 17325.8 17455.7 17472.3 17506.2 17559.3 7395.6 7521.5 7528.5 7539.4 7569.9 800.0 821.4 854.6 961.7 987.4 25588.4 25891.4 25911.0 26103.5 26223.1 936.1 944.7 1012.3 1029.2 1081.3 13377.9 13452.6 13500.5 13505.7 13506.5 283950.0 290746.0 292439.0 293580.0 293619.0 50272.7 50392.0 50466.5 50795.5 50927.7 1212.9 1235.9 1248.1 1250.6 1252.6 25629.6 25888.2 26070.0 26121.5 26214.7 44113.8 44488.6 44617.1 44843.8 44857.1 269091.0 272121.0 273806.0 274144.0 274626.0 28004.7 29014.1 29146.3 29289.9 29785.6 34566.3 34954.7 35255.5 35341.6 36871.3 29629.6 30206.4 30247.7 30384.5 32111.2 25154.6 30685.5 31828.5 32955.0 33626.8 30365.7 30433.4 30540.8 30651.0 30973.5 24907.6 27522.3 27963.9 29297.0 29308.7 20691.7 21112.4 21113.4 21143.7 21149.3 07:29:30 INFO - 2015-11-12 07:29:30,892 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,892 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22968.39 Median:4398.49 stddev:72635.77 (1651.4%) stddev-sans-first:72819.60 07:29:30 INFO - 2015-11-12 07:29:30,893 DEBUG : BROWSER_OUTPUT: Values: 304.4 309.6 309.6 315.0 316.5 15711.1 16239.0 16999.2 17132.5 17134.9 13208.7 13725.5 13754.5 16021.8 16269.0 3952.9 4086.8 4094.1 4098.3 4098.9 4039.0 4076.6 4079.8 4081.9 4097.9 3113.5 3182.4 3210.4 4358.8 4397.0 4365.7 4375.2 4378.6 4379.4 4400.0 3465.3 3635.4 3649.0 3673.5 3708.0 11688.8 11703.7 11901.5 12038.6 12169.1 1666.5 1681.8 1716.9 1741.6 1767.0 8365.7 8568.6 8580.8 8820.8 8953.1 1395.5 1409.0 1422.2 1454.2 1475.7 51120.5 52991.2 53920.0 53934.7 54058.9 5794.8 5843.4 5873.1 5905.6 5957.4 6761.2 6764.3 6770.5 6780.5 6783.6 4978.3 4992.4 5011.1 5035.9 5078.4 5404.4 5419.6 5431.6 5444.2 5461.6 2635.6 2686.0 2687.1 2701.4 2705.9 931.5 933.4 934.6 937.0 996.4 320.9 380.7 383.8 385.8 397.4 10178.9 10337.5 10437.3 10501.2 10691.3 404.4 409.3 412.6 421.6 422.2 5535.5 5715.0 5744.8 5752.8 5757.3 339311.0 439328.0 448554.0 477340.0 490776.0 63476.4 63714.0 68845.0 70320.6 75397.2 403.3 418.0 418.1 418.5 419.5 9111.9 9183.2 9268.5 9283.6 9435.2 31393.5 32166.4 32729.8 33520.3 33624.0 44022.0 44049.0 44050.0 44628.3 44758.3 6999.3 7103.1 7126.2 7141.2 7141.2 10008.8 10329.7 10642.6 10667.1 10774.0 7887.1 8813.6 9132.9 9304.8 9366.9 7632.8 8823.3 9152.1 9170.1 9184.9 9355.3 9569.5 9676.7 9696.7 9756.3 6729.1 6775.1 6872.2 6941.9 6945.1 8848.0 9166.4 9187.1 9230.6 9268.9 07:29:30 INFO - 2015-11-12 07:29:30,893 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,893 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4915.72 Median:6021.46 stddev:2518.16 (41.8%) stddev-sans-first:2509.19 07:29:30 INFO - 2015-11-12 07:29:30,894 DEBUG : BROWSER_OUTPUT: Values: 1135.2 1509.5 1604.6 1621.1 1660.9 6592.3 6830.0 6885.4 6935.2 6964.7 7125.1 7150.2 7229.0 7250.0 7266.0 1714.7 1755.1 1946.5 1966.3 1973.9 1988.8 2029.9 2033.4 2034.9 2036.7 1958.7 1981.1 1981.6 2006.4 2007.5 1968.4 1989.8 2016.5 2017.7 2021.2 2032.0 2062.2 2062.7 2069.2 2072.7 6767.0 6777.3 6786.4 6805.3 6806.5 4224.8 4338.4 4346.5 4353.2 4371.6 2498.9 2550.3 2606.5 2610.0 2629.4 671.2 712.4 790.9 797.4 826.4 9476.1 9501.6 9501.9 9527.0 9541.7 3704.1 3793.7 3832.2 3855.0 3855.6 8229.2 8282.1 8290.8 8299.7 8300.2 4335.6 4343.0 4367.1 4377.3 4380.7 3961.2 3989.1 3991.0 3995.4 4000.5 3283.1 3346.7 3359.2 3385.2 3392.2 1070.9 1078.8 1083.6 1086.7 1086.9 1216.6 1217.6 1232.4 1239.7 1245.1 6735.9 6778.9 6830.5 6861.1 6923.4 1042.2 1063.6 1068.9 1083.4 1090.4 5307.8 5340.2 5369.5 5383.8 5411.1 7998.4 8460.4 8660.4 8709.8 8736.8 7784.0 7836.3 7912.1 7917.7 7949.4 6818.2 6894.4 6932.0 6975.1 6988.9 6209.0 6416.6 6436.4 6443.1 6483.2 7154.9 7170.1 7216.5 7245.6 7299.7 7294.9 7508.2 7526.1 7526.4 7526.8 5998.0 6003.6 6018.8 6033.4 6108.2 6454.4 6497.6 6514.1 6521.6 6577.4 6288.6 6428.5 6432.9 6437.2 6528.3 6309.4 6332.0 6385.8 6427.9 6432.7 6384.4 6440.7 6472.8 6494.6 6528.7 5867.6 5918.8 5935.1 5937.6 5952.9 5944.9 6011.3 6012.4 6024.1 6038.0 07:29:30 INFO - 2015-11-12 07:29:30,894 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,895 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4839.78 Median:5558.79 stddev:1478.44 (26.6%) stddev-sans-first:1442.15 07:29:30 INFO - 2015-11-12 07:29:30,896 DEBUG : BROWSER_OUTPUT: Values: 264.7 276.6 277.2 284.7 285.4 5365.0 5434.1 5573.8 5579.0 5580.9 5376.7 5444.7 5482.0 5509.0 5528.8 4323.8 4330.8 4341.6 4349.5 4350.5 4077.7 4176.1 4249.6 4319.0 4336.6 4233.8 4246.3 4262.6 4280.8 4318.2 4239.3 4243.7 4251.8 4252.0 4255.4 3551.1 3667.1 3671.2 3675.0 3680.7 5145.5 5323.7 5332.4 5349.7 5359.7 4730.0 4735.3 4740.5 4763.7 4773.5 5724.8 5734.9 5747.7 5773.6 5798.2 3757.1 3825.1 3838.5 3858.3 3931.7 5856.3 5891.3 5900.4 5916.2 5922.3 3959.7 3966.9 3967.6 3973.0 3983.2 4013.4 4016.3 4019.4 4019.9 4029.4 4518.3 4584.1 4593.7 4670.7 4723.4 5670.4 5728.2 5733.3 5734.7 5749.8 1401.1 1403.1 1404.5 1404.8 1405.3 908.3 924.0 932.4 941.3 954.0 5492.8 5525.6 5527.0 5533.3 5543.8 5997.4 6022.2 6042.5 6047.2 6073.2 5505.9 5514.9 5528.9 5532.8 5612.3 3215.5 3315.0 3317.0 3329.1 3331.9 6150.6 6159.9 6164.8 6167.9 6196.5 6156.3 6169.2 6191.9 6205.6 6219.7 6057.8 6113.8 6182.7 6219.5 6226.3 6043.4 6049.9 6107.1 6125.4 6127.4 5709.8 5803.3 5858.8 5940.1 5965.8 6127.6 6129.8 6152.5 6161.4 6242.6 3915.6 3948.6 3953.2 3953.7 3968.3 5740.6 5985.7 5991.9 5998.6 6054.1 5743.2 5887.1 5896.2 5906.4 5911.9 5868.1 5870.4 5879.4 5884.1 5886.4 5720.8 5740.7 5745.5 5748.9 5750.1 5677.2 5856.8 5888.9 5903.6 5928.6 5749.3 5759.1 5763.0 5765.8 5772.1 07:29:30 INFO - 2015-11-12 07:29:30,896 DEBUG : BROWSER_OUTPUT: 07:29:30 INFO - 2015-11-12 07:29:30,896 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12094.64 Median:582.75 stddev:14652.79 (2514.4%) stddev-sans-first:14668.41 07:29:30 INFO - 2015-11-12 07:29:30,897 DEBUG : BROWSER_OUTPUT: Values: 585.2 639.8 640.9 680.4 688.9 12359.8 12725.1 12758.3 12761.2 12773.2 11677.1 11808.1 11808.8 11816.7 11872.9 637.6 644.3 797.6 800.8 811.0 799.1 802.8 806.3 811.6 813.4 777.8 825.7 837.1 850.3 854.3 657.8 666.1 816.5 843.5 846.6 629.4 633.8 635.3 636.0 639.8 12323.2 12502.8 12523.1 12526.2 12580.6 10400.5 10735.9 10792.8 10879.7 10957.7 8521.8 8599.8 8699.2 8722.3 9030.5 2921.3 2978.4 3001.2 3027.8 3035.7 43140.4 43174.1 43556.6 43626.3 43757.3 8020.4 8111.4 8168.2 8226.0 8322.2 17459.8 17467.3 17560.6 17589.6 17690.6 5665.9 5972.7 6061.2 6470.2 6791.4 3415.4 3481.9 3543.7 3630.1 3666.2 2428.9 2447.1 2463.3 2467.6 2478.5 380.0 383.1 384.2 386.7 390.8 446.7 470.9 472.6 547.6 565.4 7031.9 7103.0 7294.7 7504.8 7520.2 527.2 530.6 562.8 573.0 580.3 3374.9 3434.9 3459.8 3470.6 3537.6 52999.5 53915.2 54318.2 54386.7 54450.5 44769.8 45069.0 45418.3 45581.3 45758.5 40957.8 41332.0 41355.0 42072.0 42157.0 6934.6 6969.8 7125.0 7184.6 7243.2 30169.8 31192.4 31774.0 31849.4 31892.5 38825.4 41312.6 41778.8 41788.4 41922.0 6190.1 6324.1 6368.1 6368.1 6466.6 8680.6 9058.5 9145.5 9275.5 9609.5 8354.5 8604.9 8752.6 9003.6 9022.7 8919.5 8980.3 9028.1 9052.6 9133.0 8466.3 8490.4 8500.5 8893.4 8958.1 7484.7 7629.4 7781.1 7800.1 7849.0 7724.8 7850.8 7862.7 7890.5 7991.0 07:29:30 INFO - 2015-11-12 07:29:30,898 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:29:30 INFO - 2015-11-12 07:29:30,898 DEBUG : BROWSER_OUTPUT: 07:29:31 INFO - 2015-11-12 07:29:31,589 INFO : Browser exited with error code: 0 07:29:31 INFO - 2015-11-12 07:29:31,620 INFO : Completed test dromaeo_css (00:18:34) 07:29:31 INFO - 2015-11-12 07:29:31,621 INFO : Starting test kraken 07:29:31 INFO - 2015-11-12 07:29:31,621 DEBUG : operating with platform_type : mac_ 07:29:31 INFO - 2015-11-12 07:29:31,621 INFO : Initialising browser for kraken test... 07:29:31 INFO - 2015-11-12 07:29:31,636 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpTCT2Dh/profile http://localhost:50154/getInfo.html 07:29:34 INFO - 2015-11-12 07:29:34,220 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:29:34 INFO - 2015-11-12 07:29:34,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:29:34 INFO - 2015-11-12 07:29:34,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:29:34 INFO - 2015-11-12 07:29:34,220 DEBUG : BROWSER_OUTPUT: __metrics 07:29:34 INFO - 2015-11-12 07:29:34,239 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:34 INFO - 2015-11-12 07:29:34,981 INFO : Browser initialized. 07:29:34 INFO - 2015-11-12 07:29:34,981 INFO : Running cycle 1/1 for kraken test... 07:29:34 INFO - 2015-11-12 07:29:34,982 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpTCT2Dh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:29:47 INFO - 2015-11-12 07:29:47,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 229724160 07:29:47 INFO - 2015-11-12 07:29:47,135 DEBUG : BROWSER_OUTPUT: 07:29:49 INFO - 2015-11-12 07:29:49,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:50 INFO - 2015-11-12 07:29:50,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 285057024 07:29:50 INFO - 2015-11-12 07:29:50,263 DEBUG : BROWSER_OUTPUT: 07:29:53 INFO - 2015-11-12 07:29:53,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-dft) 07:29:53 INFO - 2015-11-12 07:29:53,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 299016192 07:29:53 INFO - 2015-11-12 07:29:53,723 DEBUG : BROWSER_OUTPUT: 07:29:56 INFO - 2015-11-12 07:29:56,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-fft) 07:29:57 INFO - 2015-11-12 07:29:57,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 281542656 07:29:57 INFO - 2015-11-12 07:29:57,476 DEBUG : BROWSER_OUTPUT: 07:29:59 INFO - 2015-11-12 07:29:59,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-oscillator) 07:30:00 INFO - 2015-11-12 07:30:00,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 282914816 07:30:00 INFO - 2015-11-12 07:30:00,197 DEBUG : BROWSER_OUTPUT: 07:30:02 INFO - 2015-11-12 07:30:02,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:03 INFO - 2015-11-12 07:30:03,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 284565504 07:30:03 INFO - 2015-11-12 07:30:03,112 DEBUG : BROWSER_OUTPUT: 07:30:06 INFO - 2015-11-12 07:30:06,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:06 INFO - 2015-11-12 07:30:06,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 284569600 07:30:06 INFO - 2015-11-12 07:30:06,978 DEBUG : BROWSER_OUTPUT: 07:30:10 INFO - 2015-11-12 07:30:10,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:10 INFO - 2015-11-12 07:30:10,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 284590080 07:30:10 INFO - 2015-11-12 07:30:10,942 DEBUG : BROWSER_OUTPUT: 07:30:14 INFO - 2015-11-12 07:30:14,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50154/tests/kraken/driver.html?testName=json-parse-financial) 07:30:14 INFO - 2015-11-12 07:30:14,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 284413952 07:30:14 INFO - 2015-11-12 07:30:14,618 DEBUG : BROWSER_OUTPUT: 07:30:16 INFO - 2015-11-12 07:30:16,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:16 INFO - 2015-11-12 07:30:16,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 320598016 07:30:16 INFO - 2015-11-12 07:30:16,850 DEBUG : BROWSER_OUTPUT: 07:30:18 INFO - 2015-11-12 07:30:18,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:19 INFO - 2015-11-12 07:30:19,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 320094208 07:30:19 INFO - 2015-11-12 07:30:19,397 DEBUG : BROWSER_OUTPUT: 07:30:21 INFO - 2015-11-12 07:30:21,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:22 INFO - 2015-11-12 07:30:22,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 327745536 07:30:22 INFO - 2015-11-12 07:30:22,221 DEBUG : BROWSER_OUTPUT: 07:30:25 INFO - 2015-11-12 07:30:25,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:25 INFO - 2015-11-12 07:30:25,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 328368128 07:30:25 INFO - 2015-11-12 07:30:25,601 DEBUG : BROWSER_OUTPUT: 07:30:28 INFO - 2015-11-12 07:30:28,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:28 INFO - 2015-11-12 07:30:28,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 327729152 07:30:28 INFO - 2015-11-12 07:30:28,984 DEBUG : BROWSER_OUTPUT: 07:30:30 INFO - 2015-11-12 07:30:30,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50154/tests/kraken/driver.html?testName=ai-astar) 07:30:31 INFO - 2015-11-12 07:30:31,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 387727360 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:30:31 INFO - 2015-11-12 07:30:31,086 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;104;106;112;106;108;97;107;114;112 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;175;145;173;183;141;169;165;143;183;141 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;178;180;180;175;182;181;178;173;176 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;89;96;95;78;80;79;94;93;74 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;104;155;101;100;100;146;99;99;146 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;124;130;136;136;134;132;129;129;135;129 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;141;141;139;136;141;147;141;140;135 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;113;112;113;113;114;114;113;114;113 07:30:31 INFO - 2015-11-12 07:30:31,087 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;61;64;64;66;67;67;77;65;66 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;71;72;77;76;77;77;77;74;74 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;95;95;95;98;97;98;96;98;97 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;141;149;143;141;148;145;145;142;140;145 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;161;176;176;168;157;170;177;163;165 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;79;81;81;82;80;81;81;82 07:30:31 INFO - 2015-11-12 07:30:31,089 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: __startTimestamp1447342231085__endTimestamp 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,090 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:30:31 INFO - 2015-11-12 07:30:31,091 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:30:31 INFO - 2015-11-12 07:30:31,091 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,092 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:110.00 stddev:4.84 (4.4%) stddev-sans-first:5.12 07:30:31 INFO - 2015-11-12 07:30:31,092 DEBUG : BROWSER_OUTPUT: Values: 108.0 104.0 106.0 112.0 106.0 108.0 97.0 107.0 114.0 112.0 07:30:31 INFO - 2015-11-12 07:30:31,092 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:161.80 Median:171.00 stddev:17.52 (10.2%) stddev-sans-first:17.92 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: Values: 175.0 145.0 173.0 183.0 141.0 169.0 165.0 143.0 183.0 141.0 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:177.50 Median:179.00 stddev:3.41 (1.9%) stddev-sans-first:2.98 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: Values: 172.0 178.0 180.0 180.0 175.0 182.0 181.0 178.0 173.0 176.0 07:30:31 INFO - 2015-11-12 07:30:31,093 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.40 Median:91.00 stddev:8.77 (9.6%) stddev-sans-first:8.62 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: Values: 76.0 89.0 96.0 95.0 78.0 80.0 79.0 94.0 93.0 74.0 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.40 Median:146.00 stddev:23.38 (16.0%) stddev-sans-first:24.43 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: Values: 104.0 104.0 155.0 101.0 100.0 100.0 146.0 99.0 99.0 146.0 07:30:31 INFO - 2015-11-12 07:30:31,094 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,095 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:131.40 Median:133.00 stddev:3.89 (2.9%) stddev-sans-first:3.07 07:30:31 INFO - 2015-11-12 07:30:31,095 DEBUG : BROWSER_OUTPUT: Values: 124.0 130.0 136.0 136.0 134.0 132.0 129.0 129.0 135.0 129.0 07:30:31 INFO - 2015-11-12 07:30:31,095 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,095 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:140.20 Median:141.00 stddev:3.26 (2.3%) stddev-sans-first:3.44 07:30:31 INFO - 2015-11-12 07:30:31,095 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 141.0 139.0 136.0 141.0 147.0 141.0 140.0 135.0 07:30:31 INFO - 2015-11-12 07:30:31,096 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,096 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:112.90 Median:113.00 stddev:1.20 (1.1%) stddev-sans-first:0.67 07:30:31 INFO - 2015-11-12 07:30:31,096 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 112.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 07:30:31 INFO - 2015-11-12 07:30:31,096 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,096 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:4.62 (7.0%) stddev-sans-first:4.42 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 64.0 64.0 66.0 67.0 67.0 77.0 65.0 66.0 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:76.50 stddev:2.41 (3.1%) stddev-sans-first:2.35 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 77.0 76.0 77.0 77.0 77.0 74.0 74.0 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:97.00 stddev:2.70 (2.8%) stddev-sans-first:1.33 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: Values: 89.0 95.0 95.0 95.0 98.0 97.0 98.0 96.0 98.0 97.0 07:30:31 INFO - 2015-11-12 07:30:31,098 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:145.00 stddev:3.03 (2.1%) stddev-sans-first:3.03 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 143.0 141.0 148.0 145.0 145.0 142.0 140.0 145.0 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:169.00 stddev:7.81 (4.6%) stddev-sans-first:7.22 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: Values: 156.0 161.0 176.0 176.0 168.0 157.0 170.0 177.0 163.0 165.0 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,099 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:81.00 stddev:2.79 (3.4%) stddev-sans-first:1.59 07:30:31 INFO - 2015-11-12 07:30:31,100 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 79.0 81.0 81.0 82.0 80.0 81.0 81.0 82.0 07:30:31 INFO - 2015-11-12 07:30:31,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:30:31 INFO - 2015-11-12 07:30:31,100 DEBUG : BROWSER_OUTPUT: 07:30:31 INFO - 2015-11-12 07:30:31,791 INFO : Browser exited with error code: 0 07:30:31 INFO - 2015-11-12 07:30:31,843 INFO : Completed test kraken (00:01:00) 07:30:31 INFO - 2015-11-12 07:30:31,843 INFO : Starting test v8_7 07:30:31 INFO - 2015-11-12 07:30:31,843 DEBUG : operating with platform_type : mac_ 07:30:31 INFO - 2015-11-12 07:30:31,843 INFO : Initialising browser for v8_7 test... 07:30:31 INFO - 2015-11-12 07:30:31,857 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpxx8Tr9/profile http://localhost:50154/getInfo.html 07:30:34 INFO - 2015-11-12 07:30:34,352 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:30:34 INFO - 2015-11-12 07:30:34,352 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:30:34 INFO - 2015-11-12 07:30:34,352 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:30:34 INFO - 2015-11-12 07:30:34,352 DEBUG : BROWSER_OUTPUT: __metrics 07:30:34 INFO - 2015-11-12 07:30:34,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:35 INFO - 2015-11-12 07:30:35,100 INFO : Browser initialized. 07:30:35 INFO - 2015-11-12 07:30:35,100 INFO : Running cycle 1/1 for v8_7 test... 07:30:35 INFO - 2015-11-12 07:30:35,101 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpxx8Tr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:30:47 INFO - 2015-11-12 07:30:47,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 229089280 07:30:47 INFO - 2015-11-12 07:30:47,289 DEBUG : BROWSER_OUTPUT: 07:31:09 INFO - 2015-11-12 07:31:09,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50154/tests/v8_7/run.html (next: http://localhost:50154/tests/v8_7/run.html) 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 690860032 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:31:10 INFO - 2015-11-12 07:31:10,055 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |0;Richards;173.73175816539262 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;218.00741225201656 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |2;Encrypt;353.73187124159887 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6185.185185185185 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2083.3333333333335 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |5;Earley;994.0357852882704 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |6;Boyer;13794.520547945205 07:31:10 INFO - 2015-11-12 07:31:10,056 DEBUG : BROWSER_OUTPUT: |7;RegExp;33049.18032786885 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: |8;Splay;859.106529209622 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6341.772151898735 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1447342270049__endTimestamp 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:31:10 INFO - 2015-11-12 07:31:10,057 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.73 Median:173.73 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: Values: 173.7 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:218.01 Median:218.01 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: Values: 218.0 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:353.73 Median:353.73 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: Values: 353.7 07:31:10 INFO - 2015-11-12 07:31:10,058 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6185.19 Median:6185.19 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: Values: 6185.2 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2083.33 Median:2083.33 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: Values: 2083.3 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:994.04 Median:994.04 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,059 DEBUG : BROWSER_OUTPUT: Values: 994.0 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13794.52 Median:13794.52 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: Values: 13794.5 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33049.18 Median:33049.18 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: Values: 33049.2 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,060 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:859.11 Median:859.11 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: Values: 859.1 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6341.77 Median:6341.77 stddev:0.00 (0.0%) 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: Values: 6341.8 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:31:10 INFO - 2015-11-12 07:31:10,061 DEBUG : BROWSER_OUTPUT: 07:31:10 INFO - 2015-11-12 07:31:10,806 INFO : Browser exited with error code: 0 07:31:10 INFO - 2015-11-12 07:31:10,828 INFO : Completed test v8_7 (00:00:38) 07:31:11 INFO - 2015-11-12 07:31:11,125 INFO : Completed test suite (00:20:14) 07:31:11 INFO - 2015-11-12 07:31:11,125 DEBUG : Working with test: dromaeo_css 07:31:11 INFO - 2015-11-12 07:31:11,125 DEBUG : Generating results file: dromaeo_css 07:31:11 INFO - 2015-11-12 07:31:11,126 DEBUG : Working with test: kraken 07:31:11 INFO - 2015-11-12 07:31:11,126 DEBUG : Generating results file: kraken 07:31:11 INFO - 2015-11-12 07:31:11,126 INFO : javascript benchmark 07:31:11 INFO - 2015-11-12 07:31:11,126 DEBUG : Working with test: v8_7 07:31:11 INFO - 2015-11-12 07:31:11,126 DEBUG : Generating results file: v8_7 07:31:11 INFO - 2015-11-12 07:31:11,126 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:11 INFO - 2015-11-12 07:31:11,250 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 07:31:11 INFO - 2015-11-12 07:31:11,250 DEBUG : process_Request line: dromaeo_css 5989.73 graph.html#tests=[[72,64,55]] 07:31:11 INFO - 2015-11-12 07:31:11,250 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:11 INFO - 2015-11-12 07:31:11,284 DEBUG : process_Request line: kraken 1658.70 graph.html#tests=[[232,64,55]] 07:31:11 INFO - 2015-11-12 07:31:11,285 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:11 INFO - 2015-11-12 07:31:11,315 DEBUG : process_Request line: v8_7 16474.50 graph.html#tests=[[230,64,55]] 07:31:11 INFO - 2015-11-12 07:31:11,316 INFO : javascript benchmark 07:31:11 INFO - 2015-11-12 07:31:11,317 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [304.36995419481684, 309.5681524273638, 309.60834544301457, 314.97007784260495, 316.5346939998203, 15711.0573365598, 16238.999999999985, 16999.150042497888, 17132.486025419224, 17134.914325428355, 13208.735825283513, 13725.460789753903, 13754.518591849288, 16021.759673604905, 16269.0, 3952.861649842256, 4086.8160932758096, 4094.0992981544014, 4098.282800509914, 4098.8565400211, 4038.9798051009852, 4076.6331030207275, 4079.7552146871135, 4081.8979525511804, 4097.8770636880945, 3113.532970054487, 3182.443072462321, 3210.3739770744714, 4358.803853826569, 4397.0, 4365.716228445172, 4375.2124617568825, 4378.562143785628, 4379.408779814716, 4399.978000110011, 3465.3069386122875, 3635.4365073413665, 3649.033006253345, 3673.485712000322, 3707.9814600927093, 11688.766224675544, 11703.707407314885, 11901.523939042429, 12038.638840834788, 12169.087318451064, 1666.5250403634907, 1681.7813684220973, 1716.9484915452556, 1741.5646088477881, 1766.9646607067916, 8365.707200248024, 8568.571571421404, 8580.785480362978, 8820.823583528294, 8953.059928707456, 1395.5464474045875, 1409.0, 1422.239102080382, 1454.1929229277746, 1475.6827282134393, 51120.48879511232, 52991.20513192305, 53920.0, 53934.73032634851, 54058.91882162374, 5794.768209271582, 5843.444872737083, 5873.119032145127, 5905.586608937333, 5957.404259574095, 6761.188657361148, 6764.323567643295, 6770.526063175629, 6780.491463140284, 6783.592984420852, 4978.303037574742, 4992.350994370709, 5011.1481048221885, 5035.874103147451, 5078.4413714491375, 5404.351477822686, 5419.566434685295, 5431.619786614978, 5444.183372494078, 5461.563074953994, 2635.551956167456, 2686.0, 2687.0595291648156, 2701.3651791828906, 2705.9323516912236, 931.5481991234246, 933.3932943586723, 934.5700977550403, 936.9578368973413, 996.4071377530358, 320.85240789236747, 380.6973456102405, 383.8215229918101, 385.7936004237719, 397.3602499975038, 10178.93121222261, 10337.534810933526, 10437.32157409766, 10501.21240906935, 10691.305065170895, 404.3712027796804, 409.29192496979795, 412.55032015103683, 421.5721043141214, 422.18728946777946, 5535.474129957647, 5715.0, 5744.827655170351, 5752.798652047159, 5757.337906140848, 339311.0, 439328.0, 448554.0, 477340.0, 490776.0, 63476.36523634705, 63714.044289335696, 68845.0, 70320.64839675871, 75397.24602753902, 403.2801449412784, 417.95193552741216, 418.09273875689826, 418.47481410829215, 419.49031926209193, 9111.908880911105, 9183.173514383738, 9268.490233037248, 9283.582238799136, 9435.198008169382, 31393.529097063107, 32166.35667286688, 32729.836350818092, 33520.32959340848, 33624.0, 44022.0, 44049.0, 44050.0, 44628.33057504075, 44758.32862507, 6999.335063168991, 7103.076600041962, 7126.180489243803, 7141.178764441948, 7141.178764442156, 10008.799824003625, 10329.74175645615, 10642.574297028032, 10667.093297069836, 10774.0, 7887.092984306878, 8813.647454101763, 9132.863007055032, 9304.813903721752, 9366.906330936876, 7632.847343052997, 8823.250023748053, 9152.130547597968, 9170.128837760401, 9184.908150918673, 9355.298352623444, 9569.473678947725, 9676.742023536895, 9696.660616878375, 9756.26827987918, 6729.1252137221845, 6775.085363475868, 6872.244053154249, 6941.895871561829, 6945.062416573698, 8847.955760221157, 9166.358354915092, 9187.127222913812, 9230.630774768933, 9268.860967085364], "dojo.html": [2807.480616086023, 2844.530652442346, 2865.7850661200414, 2867.2258490207646, 3073.738732207762, 4569.611583015448, 4641.489436162024, 4706.4822869484415, 4734.526547345268, 4781.976090119549, 4818.734969576672, 4845.685030473017, 4951.876203094925, 5038.899222015558, 5042.672226305297, 4492.707973981697, 4497.550244975509, 4527.615152712024, 4543.772811359436, 4597.586217240448, 4575.588197062264, 4671.042436300567, 4696.694714843524, 4730.455997560291, 4829.517048295177, 4432.756198409086, 4526.4794548627, 4540.069285796404, 4657.604103651193, 4679.461861885893, 4534.274516077412, 4545.068261006486, 4554.316852472156, 4556.681032327739, 4559.088182363541, 4453.376527286183, 4544.159330523864, 4572.382728331666, 4600.539946005406, 4639.744814035227, 4738.857834264978, 4823.927641085352, 4835.758212089381, 4856.2958371036, 4863.1732605457155, 5037.596992240612, 5064.189729643276, 5106.285120083191, 5205.115130427836, 5223.608229382811, 4969.8012079516775, 5046.848594542133, 5062.291279220912, 5069.645124841226, 5117.104506711348, 4794.9211427428545, 4882.121218180726, 4903.509649035103, 4927.556519913225, 4933.876653083702, 4913.115639184981, 5028.270900719448, 5041.8487445376695, 5270.367555893317, 5327.86680332987, 4963.131451995886, 5020.673656212334, 5045.167547354718, 5059.468755780664, 5089.185730283137, 5219.4780521947505, 5269.604779641542, 5277.525022747895, 5281.12861377876, 5319.069162896478, 5019.598432125421, 5153.201253805666, 5169.663971841818, 5176.559992400613, 5178.249153872667, 5148.433672296044, 5208.5051920067535, 5215.035218484592, 5235.502627250406, 5254.97372513135, 4104.384342348611, 4121.155163191538, 4141.958580414218, 4156.085661154541, 4166.416701661769, 3629.2197177606413, 3723.72072094594, 3736.6076561960604, 3738.4018557030745, 3761.0409345616695, 4807.735574543363, 4875.317455556225, 4888.315635810989, 4917.557419832161, 4922.1140194765285, 5120.92318615221, 5136.717480538607, 5147.742612869341, 5147.897042059138, 5181.326427564392, 4655.3947986761505, 4682.063587282489, 4721.952780472151, 4779.06808172403, 4790.8323208688225, 4526.140033393644, 4585.151746926829, 4587.977060114745, 4607.792649330788, 4640.605548528413, 5364.088105022078, 5386.946130538645, 5403.918941215964, 5406.405295417501, 5414.620976531605, 4907.656464047483, 5018.172001619838, 5060.240963855451, 5205.869853253699, 5240.816571419982, 5283.286756288006, 5336.199570064521, 5338.092524270805, 5383.488568585978, 5392.838214853561, 5196.2465442509865, 5205.817796377109, 5213.426523082382, 5221.216817477409, 5263.6052296078715, 4903.705777653352, 5029.622778291716, 5037.823676171316, 5283.682979021271, 5311.521963023347, 4970.552650261494, 5016.648834581544, 5051.595872330278, 5105.617078719037, 5156.61325400589, 5016.423111342242, 5039.118154323052, 5046.646734728533, 5053.4946505350645, 5094.694318340911, 4803.735794531334, 4948.406191257072, 4953.777080031479, 4969.850904472872, 4976.626752993468, 4916.655834091723, 4998.4251811042195, 4999.500049994971, 5030.0945829751, 5076.11168045598, 4980.153373926369, 4984.152694041949, 4988.55103040728, 4991.15150424436, 5037.093323201712], "mootools.html": [1135.199684222623, 1509.4943194030002, 1604.5988502874281, 1621.1002893394166, 1660.858826999705, 6592.340765923405, 6829.965850170748, 6885.414739747115, 6935.202451718054, 6964.6865891034895, 7125.073740413739, 7150.249223831501, 7229.024081748976, 7249.963750181241, 7266.0, 1714.7427885817103, 1755.1224387806096, 1946.4841816918529, 1966.2528239269059, 1973.8519611029158, 1988.7712913015043, 2029.8782073075588, 2033.4408037789578, 2034.9084291206857, 2036.704677821715, 1958.6670266054805, 1981.0886991983705, 1981.5739615982561, 2006.438197304757, 2007.5181956330448, 1968.4094771568473, 1989.7811240763504, 2016.5261163626535, 2017.7074324222979, 2021.181421524285, 2031.9796802031938, 2062.1854367524893, 2062.742157230346, 2069.1516478244, 2072.7098206251135, 6766.966165169192, 6777.322267773233, 6786.3892249697765, 6805.251422343538, 6806.4554835613035, 4224.831006759726, 4338.414314067592, 4346.456692913386, 4353.151135528573, 4371.584699453547, 2498.9250322490175, 2550.33691240277, 2606.504764094816, 2610.0, 2629.447815958651, 671.228087699145, 712.4193782067598, 790.8888012342668, 797.3541431440494, 826.3554427546524, 9476.099770521789, 9501.572429240701, 9501.857472137923, 9526.99966503521, 9541.666041688508, 3704.148045949447, 3793.715471339661, 3832.1952389997855, 3855.036240939765, 3855.5566109897723, 8229.177082291722, 8282.088970213272, 8290.751277461686, 8299.6680132794, 8300.2114799094, 4335.566443355639, 4343.04453020335, 4367.10474352757, 4377.343398490252, 4380.671449641226, 3961.207758448322, 3989.1423343981182, 3990.960090399117, 3995.400689896481, 4000.5199376075057, 3283.1135593390127, 3346.7322614190807, 3359.2441700617164, 3385.2213990781765, 3392.1519620094978, 1070.882202957674, 1078.7626722121122, 1083.6315652678127, 1086.6739978006567, 1086.8641419822522, 1216.5559570756786, 1217.5860207529483, 1232.4022848918266, 1239.727260002798, 1245.0910835090435, 6735.932640673531, 6778.932210677929, 6830.453563714891, 6861.142357205349, 6923.411510021705, 1042.1766804224578, 1063.6277302943909, 1068.9198310126772, 1083.3932997521413, 1090.4166271044953, 5307.840764777063, 5340.19897015443, 5369.543588794996, 5383.7846486140115, 5411.080116380225, 7998.400119990907, 8460.365472589581, 8660.39377243587, 8709.782255443664, 8736.825263494695, 7784.0, 7836.255555722311, 7912.129665736765, 7917.722879699183, 7949.364050875916, 6818.2159051708695, 6894.413974812197, 6932.024373053757, 6975.093237879043, 6988.93011069893, 6209.0, 6416.615003099829, 6436.356364363526, 6443.130177426175, 6483.189601299838, 7154.856902862018, 7170.139583250043, 7216.530925489827, 7245.601491917995, 7299.708011679473, 7294.890576641248, 7508.211637777955, 7526.09686837583, 7526.360259378014, 7526.811829704082, 5997.970010149921, 6003.609765365237, 6018.789342372996, 6033.366496517802, 6108.175396321618, 6454.386833250834, 6497.577657452251, 6514.120593719977, 6521.608703477807, 6577.440917522064, 6288.622682639057, 6428.517861160338, 6432.871342573216, 6437.163168788027, 6528.347165283433, 6309.400606942333, 6332.0, 6385.776497822554, 6427.903581446376, 6432.710528026157, 6384.425401713868, 6440.742370305135, 6472.805815825533, 6494.577852439576, 6528.67356632176, 5867.589268751147, 5918.7928422505, 5935.0503919372695, 5937.554683398676, 5952.880942381042, 5944.910826337522, 6011.338752737282, 6012.428819262163, 6024.1265016573225, 6037.969810150921], "ext.html": [496.88323244037645, 500.0324372339523, 500.7921712489317, 505.9949400505994, 530.2126342381565, 26596.4680706386, 29674.0, 29741.0, 29918.401631967346, 36448.271034579295, 39012.0, 39550.8022459888, 39668.80165599175, 39701.007474813145, 40053.39919901204, 8409.66361345547, 8580.613872375758, 8582.184692454239, 8596.8710469343, 8597.0, 7618.657160427794, 7842.843143137134, 8325.66697332106, 8456.661733530682, 9935.155511781508, 9685.854712179324, 9808.50957452128, 9819.459929703864, 9832.852507212398, 9859.556319965619, 9701.369410988264, 9803.068708472754, 9840.704778856645, 9878.60485580576, 9883.70348889538, 7120.323569260912, 7759.806004849867, 9994.950025249827, 10171.898281017244, 10208.642697505551, 36163.638363616294, 36402.817985910166, 36410.45384319237, 36463.08842278938, 36835.0, 2655.907043253477, 2766.39139389336, 2870.2106920596793, 2901.782366322513, 3030.757539396843, 24977.87511062451, 25312.493750124893, 25639.230823075337, 25726.0, 26517.204483865517, 2184.7159869217057, 2217.8513631271007, 2221.7000704904794, 2232.408411770882, 2306.273523839985, 262920.0, 263868.0, 264160.0, 264993.9999999981, 267585.0, 54935.72532137314, 55311.17033244504, 55437.1684424734, 56014.71992640011, 56106.43893561094, 51122.233166502534, 52664.0, 62971.0, 64030.0, 64128.0, 15353.769693454607, 15536.766948495782, 15584.766228506582, 15662.216889155497, 15682.0, 11823.408829558488, 11843.881561184278, 11873.762524749629, 11894.64316070502, 11959.820602690967, 17325.826741732675, 17455.73816392755, 17472.29179477183, 17506.21222045011, 17559.297628094988, 7395.630218489054, 7521.473496855277, 7528.473006889575, 7539.359154471931, 7569.886451703229, 799.9600019998977, 821.3552361396276, 854.5556310718391, 961.7499450143014, 987.3976874106789, 25588.360290992874, 25891.35271618187, 25911.0, 26103.477930441284, 26223.082192123184, 936.0592604432502, 944.6788092048737, 1012.2610494339026, 1029.2177944762034, 1081.3349789879326, 13377.933110334581, 13452.596422107352, 13500.459981600823, 13505.662358441117, 13506.527271545448, 283950.0, 290746.0, 292439.0, 293580.0, 293619.0, 50272.74863625658, 50392.0, 50466.49533504618, 50795.492045079816, 50927.7453612737, 1212.9332886691316, 1235.8702336254744, 1248.1013670157654, 1250.5560526013135, 1252.6054292897709, 25629.615555766304, 25888.223353299432, 26070.0, 26121.477570448104, 26214.73785262199, 44113.77943110264, 44488.55511444974, 44617.10765784731, 44843.77578112089, 44857.10285794201, 269091.0, 272121.0, 273806.0, 274144.0, 274626.0, 28004.719952800213, 29014.12957611275, 29146.27134321659, 29289.85355073211, 29785.553216701333, 34566.30867382688, 34954.65045349616, 35255.47116793199, 35341.64658353384, 36871.262574747816, 29629.555556666237, 30206.433983356106, 30247.69752302537, 30384.5442318361, 32111.197220069684, 25154.62268065944, 30685.53971690471, 31828.52257216097, 32955.0, 33626.83186584051, 30365.69634303629, 30433.39133217279, 30540.84729576338, 30651.0, 30973.535396969513, 24907.62638560459, 27522.311942201606, 27963.860180698965, 29297.0, 29308.706912930596, 20691.68962465534, 21112.366629001153, 21113.366599002056, 21143.682844757033, 21149.25977590777], "prototype.html": [264.70882029767245, 276.6486562066176, 277.1519151396726, 284.7437306424218, 285.443385398473, 5364.973175134119, 5434.076207044802, 5573.804916827912, 5579.0236708575985, 5580.8604784880345, 5376.677399356041, 5444.700541470217, 5482.0, 5508.9724551377185, 5528.75120619572, 4323.848665296715, 4330.805113769872, 4341.565843415649, 4349.521552629209, 4350.54319296474, 4077.734947228421, 4176.102138040321, 4249.596288352602, 4318.956810431887, 4336.631386332166, 4233.830646774125, 4246.3205887058075, 4262.573742625728, 4280.785960701953, 4318.157959197958, 4239.279322515149, 4243.6605071594195, 4251.766152861592, 4252.022034931983, 4255.361695745632, 3551.1477245460906, 3667.064898450878, 3671.192337685705, 3674.9816250918843, 3680.723945704056, 5145.536901678867, 5323.707196104213, 5332.413434522199, 5349.679019258818, 5359.651622644516, 4730.0, 4735.313379559944, 4740.525947405266, 4763.666543341968, 4773.474917759044, 5724.771009159628, 5734.856628584319, 5747.683877386742, 5773.624714393593, 5798.188253644493, 3757.135858752475, 3825.101101241234, 3838.539375274957, 3858.3247931612136, 3931.744436611611, 5856.32652244993, 5891.263592050994, 5900.380460051676, 5916.171735956969, 5922.318933322636, 3959.703022273341, 3966.8809935701975, 3967.583403742623, 3973.0464688475136, 3983.183447393277, 4013.3779264214095, 4016.3172260715746, 4019.437278780973, 4019.9196016079513, 4029.395590661424, 4518.344839998182, 4584.083183363341, 4593.655475839326, 4670.719756814534, 4723.362346083303, 5670.432956704297, 5728.198052272685, 5733.3406658234, 5734.713264336767, 5749.8275051748515, 1401.1242973141786, 1403.102014710586, 1404.515442172449, 1404.768213244803, 1405.3465138710549, 908.3323757038703, 923.9953800230955, 932.4451951089227, 941.2517048945967, 953.9570719317647, 5492.80775172867, 5525.557955363562, 5527.005139075005, 5533.253010843485, 5543.7782488700805, 5997.400259973968, 6022.156898034279, 6042.486388657014, 6047.183630209954, 6073.175973172496, 5505.862353441196, 5514.944850551443, 5528.944710552843, 5532.806351777668, 5612.270404847343, 3215.469447541176, 3315.0, 3316.9834150829574, 3329.1011426914597, 3331.850066746954, 6150.600210986271, 6159.938400616026, 6164.815055548341, 6167.907481387782, 6196.504279657616, 6156.29202641702, 6169.167162433104, 6191.907121393183, 6205.565610407228, 6219.657918814509, 6057.848553786279, 6113.84715382119, 6182.721777520022, 6219.47134493564, 6226.346233645583, 6043.365446628217, 6049.852302432749, 6107.144999699956, 6125.356837531995, 6127.448529632355, 5709.8287051388525, 5803.274590676166, 5858.794942177004, 5940.138679891478, 5965.791197308074, 6127.632342059491, 6129.80468808578, 6152.507799376129, 6161.44546990755, 6242.563020588515, 3915.6084391560616, 3948.565657777585, 3953.1895961328432, 3953.743006704555, 3968.3452230381663, 5740.598158128891, 5985.730642121028, 5991.88016239664, 5998.640081595118, 6054.122152287981, 5743.167240750151, 5887.087501437284, 5896.174535564938, 5906.350301466921, 5911.940880591139, 5868.061110222344, 5870.354261031198, 5879.382664820303, 5884.0585506318785, 5886.352501224947, 5720.799772008127, 5740.655560666373, 5745.540356771532, 5748.885022299447, 5750.108733146369, 5677.233573467694, 5856.765729370777, 5888.94111058901, 5903.586748927534, 5928.584999050025, 5749.252597162342, 5759.078547432391, 5763.0, 5765.798197063083, 5772.105323674838], "yui.html": [585.1690599348924, 639.830444932093, 640.9487241020719, 680.3502654964508, 688.874771698563, 12359.752804943906, 12725.109242353039, 12758.298293593849, 12761.23432594045, 12773.169743966659, 11677.124215683814, 11808.055355571556, 11808.7638247235, 11816.704582385444, 11872.940635296833, 637.5919411576594, 644.2977154901157, 797.6251161953872, 800.8198155415014, 810.9837803243931, 799.1010113622175, 802.83541873916, 806.2501873257868, 811.5860910935436, 813.3818298093462, 777.817212954958, 825.6532256452305, 837.0541288344193, 850.2985037344184, 854.3336197765752, 657.7730682914411, 666.0808084842935, 816.5182542300072, 843.5360551696542, 846.551327796269, 629.4492319220682, 633.787681126823, 635.2599221906473, 636.0332294911755, 639.7536948274901, 12323.198992065576, 12502.812457813048, 12523.060770442162, 12526.248425094524, 12580.622581322576, 10400.531976061095, 10735.892641073568, 10792.838107428317, 10879.66896220854, 10957.726056848564, 8521.786955326166, 8599.785005374853, 8699.217070463625, 8722.345824063157, 9030.548472576345, 2921.2842853500815, 2978.4192082543914, 3001.1896787867154, 3027.7577793776445, 3035.6964303569466, 43140.35289470661, 43174.13651726948, 43556.56443435557, 43626.34560481627, 43757.34363984543, 8020.35837133028, 8111.432199746079, 8168.183181681903, 8226.0, 8322.16778322175, 17459.825401746075, 17467.30130794754, 17560.648787024442, 17589.560260993323, 17690.5577360567, 5665.943340566624, 5972.731227094704, 6061.242344706911, 6470.22357317125, 6791.422729068085, 3415.351083294166, 3481.8781342652887, 3543.7342199335153, 3630.146915474861, 3666.211764470652, 2428.890699918508, 2447.0701133569128, 2463.310273123528, 2467.617519284478, 2478.5042991401792, 379.9696024318048, 383.14558534467733, 384.18360982911315, 386.69837526729196, 390.79873864959, 446.72749622730106, 470.88463326484543, 472.614818922577, 547.5947798628986, 565.428916794041, 7031.92968070323, 7103.0, 7294.70821167158, 7504.812379690551, 7520.172780994087, 527.2118183315968, 530.5779118324834, 562.7608266486727, 572.9775434582527, 580.3355158343758, 3374.8650053997567, 3434.9313013739584, 3459.8270086495572, 3470.554375657506, 3537.5754909411035, 52999.47000529945, 53915.19127213095, 54318.18522722162, 54386.728066359414, 54450.455495445334, 44769.77615111903, 45069.0, 45418.31872521915, 45581.31628025582, 45758.54241457609, 40957.79521102375, 41332.0, 41355.0, 42072.0, 42157.0, 6934.618595977269, 6969.756058537927, 7124.964375178091, 7184.640767961477, 7243.239459856639, 30169.849150754108, 31192.37615247637, 31774.0, 31849.36301274008, 31892.521612175373, 38825.41761873518, 41312.58687413087, 41778.79110604428, 41788.3731744018, 41922.0, 6190.102435146969, 6324.146240257506, 6368.0766288886925, 6368.076628888878, 6466.579672321284, 8680.565971701515, 9058.456492610465, 9145.542722863964, 9275.489848058422, 9609.471479068718, 8354.45696029756, 8604.913950860411, 8752.64989400417, 9003.594838232426, 9022.684206052756, 8919.464832110094, 8980.281577473655, 9028.09719028092, 9052.637894484411, 9133.0, 8466.333105071883, 8490.363222758195, 8500.53247071417, 8893.421927574687, 8958.148975847284, 7484.738034168778, 7629.427792915442, 7781.105172904962, 7800.063992320957, 7848.960755196187, 7724.8455030900195, 7850.803729906798, 7862.685492580233, 7890.48711833729, 7991.041075071029]}, "summary": {"lowerIsBetter": false, "suite": 5989.727908194625, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6059.104104044238, "unit": "ms", "value": 6059.104104044238}, "dojo.html": {"lowerIsBetter": false, "filtered": 4803.953411170283, "unit": "ms", "value": 4803.953411170283}, "mootools.html": {"lowerIsBetter": false, "filtered": 4046.968127332449, "unit": "ms", "value": 4046.968127332449}, "ext.html": {"lowerIsBetter": false, "filtered": 16867.111444178285, "unit": "ms", "value": 16867.111444178285}, "prototype.html": {"lowerIsBetter": false, "filtered": 4343.163644977427, "unit": "ms", "value": 4343.163644977427}, "yui.html": {"lowerIsBetter": false, "filtered": 5350.784047735433, "unit": "ms", "value": 5350.784047735433}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447341056, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112061647", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 178.0, 180.0, 180.0, 175.0, 182.0, 181.0, 178.0, 173.0, 176.0], "ai-astar": [108.0, 104.0, 106.0, 112.0, 106.0, 108.0, 97.0, 107.0, 114.0, 112.0], "imaging-gaussian-blur": [124.0, 130.0, 136.0, 136.0, 134.0, 132.0, 129.0, 129.0, 135.0, 129.0], "audio-beat-detection": [175.0, 145.0, 173.0, 183.0, 141.0, 169.0, 165.0, 143.0, 183.0, 141.0], "json-stringify-tinderbox": [72.0, 71.0, 72.0, 77.0, 76.0, 77.0, 77.0, 77.0, 74.0, 74.0], "stanford-crypto-pbkdf2": [156.0, 161.0, 176.0, 176.0, 168.0, 157.0, 170.0, 177.0, 163.0, 165.0], "json-parse-financial": [60.0, 61.0, 64.0, 64.0, 66.0, 67.0, 67.0, 77.0, 65.0, 66.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 79.0, 81.0, 81.0, 82.0, 80.0, 81.0, 81.0, 82.0], "audio-fft": [76.0, 89.0, 96.0, 95.0, 78.0, 80.0, 79.0, 94.0, 93.0, 74.0], "imaging-darkroom": [141.0, 141.0, 141.0, 139.0, 136.0, 141.0, 147.0, 141.0, 140.0, 135.0], "stanford-crypto-ccm": [141.0, 149.0, 143.0, 141.0, 148.0, 145.0, 145.0, 142.0, 140.0, 145.0], "audio-oscillator": [104.0, 104.0, 155.0, 101.0, 100.0, 100.0, 146.0, 99.0, 99.0, 146.0], "stanford-crypto-aes": [89.0, 95.0, 95.0, 95.0, 98.0, 97.0, 98.0, 96.0, 98.0, 97.0], "imaging-desaturate": [110.0, 113.0, 112.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0]}, "summary": {"lowerIsBetter": true, "suite": 1658.7000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 166.9, "unit": "ms", "value": 166.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 161.8, "unit": "ms", "value": 161.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 143.9, "unit": "ms", "value": 143.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 140.2, "unit": "ms", "value": 140.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 65.7, "unit": "ms", "value": 65.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 115.4, "unit": "ms", "value": 115.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.4, "unit": "ms", "value": 107.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 177.5, "unit": "ms", "value": 177.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 79.7, "unit": "ms", "value": 79.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 74.7, "unit": "ms", "value": 74.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 131.4, "unit": "ms", "value": 131.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 112.9, "unit": "ms", "value": 112.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447341056, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112061647", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}, {"talos_counters": {}, "results": {"DeltaBlue": [218.00741225201656], "Encrypt": [353.73187124159887], "NavierStokes": [6341.772151898735], "Decrypt": [6185.185185185185], "Splay": [859.106529209622], "Richards": [173.73175816539262], "RegExp": [33049.18032786885], "Earley": [994.0357852882704], "Boyer": [13794.520547945205], "RayTrace": [2083.3333333333335]}, "summary": {"lowerIsBetter": false, "suite": 16474.5033675561, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 303.283266, "unit": "score", "value": 303.283266}, "Encrypt": {"lowerIsBetter": false, "filtered": 752.4936870000003, "unit": "score", "value": 752.4936870000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 234.00399201596804, "unit": "score", "value": 234.00399201596804}, "Decrypt": {"lowerIsBetter": false, "filtered": 43.03525149700596, "unit": "score", "value": 43.03525149700596}, "Splay": {"lowerIsBetter": false, "filtered": 94.85552399999997, "unit": "score", "value": 94.85552399999997}, "RegExp": {"lowerIsBetter": false, "filtered": 27.564526289682522, "unit": "score", "value": 27.564526289682522}, "Richards": {"lowerIsBetter": false, "filtered": 203.19831200000004, "unit": "score", "value": 203.19831200000004}, "Earley": {"lowerIsBetter": false, "filtered": 670.4617780000001, "unit": "score", "value": 670.4617780000001}, "Boyer": {"lowerIsBetter": false, "filtered": 48.31360377358492, "unit": "score", "value": 48.31360377358492}, "RayTrace": {"lowerIsBetter": false, "filtered": 355.19471999999996, "unit": "score", "value": 355.19471999999996}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447341056, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112061647", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}] 07:31:11 INFO - RETURN: dromaeo_css: 5989.73 07:31:11 INFO - RETURN: kraken: 1658.70 07:31:11 INFO - RETURN: v8_7: 16474.50 07:31:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16474.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1658.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5989.73"}}} 07:31:11 INFO - Return code: 0 07:31:11 INFO - # TBPL SUCCESS # 07:31:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:31:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:31:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:31:11 INFO - 2015-11-12 07:31:11.413 screenresolution[2264:20457] starting screenresolution argv=screenresolution get 07:31:11 INFO - 2015-11-12 07:31:11.416 screenresolution[2264:20457] Display 0: 1600x1200x32@60 07:31:11 INFO - 2015-11-12 07:31:11.423 screenresolution[2265:20461] starting screenresolution argv=screenresolution list 07:31:11 INFO - Available Modes on Display 0 07:31:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:31:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:31:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:31:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:31:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:31:11 INFO - Intel HD Graphics 3000: 07:31:11 INFO - Chipset Model: Intel HD Graphics 3000 07:31:11 INFO - Type: GPU 07:31:11 INFO - Bus: Built-In 07:31:11 INFO - VRAM (Total): 512 MB 07:31:11 INFO - VRAM (Dynamic, Max): 10 07:31:11 INFO - Vendor: Intel (0x8086) 07:31:11 INFO - Device ID: 0x0116 07:31:11 INFO - Revision ID: 0x0009 07:31:11 INFO - Displays: 07:31:11 INFO - Display: 07:31:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:31:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:31:11 INFO - Display Serial Number: 1600x1200 60 07:31:11 INFO - Main Display: Yes 07:31:11 INFO - Mirror: Off 07:31:11 INFO - Online: Yes 07:31:11 INFO - Rotation: Supported 07:31:11 INFO - Return code: 0 07:31:11 INFO - Running post-action listener: _resource_record_post_action 07:31:11 INFO - Running post-run listener: _resource_record_post_run 07:31:12 INFO - Total resource usage - Wall time: 1254s; CPU: 30.0%; Read bytes: 2297856; Write bytes: 687819776; Read time: 739; Write time: 46332 07:31:12 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 338661888; Write bytes: 334936064; Read time: 33612; Write time: 7531 07:31:12 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 2297856; Write bytes: 341632000; Read time: 739; Write time: 38311 07:31:12 INFO - Running post-run listener: _upload_blobber_files 07:31:12 INFO - Blob upload gear active. 07:31:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:31:12 INFO - Copying logs to upload dir... 07:31:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1384.194504 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-11-12 07:31:12.826236) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 07:31:12.830109) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010230 build_url: 'https://queue.taskcluster.net/v1/task/UEIjPLYHS2WlL4oJ8ibU7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 07:31:12.856586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:31:12.856985) ========= 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.5BgPHZFX29/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.uThfZzFRYZ/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005327 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 07:31:12.906544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 07:31:12.906872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 07:31:12.907330) ========= ========= Total master_lag: 0.31 =========