builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0103 starttime: 1447428954.83 results: success (0) buildid: 20151113053738 builduid: c80320f521ff4192a2660816a704cd92 revision: 55174ceac7e5b3d3f00afbce746966c0efb2890d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:54.833844) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:54.834351) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:54.834718) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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.006634 basedir: '/builds/slave/test' ========= master_lag: 0.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.037999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.038356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.069854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.070337) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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.047052 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.133801) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.134153) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.134556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.134887) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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-13 07:35:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-13 07:35:55 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.400487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.554532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.554943) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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.248186 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:55.819972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 07:35:55.820418) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55174ceac7e5b3d3f00afbce746966c0efb2890d --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 55174ceac7e5b3d3f00afbce746966c0efb2890d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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-13 07:35:55,929 truncating revision to first 12 chars 2015-11-13 07:35:55,930 Setting DEBUG logging. 2015-11-13 07:35:55,930 attempt 1/10 2015-11-13 07:35:55,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55174ceac7e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 07:35:56,206 unpacking tar archive at: fx-team-55174ceac7e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 07:35:57.122883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:57.123388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:57.138510) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:57.138979) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 07:35:57.139577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 22 secs) (at 2015-11-13 07:35:57.139916) ========= /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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:35:57 INFO - MultiFileLogger online at 20151113 07:35:57 in /builds/slave/test 07:35:57 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:35:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:57 INFO - {'append_to_log': False, 07:35:57 INFO - 'base_work_dir': '/builds/slave/test', 07:35:57 INFO - 'blob_upload_branch': 'Fx-Team', 07:35:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:57 INFO - 'branch': 'Fx-Team', 07:35:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:57 INFO - 'config_files': ('talos/mac_config.py',), 07:35:57 INFO - 'default_actions': ('clobber', 07:35:57 INFO - 'read-buildbot-config', 07:35:57 INFO - 'download-and-extract', 07:35:57 INFO - 'populate-webroot', 07:35:57 INFO - 'create-virtualenv', 07:35:57 INFO - 'install', 07:35:57 INFO - 'run-tests'), 07:35:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:57 INFO - 'download_minidump_stackwalk': True, 07:35:57 INFO - 'download_symbols': 'ondemand', 07:35:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:57 INFO - 'installer_path': 'installer.exe', 07:35:57 INFO - 'log_level': 'info', 07:35:57 INFO - 'log_name': 'talos', 07:35:57 INFO - 'log_to_console': True, 07:35:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:57 INFO - 'opt_config_files': (), 07:35:57 INFO - 'pip_index': False, 07:35:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:57 INFO - 'cmd': ('bash', 07:35:57 INFO - '-c', 07:35:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:57 INFO - 'enabled': True, 07:35:57 INFO - 'halt_on_failure': False, 07:35:57 INFO - 'name': 'check_screen_resolution'},), 07:35:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:57 INFO - 'cmd': ('bash', 07:35:57 INFO - '-c', 07:35:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:57 INFO - 'enabled': True, 07:35:57 INFO - 'halt_on_failure': False, 07:35:57 INFO - 'name': 'check_screen_resolution'},), 07:35:57 INFO - 'run_cmd_checks_enabled': True, 07:35:57 INFO - 'sps_profile': False, 07:35:57 INFO - 'sps_profile_interval': 0, 07:35:57 INFO - 'suite': 'dromaeojs', 07:35:57 INFO - 'system_bits': '64', 07:35:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:57 INFO - 'title': 't-yosemite-r5-0103', 07:35:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:57 INFO - 'use_talos_json': True, 07:35:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:57 INFO - 'work_dir': 'build'} 07:35:57 INFO - ##### 07:35:57 INFO - ##### Running clobber step. 07:35:57 INFO - ##### 07:35:57 INFO - Running pre-action listener: _resource_record_pre_action 07:35:57 INFO - Running main action method: clobber 07:35:57 INFO - rmtree: /builds/slave/test/build 07:35:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - ##### 07:36:12 INFO - ##### Running read-buildbot-config step. 07:36:12 INFO - ##### 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: read_buildbot_config 07:36:12 INFO - Using buildbot properties: 07:36:12 INFO - { 07:36:12 INFO - "properties": { 07:36:12 INFO - "buildnumber": 1225, 07:36:12 INFO - "product": "firefox", 07:36:12 INFO - "script_repo_revision": "production", 07:36:12 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 07:36:12 INFO - "repository": "", 07:36:12 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 07:36:12 INFO - "buildid": "20151113053738", 07:36:12 INFO - "slavename": "t-yosemite-r5-0103", 07:36:12 INFO - "pgo_build": "False", 07:36:12 INFO - "basedir": "/builds/slave/test", 07:36:12 INFO - "project": "", 07:36:12 INFO - "platform": "yosemite", 07:36:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:36:12 INFO - "slavebuilddir": "test", 07:36:12 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:36:12 INFO - "branch": "fx-team", 07:36:12 INFO - "repo_path": "integration/fx-team", 07:36:12 INFO - "stage_platform": "macosx64", 07:36:12 INFO - "builduid": "c80320f521ff4192a2660816a704cd92", 07:36:12 INFO - "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d" 07:36:12 INFO - }, 07:36:12 INFO - "sourcestamp": { 07:36:12 INFO - "repository": "", 07:36:12 INFO - "hasPatch": false, 07:36:12 INFO - "project": "", 07:36:12 INFO - "branch": "fx-team-macosx64-talos", 07:36:12 INFO - "changes": [ 07:36:12 INFO - { 07:36:12 INFO - "category": null, 07:36:12 INFO - "files": [ 07:36:12 INFO - { 07:36:12 INFO - "url": null, 07:36:12 INFO - "name": "https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:36:12 INFO - } 07:36:12 INFO - ], 07:36:12 INFO - "repository": "", 07:36:12 INFO - "rev": "55174ceac7e5b3d3f00afbce746966c0efb2890d", 07:36:12 INFO - "who": "cbook@mozilla.com", 07:36:12 INFO - "when": 1447427161, 07:36:12 INFO - "number": 6658486, 07:36:12 INFO - "comments": "Merge mozilla-central to fx-team", 07:36:12 INFO - "project": "", 07:36:12 INFO - "at": "Fri 13 Nov 2015 07:06:01", 07:36:12 INFO - "branch": "fx-team-macosx64-talos", 07:36:12 INFO - "revlink": "", 07:36:12 INFO - "properties": [ 07:36:12 INFO - [ 07:36:12 INFO - "buildid", 07:36:12 INFO - "20151113053738", 07:36:12 INFO - "Change" 07:36:12 INFO - ], 07:36:12 INFO - [ 07:36:12 INFO - "builduid", 07:36:12 INFO - "c80320f521ff4192a2660816a704cd92", 07:36:12 INFO - "Change" 07:36:12 INFO - ], 07:36:12 INFO - [ 07:36:12 INFO - "pgo_build", 07:36:12 INFO - "False", 07:36:12 INFO - "Change" 07:36:12 INFO - ] 07:36:12 INFO - ], 07:36:12 INFO - "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d" 07:36:12 INFO - } 07:36:12 INFO - ], 07:36:12 INFO - "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d" 07:36:12 INFO - } 07:36:12 INFO - } 07:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - ##### 07:36:12 INFO - ##### Running download-and-extract step. 07:36:12 INFO - ##### 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: download_and_extract 07:36:12 INFO - mkdir: /builds/slave/test/build/tests 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:12 INFO - https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/test_packages.json 07:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/test_packages.json 07:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:36:13 INFO - Downloaded 1149 bytes. 07:36:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:36:13 INFO - Using the following test package requirements: 07:36:13 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:36:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:36:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'jsshell-mac.zip'], 07:36:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:36:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:36:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:36:13 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:36:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:36:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:36:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:36:13 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:36:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:36: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:36:13 INFO - https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:36:16 INFO - Downloaded 17460686 bytes. 07:36:16 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:36:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:36:46 INFO - Return code: 0 07:36:46 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:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:46 INFO - https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:36:50 INFO - Downloaded 17460686 bytes. 07:36:50 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:36:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:36:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:37:34 INFO - Return code: 0 07:37:34 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:37:34 INFO - https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:37:36 INFO - Downloaded 11131693 bytes. 07:37:36 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:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:37:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:37:41 INFO - Return code: 0 07:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:41 INFO - https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/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:38:06 INFO - Downloaded 108694500 bytes. 07:38:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:38:06 INFO - mkdir: /builds/slave/test/properties 07:38:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:06 INFO - Contents: 07:38:06 INFO - build_url:https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:38:06 INFO - Running post-action listener: _resource_record_post_action 07:38:06 INFO - Running post-action listener: set_extra_try_arguments 07:38:06 INFO - ##### 07:38:06 INFO - ##### Running populate-webroot step. 07:38:06 INFO - ##### 07:38:06 INFO - Running pre-action listener: _resource_record_pre_action 07:38:06 INFO - Running main action method: populate_webroot 07:38:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:38:06 INFO - '../fennec_ids.txt'], 07:38:06 INFO - 'tests': ['tcheck2']}, 07:38:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:06 INFO - '--tppagecycles', 07:38:06 INFO - '7'], 07:38:06 INFO - 'tests': ['tsvgm']}}, 07:38:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:38:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:38:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:38:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'tests': ['damp', 'tps']}, 07:38:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['damp', 'tps']}, 07:38:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:38:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:06 INFO - 'other': {'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'other_l64': {'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'other_nol64': {'tests': ['a11yr', 07:38:06 INFO - 'ts_paint', 07:38:06 INFO - 'tpaint', 07:38:06 INFO - 'sessionrestore', 07:38:06 INFO - 'sessionrestore_no_auto_restore']}, 07:38:06 INFO - 'svgr': {'tests': ['tsvgx', 07:38:06 INFO - 'tsvgr_opacity', 07:38:06 INFO - 'tart', 07:38:06 INFO - 'tscrollx', 07:38:06 INFO - 'cart']}, 07:38:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['tsvgx', 07:38:06 INFO - 'tsvgr_opacity', 07:38:06 INFO - 'tart', 07:38:06 INFO - 'tscrollx', 07:38:06 INFO - 'cart']}, 07:38:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'tests': ['tp5o']}, 07:38:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'talos_options': ['--e10s'], 07:38:06 INFO - 'tests': ['tp5o']}, 07:38:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'talos_options': ['--xperf_path', 07:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:06 INFO - 'tests': ['tp5n']}, 07:38:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:06 INFO - 'talos_options': ['--e10s', 07:38:06 INFO - '--xperf_path', 07:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:06 INFO - 'tests': ['tp5n']}}, 07:38:06 INFO - 'talos.zip': {'path': '', 07:38:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:06 INFO - Running post-action listener: _resource_record_post_action 07:38:06 INFO - ##### 07:38:06 INFO - ##### Running create-virtualenv step. 07:38:06 INFO - ##### 07:38:06 INFO - Running pre-action listener: _resource_record_pre_action 07:38:06 INFO - Running main action method: create_virtualenv 07:38:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:06 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:38:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:08 INFO - Using real prefix '/tools/python27' 07:38:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:19 INFO - Installing pip.................done. 07:38:19 INFO - Return code: 0 07:38:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38: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:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:19 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:38:19 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:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:19 INFO - 'HOME': '/Users/cltbld', 07:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PAGER': '/bin/cat', 07:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:19 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - 'XPC_FLAGS': '0x0', 07:38:19 INFO - 'XPC_SERVICE_NAME': '0', 07:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:22 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:38:22 INFO - Cleaning up... 07:38:22 INFO - Return code: 0 07:38:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:22 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:22 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:38:22 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:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:22 INFO - 'HOME': '/Users/cltbld', 07:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:22 INFO - 'LOGNAME': 'cltbld', 07:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:22 INFO - 'MOZ_NO_REMOTE': '1', 07:38:22 INFO - 'NO_EM_RESTART': '1', 07:38:22 INFO - 'PAGER': '/bin/cat', 07:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:22 INFO - 'PWD': '/builds/slave/test', 07:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:22 INFO - 'SHELL': '/bin/bash', 07:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:22 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:22 INFO - 'USER': 'cltbld', 07:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:22 INFO - 'XPC_FLAGS': '0x0', 07:38:22 INFO - 'XPC_SERVICE_NAME': '0', 07:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:22 INFO - Downloading/unpacking psutil>=0.7.1 07:38:22 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:38:22 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:38:22 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:38:22 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:38:22 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:38:22 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:38:25 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:38:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:26 INFO - Installing collected packages: psutil 07:38:26 INFO - Running setup.py install for psutil 07:38:26 INFO - building 'psutil._psutil_osx' extension 07:38:26 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:38:31 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:38:31 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:38:31 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:38:31 INFO - building 'psutil._psutil_posix' extension 07:38:31 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:38:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:38:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:38:32 INFO - ^ 07:38:32 INFO - 1 warning generated. 07:38:32 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:38:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:32 INFO - Successfully installed psutil 07:38:32 INFO - Cleaning up... 07:38:32 INFO - Return code: 0 07:38:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:38: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:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:32 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:32 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:38:32 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:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:32 INFO - 'HOME': '/Users/cltbld', 07:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:32 INFO - 'LOGNAME': 'cltbld', 07:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:32 INFO - 'MOZ_NO_REMOTE': '1', 07:38:32 INFO - 'NO_EM_RESTART': '1', 07:38:32 INFO - 'PAGER': '/bin/cat', 07:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:32 INFO - 'PWD': '/builds/slave/test', 07:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:32 INFO - 'SHELL': '/bin/bash', 07:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:32 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:32 INFO - 'USER': 'cltbld', 07:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:32 INFO - 'XPC_FLAGS': '0x0', 07:38:32 INFO - 'XPC_SERVICE_NAME': '0', 07:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:38:32 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:38:32 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:38:32 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:38:32 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:38:32 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:38:32 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:38:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:38:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:35 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:38:35 INFO - Installing collected packages: mozsystemmonitor 07:38:35 INFO - Running setup.py install for mozsystemmonitor 07:38:35 INFO - Successfully installed mozsystemmonitor 07:38:35 INFO - Cleaning up... 07:38:35 INFO - Return code: 0 07:38:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:35 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:35 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:38:35 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:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:35 INFO - 'HOME': '/Users/cltbld', 07:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:35 INFO - 'LOGNAME': 'cltbld', 07:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:35 INFO - 'MOZ_NO_REMOTE': '1', 07:38:35 INFO - 'NO_EM_RESTART': '1', 07:38:35 INFO - 'PAGER': '/bin/cat', 07:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:35 INFO - 'PWD': '/builds/slave/test', 07:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:35 INFO - 'SHELL': '/bin/bash', 07:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:35 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:35 INFO - 'USER': 'cltbld', 07:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:35 INFO - 'XPC_FLAGS': '0x0', 07:38:35 INFO - 'XPC_SERVICE_NAME': '0', 07:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:39 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:38:39 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:38:39 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:38:39 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:38:39 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:38:39 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:38:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:40 INFO - Downloading docopt-0.6.1.tar.gz 07:38:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:40 INFO - Running setup.py install for blobuploader 07:38:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:41 INFO - Running setup.py install for requests 07:38:41 INFO - Running setup.py install for docopt 07:38:41 INFO - Successfully installed blobuploader requests docopt 07:38:41 INFO - Cleaning up... 07:38:41 INFO - Return code: 0 07:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:41 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:38:41 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:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:42 INFO - 'HOME': '/Users/cltbld', 07:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:42 INFO - 'LOGNAME': 'cltbld', 07:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:42 INFO - 'MOZ_NO_REMOTE': '1', 07:38:42 INFO - 'NO_EM_RESTART': '1', 07:38:42 INFO - 'PAGER': '/bin/cat', 07:38:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:42 INFO - 'PWD': '/builds/slave/test', 07:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:42 INFO - 'SHELL': '/bin/bash', 07:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:42 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:42 INFO - 'USER': 'cltbld', 07:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:42 INFO - 'XPC_FLAGS': '0x0', 07:38:42 INFO - 'XPC_SERVICE_NAME': '0', 07:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:42 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-pvF5dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:42 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-zh9OHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:42 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-ZXIlw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:42 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-S5wkKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:42 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-jtAzg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-11CnbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-bs_jgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-y9wXNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-TdGVB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-jXKDyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-pyi4Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:43 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-YciDUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:44 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-DU3DUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:44 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-IhGX7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:44 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-INIvWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:44 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-2l37P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:44 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-iznRfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:44 INFO - Running setup.py install for manifestparser 07:38:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:45 INFO - Running setup.py install for mozcrash 07:38:45 INFO - Running setup.py install for mozdebug 07:38:45 INFO - Running setup.py install for mozdevice 07:38:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:45 INFO - Running setup.py install for mozfile 07:38:45 INFO - Running setup.py install for mozhttpd 07:38:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Running setup.py install for mozinfo 07:38:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Running setup.py install for mozInstall 07:38:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Running setup.py install for mozleak 07:38:46 INFO - Running setup.py install for mozlog 07:38:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:46 INFO - Running setup.py install for moznetwork 07:38:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:47 INFO - Running setup.py install for mozprocess 07:38:47 INFO - Running setup.py install for mozprofile 07:38:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:47 INFO - Running setup.py install for mozrunner 07:38:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:47 INFO - Running setup.py install for mozscreenshot 07:38:47 INFO - Running setup.py install for moztest 07:38:48 INFO - Running setup.py install for mozversion 07:38:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:48 INFO - Cleaning up... 07:38:48 INFO - Return code: 0 07:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:48 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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:48 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:38:48 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:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:48 INFO - 'HOME': '/Users/cltbld', 07:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:48 INFO - 'LOGNAME': 'cltbld', 07:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:48 INFO - 'MOZ_NO_REMOTE': '1', 07:38:48 INFO - 'NO_EM_RESTART': '1', 07:38:48 INFO - 'PAGER': '/bin/cat', 07:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:48 INFO - 'PWD': '/builds/slave/test', 07:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:48 INFO - 'SHELL': '/bin/bash', 07:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:48 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:48 INFO - 'USER': 'cltbld', 07:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:48 INFO - 'XPC_FLAGS': '0x0', 07:38:48 INFO - 'XPC_SERVICE_NAME': '0', 07:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:48 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-CrjiPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:48 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:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:48 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-tAfbsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:48 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:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:48 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-fyIIhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-IV7TTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-LmBnn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-KCkaB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-GFQvgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-iUxsyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:49 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:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:49 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-wghU5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-U_Bauy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-_gt45h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-XOpHxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-wFtHSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-oKyxmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-wpY86N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:50 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:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:50 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-c3laPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:51 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:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:51 INFO - Running setup.py (path:/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/pip-cDgMS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:51 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:38:51 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:38:51 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:38:51 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:38:51 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:38:51 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:38:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:51 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:38:51 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:38:51 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:38:51 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:38:51 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:38:51 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:38:54 INFO - Downloading blessings-1.5.1.tar.gz 07:38:54 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:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:54 INFO - Installing collected packages: blessings 07:38:54 INFO - Running setup.py install for blessings 07:38:54 INFO - Successfully installed blessings 07:38:54 INFO - Cleaning up... 07:38:54 INFO - Return code: 0 07:38:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:54 INFO - Reading from file tmpfile_stdout 07:38:54 INFO - Current package versions: 07:38:54 INFO - blessings == 1.5.1 07:38:54 INFO - blobuploader == 1.2.4 07:38:54 INFO - docopt == 0.6.1 07:38:54 INFO - manifestparser == 1.1 07:38:54 INFO - mozInstall == 1.12 07:38:54 INFO - mozcrash == 0.16 07:38:54 INFO - mozdebug == 0.1 07:38:54 INFO - mozdevice == 0.47 07:38:54 INFO - mozfile == 1.2 07:38:54 INFO - mozhttpd == 0.7 07:38:54 INFO - mozinfo == 0.9 07:38:54 INFO - mozleak == 0.1 07:38:54 INFO - mozlog == 3.0 07:38:54 INFO - moznetwork == 0.27 07:38:54 INFO - mozprocess == 0.22 07:38:54 INFO - mozprofile == 0.27 07:38:54 INFO - mozrunner == 6.11 07:38:54 INFO - mozscreenshot == 0.1 07:38:54 INFO - mozsystemmonitor == 0.0 07:38:54 INFO - moztest == 0.7 07:38:54 INFO - mozversion == 1.4 07:38:54 INFO - psutil == 3.1.1 07:38:54 INFO - requests == 1.2.3 07:38:54 INFO - wsgiref == 0.1.2 07:38:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', '-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 0x104e31490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e0e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82a3700000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, '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.ni2UJanpiS/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.nXe2FUNxZP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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:38:54 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:38:54 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:38:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:38:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:54 INFO - 'HOME': '/Users/cltbld', 07:38:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:54 INFO - 'LOGNAME': 'cltbld', 07:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:54 INFO - 'MOZ_NO_REMOTE': '1', 07:38:54 INFO - 'NO_EM_RESTART': '1', 07:38:54 INFO - 'PAGER': '/bin/cat', 07:38:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:54 INFO - 'PWD': '/builds/slave/test', 07:38:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:54 INFO - 'SHELL': '/bin/bash', 07:38:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:38:54 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:38:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:54 INFO - 'USER': 'cltbld', 07:38:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:54 INFO - 'XPC_FLAGS': '0x0', 07:38:54 INFO - 'XPC_SERVICE_NAME': '0', 07:38:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 INFO - Cleaning up... 07:38:55 INFO - Return code: 0 07:38:55 INFO - Running post-action listener: _resource_record_post_action 07:38:55 INFO - Running post-action listener: _start_resource_monitoring 07:38:55 INFO - Starting resource monitoring. 07:38:55 INFO - ##### 07:38:55 INFO - ##### Running install step. 07:38:55 INFO - ##### 07:38:55 INFO - Running pre-action listener: _resource_record_pre_action 07:38:55 INFO - Running main action method: install 07:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:55 INFO - Reading from file tmpfile_stdout 07:38:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:55 INFO - Reading from file tmpfile_stdout 07:38:55 INFO - Output received: 07:38:55 INFO - Usage: mozinstall [options] installer 07:38:55 INFO - Options: 07:38:55 INFO - -h, --help show this help message and exit 07:38:55 INFO - -d DEST, --destination=DEST 07:38:55 INFO - Directory to install application into. [default: 07:38:55 INFO - "/builds/slave/test"] 07:38:55 INFO - --app=APP Application being installed. [default: firefox] 07:38:55 INFO - mkdir: /builds/slave/test/build/application 07:38:55 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:38:55 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:40:29 INFO - Reading from file tmpfile_stdout 07:40:29 INFO - Output received: 07:40:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:40:29 INFO - Running post-action listener: _resource_record_post_action 07:40:29 INFO - ##### 07:40:29 INFO - ##### Running run-tests step. 07:40:29 INFO - ##### 07:40:29 INFO - Running pre-action listener: _resource_record_pre_action 07:40:29 INFO - Running main action method: run_tests 07:40:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:40:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:40:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:40:29 INFO - 2015-11-13 07:40:29.311 screenresolution[1634:7818] starting screenresolution argv=screenresolution get 07:40:29 INFO - 2015-11-13 07:40:29.315 screenresolution[1634:7818] Display 0: 1600x1200x32@60 07:40:29 INFO - 2015-11-13 07:40:29.321 screenresolution[1635:7820] starting screenresolution argv=screenresolution list 07:40:29 INFO - Available Modes on Display 0 07:40:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:40:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:40:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:40:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:40:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:40:29 INFO - Intel HD Graphics 3000: 07:40:29 INFO - Chipset Model: Intel HD Graphics 3000 07:40:29 INFO - Type: GPU 07:40:29 INFO - Bus: Built-In 07:40:29 INFO - VRAM (Total): 512 MB 07:40:29 INFO - VRAM (Dynamic, Max): 10 07:40:29 INFO - Vendor: Intel (0x8086) 07:40:29 INFO - Device ID: 0x0116 07:40:29 INFO - Revision ID: 0x0009 07:40:29 INFO - Displays: 07:40:29 INFO - Display: 07:40:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:40:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:40:29 INFO - Display Serial Number: 1600x1200 60 07:40:29 INFO - Main Display: Yes 07:40:29 INFO - Mirror: Off 07:40:29 INFO - Online: Yes 07:40:29 INFO - Rotation: Supported 07:40:29 INFO - Return code: 0 07:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:40:29 INFO - Python 2.7.3 07:40:29 INFO - Return code: 0 07:40:29 INFO - grabbing minidump binary from tooltool 07:40:29 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:40:29 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 0x104d549f0>, '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 0x104ab4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d488c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:40:29 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:40:29 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:40:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:40:29 INFO - Return code: 0 07:40:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:40:29 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/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0103', '--webServer', 'localhost'] in /builds/slave/test/build 07:40:29 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/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0103 --webServer localhost 07:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ni2UJanpiS/Render', 07:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:29 INFO - 'HOME': '/Users/cltbld', 07:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:29 INFO - 'LOGNAME': 'cltbld', 07:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:29 INFO - 'MOZ_NO_REMOTE': '1', 07:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:40:29 INFO - 'NO_EM_RESTART': '1', 07:40:29 INFO - 'PAGER': '/bin/cat', 07:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:29 INFO - 'PWD': '/builds/slave/test', 07:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:29 INFO - 'SHELL': '/bin/bash', 07:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXe2FUNxZP/Listeners', 07:40:29 INFO - 'TMPDIR': '/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/', 07:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:29 INFO - 'USER': 'cltbld', 07:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:29 INFO - 'XPC_FLAGS': '0x0', 07:40:29 INFO - 'XPC_SERVICE_NAME': '0', 07:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:40:29 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/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0103', '--webServer', 'localhost'] with output_timeout 3600 07:40:30 INFO - mozversion INFO | application_buildid: 20151113053738 07:40:30 INFO - mozversion INFO | application_changeset: 55174ceac7e5b3d3f00afbce746966c0efb2890d 07:40:30 INFO - mozversion INFO | application_display_name: Nightly 07:40:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:40:30 INFO - mozversion INFO | application_name: Firefox 07:40:30 INFO - mozversion INFO | application_remotingname: firefox 07:40:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:40:30 INFO - mozversion INFO | application_vendor: Mozilla 07:40:30 INFO - mozversion INFO | application_version: 45.0a1 07:40:30 INFO - mozversion INFO | platform_buildid: 20151113053738 07:40:30 INFO - mozversion INFO | platform_changeset: 55174ceac7e5b3d3f00afbce746966c0efb2890d 07:40:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:40:30 INFO - mozversion INFO | platform_version: 45.0a1 07:40:30 INFO - 2015-11-13 07:40:30,676 DEBUG : using testdate: 1447429230 07:40:30 INFO - 2015-11-13 07:40:30,676 DEBUG : actual date: 1447429230 07:40:30 INFO - 2015-11-13 07:40:30,685 INFO : starting webserver on 'localhost:49273' 07:40:30 INFO - 2015-11-13 07:40:30,686 INFO : Starting test suite t-yosemite-r5-0103 07:40:30 INFO - 2015-11-13 07:40:30,686 INFO : Starting test dromaeo_css 07:40:30 INFO - 2015-11-13 07:40:30,686 DEBUG : operating with platform_type : mac_ 07:40:30 INFO - 2015-11-13 07:40:30,687 INFO : Initialising browser for dromaeo_css test... 07:40:30 INFO - 2015-11-13 07:40:30,724 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmpXVN6d9/profile http://localhost:49273/getInfo.html 07:40:39 INFO - 2015-11-13 07:40:39,046 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:40:39 INFO - 2015-11-13 07:40:39,046 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:40:39 INFO - 2015-11-13 07:40:39,046 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:40:39 INFO - 2015-11-13 07:40:39,046 DEBUG : BROWSER_OUTPUT: __metrics 07:40:39 INFO - 2015-11-13 07:40:39,068 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:40:39 INFO - 2015-11-13 07:40:39,872 INFO : Browser initialized. 07:40:39 INFO - 2015-11-13 07:40:39,873 INFO : Running cycle 1/1 for dromaeo_css test... 07:40:39 INFO - 2015-11-13 07:40:39,873 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmpXVN6d9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:40:52 INFO - 2015-11-13 07:40:52,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 232022016 07:40:52 INFO - 2015-11-13 07:40:52,116 DEBUG : BROWSER_OUTPUT: 07:41:43 INFO - 2015-11-13 07:41:43,738 DEBUG : BROWSER_OUTPUT: 1447429303731 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:43:54 INFO - 2015-11-13 07:43:54,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 07:43:56 INFO - 2015-11-13 07:43:56,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 326942720 07:43:56 INFO - 2015-11-13 07:43:56,001 DEBUG : BROWSER_OUTPUT: 07:46:58 INFO - 2015-11-13 07:46:58,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 07:46:59 INFO - 2015-11-13 07:46:59,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 364167168 07:46:59 INFO - 2015-11-13 07:46:59,527 DEBUG : BROWSER_OUTPUT: 07:50:02 INFO - 2015-11-13 07:50:02,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 07:50:03 INFO - 2015-11-13 07:50:03,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 333500416 07:50:03 INFO - 2015-11-13 07:50:03,321 DEBUG : BROWSER_OUTPUT: 07:53:05 INFO - 2015-11-13 07:53:05,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 07:53:06 INFO - 2015-11-13 07:53:06,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 317968384 07:53:06 INFO - 2015-11-13 07:53:06,085 DEBUG : BROWSER_OUTPUT: 07:56:09 INFO - 2015-11-13 07:56:09,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 07:56:09 INFO - 2015-11-13 07:56:09,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 321404928 07:56:09 INFO - 2015-11-13 07:56:09,907 DEBUG : BROWSER_OUTPUT: 07:59:12 INFO - 2015-11-13 07:59:12,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 07:59:13 INFO - 2015-11-13 07:59:13,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 366661632 07:59:13 INFO - 2015-11-13 07:59:13,250 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,250 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:59:13 INFO - 2015-11-13 07:59:13,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:59:13 INFO - 2015-11-13 07:59:13,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:59:13 INFO - 2015-11-13 07:59:13,251 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:59:13 INFO - 2015-11-13 07:59:13,251 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2396.2811156653;2533.290678609989;2544.694636643602;2546.3506805764528;2588.7411258874126;3987.700922430815;4079.4696689430334;4107.466029416171;4150.418941348206;4241.851535196272;4258.339957306623;4265.189613973343;4297.162053399588;4363.192809330276;4369.934450983238;3800.258949504848;3902.9852238418075;3908.2965066288198;3951.9012024699323;4087.734297270683;3983;3999.2601368746728;4040.0505881117915;4042;4051.5948405159543;202.46895156777316;3942.073612701013;3968.3452230381954;3984.740991835536;4014.7390419622775;3935.822887970048;3944.349182384903;3959.307121253769;3998.7000974926996;4014.979925100385;3909.7263191576603;3923.313420151462;3932.3904794756572;3983.24318379507;4024.9937515621095;4016.397540368968;4136.193442278757;4142.751434913915;4233.830646774156;4267.743935363857;4352.7823608819435;4437.822487100512;4440.4893437254805;4489.663275254369;4490.371348011281;4573.245414506636;4577.9542204577865;4583.9083218335445;4588.426446694163;4629.282461218517;4090.81591328385;4159.147374788222;4203.159368126387;4280.165367753259;4294.849680261207;4565.338025986213;4638.2115040443205;4649.883752906205;4668.766561671903;4706.788194531186;4386.1008493258805;4499.550044995474;4505.301678239878;4506.436695413074;4576.405067341224;4416.1609294233995;4543.0232500012;4550.067236216568;4629.537046295411;4644.907101857944;4430.13612345596;4507.954920450819;4518.774061296987;4549.340345649863;4585.358049873021;4417.624501917373;4466.464024317038;4481.641468682497;4489.034857505652;4531.864044078683;3365.3101114272004;3501.439769636846;3510.5611798525183;3514.472829075608;3530.1527633367805;3084.1826915867314;3167.762417818673;3168.683131686813;3207.887723929651;3208.6149662040702;4271.700980931367;4290.227759003409;4293;4296.505901821331;4355.912881742347;4370.082282720601;4510.255807791743;4531.207038768202;4579.496255411902;4582.5417458253905;4202.159568086395;4277.786110694453;4282.8715138545895;4337.783110844445;4378.014946637045;4012.3580227163516;4023.6781057515327;4027.1140349123148;4029.5567487576345;4042.9797851010558;4512.503624601357;4623.791929363254;4645.02454484562;4667.789949452351;4756.5956893664425;4437.689361744647;4479.7536135511555;4502.977485112553;4543.931841022453;4547.772611369484;4695.225287827607;4697.765111744331;4706.788194531186;4765.6187504998825;4775.068861572099;4283;4385.386045953633;4390.275604525217;4518.344839998247;4526.388937493396;4407.316865885793;4443.511213766547;4455.576720211575;4489.236829739018;4514.45826500822;4355.368471571668;4426.313921342197;4437.378766972562;4454.510003899503;4480.731156130512;4244.10873716523;4343.066240758252;4350.58669426404;4430.269005614037;4437.572708381059;4172.248995180897;4213.41012258278;4253.8723838284905;4271.786410679516;4296.742195468282;4401.471823381215;4450.977745111254;4454.420925279693;4473.46318441776;4523.004938913434;4200.936985945152;4291.291936830388;4321.675874309502;4388.4733831940375;4401.977990110029 07:59:13 INFO - 2015-11-13 07:59:13,251 DEBUG : BROWSER_OUTPUT: |1;ext.html;441.3225698552721;446.8101057050753;452.6785981952813;460.89169045274355;482.65731330755165;24094.156704515346;24798.75201247987;31806.68193318069;32715.182120447;32752.344953100925;34507.30985380291;35123;35178.82410587944;35564;35574.46638300428;6541.7710380136705;7318.524295920762;7494.175640679521;7500.774976750679;7515.210902855176;6649.534532582721;6822.829429264283;9031.774205644846;9042.954785226098;9078.86381704275;8827.205551500363;8896.510691911943;8899.199072083511;8919.24186444153;8949.463032218087;6705.497087718391;6895.827604309882;8894.24398926092;8995.145461181177;8999.19007289347;6568.0147977803235;8727.170918762708;8968.596413161424;9020;9029.5620182551;31998.520022199453;32525.349493010242;32577.511337329957;32596.511052334234;32674.346513069606;2218.556288742258;2300.1374484568287;2336.6728657987896;2486.477839653675;2611.764941155286;22565.097396104135;22710.77289227103;23348.64977025329;23502.529949400916;23717.407064823346;1884.0297246917848;1888.490107670935;1907.3229003703625;1923.2979962313796;1931.9034048297528;214361;215818;216021;217470;219686;43481;44521.77739111284;44602.33096503555;50646.24030639543;50864.71108800113;52602;53761;54098.72950635222;54117.72941135269;54169;12592.237086807854;12683.048771342186;12728.681782955315;12735.55425560101;12784;9448.858267126;9454.149126578503;9504.95247523758;9511.096445837635;9529.523523823782;16176.514704558882;16242.269097890623;16321.510354689379;16326.510204693877;16419.835801642068;6297.96851015742;6586.473082153416;6608.86782264352;6660.933390666129;6663.267040625527;689.5276735436242;725.9637018149072;742.3652776875801;792.5324058805332;869.8129902071086;23053;23304.65043024356;23442.76557234406;23457.7654223459;23490.295291141294;812.9431738739614;828.3580225325301;862.8662557303628;903.1916434790826;940.9931373430363;11978.760424791455;12144.514219431301;12253.264804111783;12257.754844903231;12265.08011899111;256054;260349;260808;262174;262596;45127.77436112864;45205.77397112994;45276.3208551872;45289.54710452853;45301.546984529734;1074.9408782517037;1093.1637297467444;1104.690686607751;1105.8285965675334;1125.4091601909063;21530.892345538174;22962;23577;23583.174588889306;23739.287821365386;37116.81441592775;37415;37465.81267093647;37951.81024094862;38087.238255235294;206309;209181;209928;212702;212947;24707.25878223656;25338.493230135664;25420.745792542577;25488.10791622284;25724.356891077874;31818.84090579532;32040.198995024377;32164.35671286608;41157.382639259835;43190.56809431865;29964.850175748983;32289.51565726469;32361.514577281832;32452.837735812114;32489.675103248665;25334.746652533977;31321.373572527966;32155;32469.512957305185;35061.47407788936;31617.84191079122;31954.20114497156;32363.51454728134;32853.67146328506;33246.50130248097;26894.462110758068;28778.712212877603;29535.26161845971;29959.101226963227;29962.25094372658;20990.580188396452;21079.15683372709;21273.468163296042;21290.467738306048;21406 07:59:13 INFO - 2015-11-13 07:59:13,253 DEBUG : BROWSER_OUTPUT: |2;jquery.html;261.29320188889056;262.32713090921783;263.7178219305343;264.7405542568283;266.5109524023417;10630.946845265773;11019.779604407928;11148.386838723867;14076.788848167273;14368.353424095914;13798.310084495784;13810.585682429519;14244.572662820106;14279.928600356983;14401.423943042266;3931.095847954972;3941.881743547698;3949.5063117110362;4054.9594504054876;4160.66714662827;3089.5365695145797;3203.807771533704;3211.6948889855425;4213.810378532958;4573.291139873309;4630.629549636038;4649.86050418488;4697.271922851964;4700.271457924027;4732.3374727538;4503.81984720614;4620.930686039712;4638.327442520849;4725.952740472586;4733.810647574093;3988.202359528106;4001.139754952699;4017.6183262590007;4024.6981476389387;4060.4924384451942;16748.330066797313;16805.83194168055;16893;17417.30330786767;17488.551602775493;1477.2023107521925;1502.0462006625871;1514.8788096952217;1535.3244572388114;1556.9766453503207;10088.798224035552;10263.332883362558;10557.894421055767;10558;11110.333379997146;1350.8041334006612;1392.9442822287097;1400;1428.307270973577;1475.8155230596176;39413.35399407998;40568.79715601433;41630;41750;41873.16253674909;4984.526469985346;5041.1430056889685;5120.48795120485;5128.538431541179;5212.843614691489;5850.707464626752;5876.794312199138;5881.500072493886;5887.381824908409;5913.852153696106;4047.7166598337835;4074.1851629674184;4244.53310135891;4295.742255464682;4311.547287534827;4508.211063063951;4518.277075667877;4565.223911934979;4582.702124361906;4592.471865735483;2287.4395773035712;2287.942801429944;2320.593896068215;2320.733115691717;2328.918487852917;801.555136899015;820.8112134209165;826.6652005937605;853.9316854651613;880.1814312689132;309.57433528897764;321.77958098702464;338.0854787798998;350.6616115448604;369.56391458079185;8419.663213471515;8587.699430519902;8935.553222338856;9342.439453632804;9587.760305992406;337.6387265625806;337.7466899825131;337.85298910200225;350.41305812763517;354.33562071116654;4695.765211739467;4701.529847015271;4784.712917224908;4821.035792841376;4876.122297986397;402663;404528;413072;414883;416875;56371;56847.43152568504;57973;58265;58482.415175847695;389.96658854035894;396.58358723340376;398.1300857626096;400.27550134257086;400.93184158693094;8121.187881211831;8247.546384948886;8314.792130196793;8369.707060252862;8406.83186336282;26557;26602.20193394201;27106.32234194161;27222.455550889266;27338.589921151597;37135.257294853414;37563.81218094001;37900.2419951605;37905.24189516139;38036;4732.905341893074;4745.145873742759;4856.174450343379;4862.489438609036;4904.607631389409;8978;9147.63409463614;9176.816463670822;9225.354225204439;9404.059594040542;7694.615269236628;8064.6370913307865;8075.152109028468;8124.350051995944;8134.023917129983;7618.961905190438;7715.884261736191;7739.5743234122665;7876.6849326028605;7952.681892724227;6660.933390666031;8076.192380761877;8140.959295203486;8288.502689838388;8296.211859873303;4143.3370660694145;4371.2568863293955;4379.58393952574;4483.080968401535;4791.281307803718;7496.437767167593;7673.731419400518;7748.883766743391;7827.686892524235;7844.294013538809 07:59:13 INFO - 2015-11-13 07:59:13,257 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1002.1531805624245;1143.5254369436684;1260.1053252190943;1315.83552055993;1441.8918581106416;5535.612507124503;5898.056310990242;6054.5459090568165;6237.251529816417;6243.46930510906;6036.09458581213;6140.478059364948;6147.446729794317;6147.907781383283;6209.9068513972325;1748.7988881278688;1749.9737503937451;1773.7694099767011;1776.9555761106012;1779.4127937780502;1743.328818404917;1752.8510076643502;1766.5936834528065;1767.8850874693103;1768.3899054826065;1654.8841581089328;1658.8424099710508;1662.9251683674263;1668.1659170414794;1679.7816283883078;1705.6503416799526;1708.2142214581309;1709.350446830209;1715.759793628893;1745.3629425259817;1725.2495164603438;1757.0424118855126;1758.9648207035916;1760.70068088424;1761.7357396390644;5481.260029895953;6128.724207410677;6149.13912052313;6176.752929882799;6207.81376558704;3223.161977885743;3344.3144155448076;3563.6970857476886;3657.9817100914593;3680.871169509081;2277.5786479501344;2286.634138537843;2327.615943369342;2333.0084713996484;2342.3441436397834;691.0877641513205;691.7855464805926;714.6283932355146;730.1347902735223;736.3446532586003;8305.37709671777;8401.53791541471;8426.494410335337;8427.367947403907;8444.788880278042;3194.9840250798597;3249.902502924916;3318.253392986607;3333.283344081034;3345.749068819848;7286.7085316586745;7304.744333948286;7311.488195826348;7330.413566914634;7376.0411146550605;3713.461548075568;3724.404095344732;3745.1198968242443;3746.3631182699005;3770.811459427018;3353.5305057292;3361.7310615150727;3371.713404360657;3372.898813035613;3392.38936991339;2674.2244749022566;2697.905573304964;2699.838009719423;2716.8098233123887;2725.8364498130177;883.4037025008093;884.12471653063;891.3983061433636;899.4738078224312;901.2249465459699;1033.426448321174;1037.3983089807894;1038.657243109772;1068.513826209073;1072.7639919217759;5861.853453663607;5893.941060589425;5925.229720136354;5930.11048342752;5931.377205393458;332.1082892433823;344.211755080867;345.37831902575266;347.633246924492;348.6635396842009;4549.522300158502;4649.651276154302;4652.97673511637;4660.254359302496;4674.789634466457;6611.404973552403;6856.348646878539;6955.234924158339;7152.856942861114;7470.2903224193615;7195.352418282379;7220.097487814023;7261;7287.963560182166;7300.780976570712;5715.428457154335;5795.275590551181;5922.615030022948;5933.080372542263;5935.347111817697;5865.237519122486;5880.8235752927485;5895.086261629454;5912.290525137011;5916.023856063702;6362.713677884599;6519.315471875574;6533.150690410216;6646.9002964956535;6672.132622759011;6597.60414375139;6735;6751.966240168767;6778.288279730557;6933.757318493828;5486.835394938158;5536.892621475801;5538.418466061005;5541.362743284574;5588.441155884379;6048.5161187105805;6066.817995460143;6100.572959892942;6115.908261376172;6134.079888016833;5500.697461639648;5619.157126431068;5675.914861277001;5695.914561281667;5774.076147816497;5468.398476167698;5501.174823776466;5521.420250873601;5559.833205003856;5610.354809196994;5524.861878453071;5561.805336813354;5565.916511252415;5579.16312553104;5633.492985631149;5051.949480505148;5071.39143302806;5084.7966081356335;5091.516305950929;5106.923396148986;5069.721165335942;5119.5648369887485;5135.666181698178;5147;5155.664881782672 07:59:13 INFO - 2015-11-13 07:59:13,258 DEBUG : BROWSER_OUTPUT: |4;prototype.html;227.3509131429768;233.61920070285433;239.67643681030611;240.81216651012207;253.58412203985478;4974.228994505853;4982.800687972482;5008.424031236414;5040.1935690289565;5063.6202284828605;4771.522847715227;4859.173940430126;4896.53482919123;4907.1412502812045;4949.133901567229;3752.8311225994757;3798.620137986193;3807.5240594925635;3809.371453710148;3818.179091495328;3812.3137835189655;3820.2550502651993;3826.598207188233;3838.2323535292912;3848.26882892251;3544.8227588620593;3606.6573675500786;3647.106458917569;3655.94516082259;3780.2250538639514;3788.8295026723863;3791;3792.469054332396;3795.0512371907025;3803.6766874815676;3284.868605255787;3295.1103202135528;3304.041827869915;3315.4529502632035;3333.28334408101;4834.709917404932;4838.588719958808;4863.610911127137;4868.440129385131;4868.561829435333;4123.546409894909;4319.438472998521;4321.524632290446;4340.956590434087;4348.326009468537;5200.349956255468;5203.791848326063;5207.791688332462;5209.531142197183;5229.869253268661;3412.9488057679155;3454.9481757773656;3469.809160496172;3476.2699833035094;3478.7738796978115;5366.302380690485;5460.099083651193;5471.945280547184;5473.863153421196;5541.113421852484;3404.6595340465756;3433.9828300858835;3435.811030393352;3441.346144232588;3447.1554469155217;3366.360391525602;3466.7226621870695;3562.4656301554455;3611.620779818134;3612.6206748291575;4207.474065741782;4211.220924129046;4212.262854000538;4225.514065882463;4231.830726770895;5204.375474943031;5226.137687281556;5232.790688372423;5233.6074794389815;5238.607104467104;1252.661781319057;1262.5391732017747;1265.6709255593428;1268.6320966919675;1272.0904553244475;795.327947884037;815.4251252866715;817.8814071959532;829.5852073963018;829.788403956987;5022.874428139253;5022.949770502249;5032.823851165192;5034.194528875362;5054.721990290495;5428.6199966002005;5444.802143528417;5446.128619420873;5454.318210223722;5482.122860342406;4863.440704318978;5019.887669644843;5029.321041659402;5031.823886163967;5037.949620503748;2869.9426011479654;2887.97112028877;2899.4635992341487;2986.357933044406;2994.5807586937844;5645.68948707825;5651.830445086572;5655.066913959233;5668.433156684298;5727.11229759388;5635.267415235993;5638.210650508932;5643.379228284885;5647.068233741386;5662.292213473316;5409.215663728737;5567.220589117608;5649.915251271316;5682.6306290091015;5685.260916080966;5473.2063850742215;5480.753366098615;5482.862928426821;5490;5511.779528818803;5367.892642147213;5394;5400.675959442446;5407.567394608343;5411;5437.238786569805;5620.690862002465;5633.2113504110275;5642.2665053544415;5643.746031428514;3486.3201675673;3558.323918455485;3559.7864128152396;3566.465030245484;3568.2149927016017;5458.208559758892;5480.588955828409;5481.561475082063;5490.396056433869;5497.862553436036;5286.9471305288;5293.338332708411;5301.390340110936;5319.494648008433;5320.255164277081;5151.742412879266;5309.442508536703;5312.920306195333;5321.2816269804625;5328.440513746156;5158.123119069842;5161.122609156528;5165.070287348313;5170.405403378509;5176.948230517647;5295.973520132375;5302.973485132549;5317.468253174807;5334.732738586008;5434.646747961528;5174.301469301747;5180.6891586504935;5187.533122019036;5194.610404219623;5202.297689811979 07:59:13 INFO - 2015-11-13 07:59:13,261 DEBUG : BROWSER_OUTPUT: |5;yui.html;522.4749127127237;579.4263678957831;585.8506080949358;590.8316129902978;594.7977687586219;10597.894021059787;10731.248812583122;10741.892581074197;10750;10780.838287425695;9951.253655975812;10121.797564048733;10251.897481025188;10278.229132815031;10291.279610427273;548.2954403591386;561.9578531610125;704.2148004974442;717.9030830837848;721.4480922094601;556.0769123255396;704.2429388407456;720.881054625986;721.4516967105012;721.7149226055705;714.0895358418032;738.9150247721527;743.2938708227178;744.0439035838948;744.9962750186269;567.5487987050304;575.7294071786254;576.815419065899;737.2185483387626;741.5587725303436;536.088649296198;538.5341679447289;542.1975476295105;552.2323969682145;552.353746117044;10554.366737995744;10926.890731092746;10927.235093543455;11021.118310535137;11047.83428248577;9261.490618016007;9306;9545.188658963996;9729.951350243275;9829.950850245774;7479.4016478682115;7501.924980750232;7656.61716914152;7933.880991785128;8018.318442932357;2650.496405682914;2666.5066962611786;2673.692525359589;2709.322669332667;2730.4539092181444;32731.836340818383;32999.34001319984;38041.239175216615;38181.618183818086;38847;5438.864028399243;5480;5486.1222204447095;5522.91715624266;5585.8603534911135;9794.902050979399;9819.214462842956;9828.705138845846;9875.259355548362;9878.703638890845;4696.436427628638;4740.478547359788;4819.108464933998;4832.903341933212;4835.903281934412;2738.3017330580574;2846.6868644449096;2914.519104347759;3009.714077162666;3025.1227144128397;2096.8217701495546;2121.2363549122306;2123.58590074937;2130.041481333406;2156.676498525234;318.05696111030903;324.02468569605657;326.89049168528334;327.20978836110527;329.7378584025705;391.6866506794553;393.8936487148511;427.04768366542163;455.41024373436477;468.28118837584145;6018.337982821886;6353.30113687494;6463.773767918195;6476.6114033158165;6532.150820393318;310.58847027688404;432.565271901743;433.3543020898901;445.14976395085233;472.3906161052273;2966.2732630505666;2993.191838203673;3216.9195770105935;3316.9668303316657;3318.618358888759;44460.77769611196;44690.776546117064;44944.550554494694;45326.773366132955;45457.31814022792;36946.44580331297;38048;39878.60121398807;39955.40066898999;40108;35731.285374292886;37044.888653340444;37331;37470.62529374726;37564.24871502555;6255.78104766331;6317.620942743266;6318.399752023551;6365.936340636719;6481.4814814815645;25990.74009259959;26089.73910260873;26874.462510749283;27288.72711272862;27367.589486158122;33083.66916330902;33219;33577.66422335745;33686;34889.65110348864;6058.84852878664;6071.696415179135;6108.969455152695;6377.76852457714;6426.871462570629;8531.91468085336;8739.606717697592;8779.25376343018;8838.29293656493;9136.862947055666;8435.32517398619;8581.570921453778;8584.484930904166;8632.438891472286;8641.82716345657;8339.20777526134;8368.790780230544;8412;8422.368322375723;8461.915380846112;8335.374846886387;8414.284785793276;8480.32157427392;8545.700900468453;8569.48583085017;6978.825529361807;7160.212376638669;7239.529430587206;7555.168931417649;7860.882086768589;6208.286047104641;6710.328967103251;6842.571135886692;6967.09427774386;6983.685734142077 07:59:13 INFO - 2015-11-13 07:59:13,261 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:59:13 INFO - 2015-11-13 07:59:13,261 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:59:13 INFO - 2015-11-13 07:59:13,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 07:59:13 INFO - 2015-11-13 07:59:13,262 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:59:13 INFO - 2015-11-13 07:59:13,262 DEBUG : BROWSER_OUTPUT: __startTimestamp1447430353245__endTimestamp 07:59:13 INFO - 2015-11-13 07:59:13,262 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,263 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:59:13 INFO - 2015-11-13 07:59:13,263 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:59:13 INFO - 2015-11-13 07:59:13,263 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,263 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4196.92 Median:4350.59 stddev:545.89 (12.5%) stddev-sans-first:528.97 07:59:13 INFO - 2015-11-13 07:59:13,263 DEBUG : BROWSER_OUTPUT: Values: 2396.3 2533.3 2544.7 2546.4 2588.7 3987.7 4079.5 4107.5 4150.4 4241.9 4258.3 4265.2 4297.2 4363.2 4369.9 3800.3 3903.0 3908.3 3951.9 4087.7 3983.0 3999.3 4040.1 4042.0 4051.6 202.5 3942.1 3968.3 3984.7 4014.7 3935.8 3944.3 3959.3 3998.7 4015.0 3909.7 3923.3 3932.4 3983.2 4025.0 4016.4 4136.2 4142.8 4233.8 4267.7 4352.8 4437.8 4440.5 4489.7 4490.4 4573.2 4578.0 4583.9 4588.4 4629.3 4090.8 4159.1 4203.2 4280.2 4294.8 4565.3 4638.2 4649.9 4668.8 4706.8 4386.1 4499.6 4505.3 4506.4 4576.4 4416.2 4543.0 4550.1 4629.5 4644.9 4430.1 4508.0 4518.8 4549.3 4585.4 4417.6 4466.5 4481.6 4489.0 4531.9 3365.3 3501.4 3510.6 3514.5 3530.2 3084.2 3167.8 3168.7 3207.9 3208.6 4271.7 4290.2 4293.0 4296.5 4355.9 4370.1 4510.3 4531.2 4579.5 4582.5 4202.2 4277.8 4282.9 4337.8 4378.0 4012.4 4023.7 4027.1 4029.6 4043.0 4512.5 4623.8 4645.0 4667.8 4756.6 4437.7 4479.8 4503.0 4543.9 4547.8 4695.2 4697.8 4706.8 4765.6 4775.1 4283.0 4385.4 4390.3 4518.3 4526.4 4407.3 4443.5 4455.6 4489.2 4514.5 4355.4 4426.3 4437.4 4454.5 4480.7 4244.1 4343.1 4350.6 4430.3 4437.6 4172.2 4213.4 4253.9 4271.8 4296.7 4401.5 4451.0 4454.4 4473.5 4523.0 4200.9 4291.3 4321.7 4388.5 4402.0 07:59:13 INFO - 2015-11-13 07:59:13,264 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,264 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37500.26 Median:32408.18 stddev:60037.91 (185.3%) stddev-sans-first:60141.85 07:59:13 INFO - 2015-11-13 07:59:13,264 DEBUG : BROWSER_OUTPUT: Values: 441.3 446.8 452.7 460.9 482.7 24094.2 24798.8 31806.7 32715.2 32752.3 34507.3 35123.0 35178.8 35564.0 35574.5 6541.8 7318.5 7494.2 7500.8 7515.2 6649.5 6822.8 9031.8 9043.0 9078.9 8827.2 8896.5 8899.2 8919.2 8949.5 6705.5 6895.8 8894.2 8995.1 8999.2 6568.0 8727.2 8968.6 9020.0 9029.6 31998.5 32525.3 32577.5 32596.5 32674.3 2218.6 2300.1 2336.7 2486.5 2611.8 22565.1 22710.8 23348.6 23502.5 23717.4 1884.0 1888.5 1907.3 1923.3 1931.9 214361.0 215818.0 216021.0 217470.0 219686.0 43481.0 44521.8 44602.3 50646.2 50864.7 52602.0 53761.0 54098.7 54117.7 54169.0 12592.2 12683.0 12728.7 12735.6 12784.0 9448.9 9454.1 9505.0 9511.1 9529.5 16176.5 16242.3 16321.5 16326.5 16419.8 6298.0 6586.5 6608.9 6660.9 6663.3 689.5 726.0 742.4 792.5 869.8 23053.0 23304.7 23442.8 23457.8 23490.3 812.9 828.4 862.9 903.2 941.0 11978.8 12144.5 12253.3 12257.8 12265.1 256054.0 260349.0 260808.0 262174.0 262596.0 45127.8 45205.8 45276.3 45289.5 45301.5 1074.9 1093.2 1104.7 1105.8 1125.4 21530.9 22962.0 23577.0 23583.2 23739.3 37116.8 37415.0 37465.8 37951.8 38087.2 206309.0 209181.0 209928.0 212702.0 212947.0 24707.3 25338.5 25420.7 25488.1 25724.4 31818.8 32040.2 32164.4 41157.4 43190.6 29964.9 32289.5 32361.5 32452.8 32489.7 25334.7 31321.4 32155.0 32469.5 35061.5 31617.8 31954.2 32363.5 32853.7 33246.5 26894.5 28778.7 29535.3 29959.1 29962.3 20990.6 21079.2 21273.5 21290.5 21406.0 07:59:13 INFO - 2015-11-13 07:59:13,264 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,264 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20769.48 Median:23043.49 stddev:67183.34 (291.6%) stddev-sans-first:67354.16 07:59:13 INFO - 2015-11-13 07:59:13,266 DEBUG : BROWSER_OUTPUT: Values: 261.3 262.3 263.7 264.7 266.5 10630.9 11019.8 11148.4 14076.8 14368.4 13798.3 13810.6 14244.6 14279.9 14401.4 3931.1 3941.9 3949.5 4055.0 4160.7 3089.5 3203.8 3211.7 4213.8 4573.3 4630.6 4649.9 4697.3 4700.3 4732.3 4503.8 4620.9 4638.3 4726.0 4733.8 3988.2 4001.1 4017.6 4024.7 4060.5 16748.3 16805.8 16893.0 17417.3 17488.6 1477.2 1502.0 1514.9 1535.3 1557.0 10088.8 10263.3 10557.9 10558.0 11110.3 1350.8 1392.9 1400.0 1428.3 1475.8 39413.4 40568.8 41630.0 41750.0 41873.2 4984.5 5041.1 5120.5 5128.5 5212.8 5850.7 5876.8 5881.5 5887.4 5913.9 4047.7 4074.2 4244.5 4295.7 4311.5 4508.2 4518.3 4565.2 4582.7 4592.5 2287.4 2287.9 2320.6 2320.7 2328.9 801.6 820.8 826.7 853.9 880.2 309.6 321.8 338.1 350.7 369.6 8419.7 8587.7 8935.6 9342.4 9587.8 337.6 337.7 337.9 350.4 354.3 4695.8 4701.5 4784.7 4821.0 4876.1 402663.0 404528.0 413072.0 414883.0 416875.0 56371.0 56847.4 57973.0 58265.0 58482.4 390.0 396.6 398.1 400.3 400.9 8121.2 8247.5 8314.8 8369.7 8406.8 26557.0 26602.2 27106.3 27222.5 27338.6 37135.3 37563.8 37900.2 37905.2 38036.0 4732.9 4745.1 4856.2 4862.5 4904.6 8978.0 9147.6 9176.8 9225.4 9404.1 7694.6 8064.6 8075.2 8124.4 8134.0 7619.0 7715.9 7739.6 7876.7 7952.7 6660.9 8076.2 8141.0 8288.5 8296.2 4143.3 4371.3 4379.6 4483.1 4791.3 7496.4 7673.7 7748.9 7827.7 7844.3 07:59:13 INFO - 2015-11-13 07:59:13,266 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,267 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4281.89 Median:5523.14 stddev:2265.81 (41.0%) stddev-sans-first:2258.76 07:59:13 INFO - 2015-11-13 07:59:13,268 DEBUG : BROWSER_OUTPUT: Values: 1002.2 1143.5 1260.1 1315.8 1441.9 5535.6 5898.1 6054.5 6237.3 6243.5 6036.1 6140.5 6147.4 6147.9 6209.9 1748.8 1750.0 1773.8 1777.0 1779.4 1743.3 1752.9 1766.6 1767.9 1768.4 1654.9 1658.8 1662.9 1668.2 1679.8 1705.7 1708.2 1709.4 1715.8 1745.4 1725.2 1757.0 1759.0 1760.7 1761.7 5481.3 6128.7 6149.1 6176.8 6207.8 3223.2 3344.3 3563.7 3658.0 3680.9 2277.6 2286.6 2327.6 2333.0 2342.3 691.1 691.8 714.6 730.1 736.3 8305.4 8401.5 8426.5 8427.4 8444.8 3195.0 3249.9 3318.3 3333.3 3345.7 7286.7 7304.7 7311.5 7330.4 7376.0 3713.5 3724.4 3745.1 3746.4 3770.8 3353.5 3361.7 3371.7 3372.9 3392.4 2674.2 2697.9 2699.8 2716.8 2725.8 883.4 884.1 891.4 899.5 901.2 1033.4 1037.4 1038.7 1068.5 1072.8 5861.9 5893.9 5925.2 5930.1 5931.4 332.1 344.2 345.4 347.6 348.7 4549.5 4649.7 4653.0 4660.3 4674.8 6611.4 6856.3 6955.2 7152.9 7470.3 7195.4 7220.1 7261.0 7288.0 7300.8 5715.4 5795.3 5922.6 5933.1 5935.3 5865.2 5880.8 5895.1 5912.3 5916.0 6362.7 6519.3 6533.2 6646.9 6672.1 6597.6 6735.0 6752.0 6778.3 6933.8 5486.8 5536.9 5538.4 5541.4 5588.4 6048.5 6066.8 6100.6 6115.9 6134.1 5500.7 5619.2 5675.9 5695.9 5774.1 5468.4 5501.2 5521.4 5559.8 5610.4 5524.9 5561.8 5565.9 5579.2 5633.5 5051.9 5071.4 5084.8 5091.5 5106.9 5069.7 5119.6 5135.7 5147.0 5155.7 07:59:13 INFO - 2015-11-13 07:59:13,268 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,269 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4371.55 Median:5036.07 stddev:1363.63 (27.1%) stddev-sans-first:1331.51 07:59:13 INFO - 2015-11-13 07:59:13,270 DEBUG : BROWSER_OUTPUT: Values: 227.4 233.6 239.7 240.8 253.6 4974.2 4982.8 5008.4 5040.2 5063.6 4771.5 4859.2 4896.5 4907.1 4949.1 3752.8 3798.6 3807.5 3809.4 3818.2 3812.3 3820.3 3826.6 3838.2 3848.3 3544.8 3606.7 3647.1 3655.9 3780.2 3788.8 3791.0 3792.5 3795.1 3803.7 3284.9 3295.1 3304.0 3315.5 3333.3 4834.7 4838.6 4863.6 4868.4 4868.6 4123.5 4319.4 4321.5 4341.0 4348.3 5200.3 5203.8 5207.8 5209.5 5229.9 3412.9 3454.9 3469.8 3476.3 3478.8 5366.3 5460.1 5471.9 5473.9 5541.1 3404.7 3434.0 3435.8 3441.3 3447.2 3366.4 3466.7 3562.5 3611.6 3612.6 4207.5 4211.2 4212.3 4225.5 4231.8 5204.4 5226.1 5232.8 5233.6 5238.6 1252.7 1262.5 1265.7 1268.6 1272.1 795.3 815.4 817.9 829.6 829.8 5022.9 5022.9 5032.8 5034.2 5054.7 5428.6 5444.8 5446.1 5454.3 5482.1 4863.4 5019.9 5029.3 5031.8 5037.9 2869.9 2888.0 2899.5 2986.4 2994.6 5645.7 5651.8 5655.1 5668.4 5727.1 5635.3 5638.2 5643.4 5647.1 5662.3 5409.2 5567.2 5649.9 5682.6 5685.3 5473.2 5480.8 5482.9 5490.0 5511.8 5367.9 5394.0 5400.7 5407.6 5411.0 5437.2 5620.7 5633.2 5642.3 5643.7 3486.3 3558.3 3559.8 3566.5 3568.2 5458.2 5480.6 5481.6 5490.4 5497.9 5286.9 5293.3 5301.4 5319.5 5320.3 5151.7 5309.4 5312.9 5321.3 5328.4 5158.1 5161.1 5165.1 5170.4 5176.9 5296.0 5303.0 5317.5 5334.7 5434.6 5174.3 5180.7 5187.5 5194.6 5202.3 07:59:13 INFO - 2015-11-13 07:59:13,270 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,271 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10275.01 Median:5483.06 stddev:12354.12 (225.3%) stddev-sans-first:12367.07 07:59:13 INFO - 2015-11-13 07:59:13,272 DEBUG : BROWSER_OUTPUT: Values: 522.5 579.4 585.9 590.8 594.8 10597.9 10731.2 10741.9 10750.0 10780.8 9951.3 10121.8 10251.9 10278.2 10291.3 548.3 562.0 704.2 717.9 721.4 556.1 704.2 720.9 721.5 721.7 714.1 738.9 743.3 744.0 745.0 567.5 575.7 576.8 737.2 741.6 536.1 538.5 542.2 552.2 552.4 10554.4 10926.9 10927.2 11021.1 11047.8 9261.5 9306.0 9545.2 9730.0 9830.0 7479.4 7501.9 7656.6 7933.9 8018.3 2650.5 2666.5 2673.7 2709.3 2730.5 32731.8 32999.3 38041.2 38181.6 38847.0 5438.9 5480.0 5486.1 5522.9 5585.9 9794.9 9819.2 9828.7 9875.3 9878.7 4696.4 4740.5 4819.1 4832.9 4835.9 2738.3 2846.7 2914.5 3009.7 3025.1 2096.8 2121.2 2123.6 2130.0 2156.7 318.1 324.0 326.9 327.2 329.7 391.7 393.9 427.0 455.4 468.3 6018.3 6353.3 6463.8 6476.6 6532.2 310.6 432.6 433.4 445.1 472.4 2966.3 2993.2 3216.9 3317.0 3318.6 44460.8 44690.8 44944.6 45326.8 45457.3 36946.4 38048.0 39878.6 39955.4 40108.0 35731.3 37044.9 37331.0 37470.6 37564.2 6255.8 6317.6 6318.4 6365.9 6481.5 25990.7 26089.7 26874.5 27288.7 27367.6 33083.7 33219.0 33577.7 33686.0 34889.7 6058.8 6071.7 6109.0 6377.8 6426.9 8531.9 8739.6 8779.3 8838.3 9136.9 8435.3 8581.6 8584.5 8632.4 8641.8 8339.2 8368.8 8412.0 8422.4 8461.9 8335.4 8414.3 8480.3 8545.7 8569.5 6978.8 7160.2 7239.5 7555.2 7860.9 6208.3 6710.3 6842.6 6967.1 6983.7 07:59:13 INFO - 2015-11-13 07:59:13,272 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:59:13 INFO - 2015-11-13 07:59:13,272 DEBUG : BROWSER_OUTPUT: 07:59:13 INFO - 2015-11-13 07:59:13,784 INFO : Browser exited with error code: 0 07:59:13 INFO - 2015-11-13 07:59:13,819 INFO : Completed test dromaeo_css (00:18:43) 07:59:13 INFO - 2015-11-13 07:59:13,819 INFO : Starting test kraken 07:59:13 INFO - 2015-11-13 07:59:13,819 DEBUG : operating with platform_type : mac_ 07:59:13 INFO - 2015-11-13 07:59:13,820 INFO : Initialising browser for kraken test... 07:59:13 INFO - 2015-11-13 07:59:13,836 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmp63NTyS/profile http://localhost:49273/getInfo.html 07:59:18 INFO - 2015-11-13 07:59:18,607 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:59:18 INFO - 2015-11-13 07:59:18,607 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:59:18 INFO - 2015-11-13 07:59:18,608 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:59:18 INFO - 2015-11-13 07:59:18,608 DEBUG : BROWSER_OUTPUT: __metrics 07:59:18 INFO - 2015-11-13 07:59:18,628 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:59:19 INFO - 2015-11-13 07:59:19,469 INFO : Browser initialized. 07:59:19 INFO - 2015-11-13 07:59:19,469 INFO : Running cycle 1/1 for kraken test... 07:59:19 INFO - 2015-11-13 07:59:19,469 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmp63NTyS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:59:31 INFO - 2015-11-13 07:59:31,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 229695488 07:59:31 INFO - 2015-11-13 07:59:31,671 DEBUG : BROWSER_OUTPUT: 07:59:36 INFO - 2015-11-13 07:59:36,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 07:59:36 INFO - 2015-11-13 07:59:36,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 286396416 07:59:36 INFO - 2015-11-13 07:59:36,725 DEBUG : BROWSER_OUTPUT: 07:59:39 INFO - 2015-11-13 07:59:39,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 07:59:40 INFO - 2015-11-13 07:59:40,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 295174144 07:59:40 INFO - 2015-11-13 07:59:40,500 DEBUG : BROWSER_OUTPUT: 07:59:43 INFO - 2015-11-13 07:59:43,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 07:59:44 INFO - 2015-11-13 07:59:44,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 283705344 07:59:44 INFO - 2015-11-13 07:59:44,481 DEBUG : BROWSER_OUTPUT: 07:59:46 INFO - 2015-11-13 07:59:46,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 07:59:47 INFO - 2015-11-13 07:59:47,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 285401088 07:59:47 INFO - 2015-11-13 07:59:47,464 DEBUG : BROWSER_OUTPUT: 07:59:50 INFO - 2015-11-13 07:59:50,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:59:50 INFO - 2015-11-13 07:59:50,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 286109696 07:59:50 INFO - 2015-11-13 07:59:50,629 DEBUG : BROWSER_OUTPUT: 07:59:54 INFO - 2015-11-13 07:59:54,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 07:59:54 INFO - 2015-11-13 07:59:54,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 291311616 07:59:54 INFO - 2015-11-13 07:59:54,926 DEBUG : BROWSER_OUTPUT: 08:00:02 INFO - 2015-11-13 08:00:02,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 08:00:02 INFO - 2015-11-13 08:00:02,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 288808960 08:00:02 INFO - 2015-11-13 08:00:02,730 DEBUG : BROWSER_OUTPUT: 08:00:09 INFO - 2015-11-13 08:00:09,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 08:00:09 INFO - 2015-11-13 08:00:09,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 282873856 08:00:09 INFO - 2015-11-13 08:00:09,803 DEBUG : BROWSER_OUTPUT: 08:00:12 INFO - 2015-11-13 08:00:12,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:13 INFO - 2015-11-13 08:00:13,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 326291456 08:00:13 INFO - 2015-11-13 08:00:13,479 DEBUG : BROWSER_OUTPUT: 08:00:15 INFO - 2015-11-13 08:00:15,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:16 INFO - 2015-11-13 08:00:16,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 326021120 08:00:16 INFO - 2015-11-13 08:00:16,231 DEBUG : BROWSER_OUTPUT: 08:00:18 INFO - 2015-11-13 08:00:18,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:00:19 INFO - 2015-11-13 08:00:19,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 329863168 08:00:19 INFO - 2015-11-13 08:00:19,325 DEBUG : BROWSER_OUTPUT: 08:00:21 INFO - 2015-11-13 08:00:21,785 DEBUG : BROWSER_OUTPUT: 1447430421781 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:00:22 INFO - 2015-11-13 08:00:22,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:00:23 INFO - 2015-11-13 08:00:23,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 328089600 08:00:23 INFO - 2015-11-13 08:00:23,102 DEBUG : BROWSER_OUTPUT: 08:00:27 INFO - 2015-11-13 08:00:27,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:00:28 INFO - 2015-11-13 08:00:28,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 314564608 08:00:28 INFO - 2015-11-13 08:00:28,427 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 08:00:30 INFO - 2015-11-13 08:00:30,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 373555200 08:00:30 INFO - 2015-11-13 08:00:30,726 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,726 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:00:30 INFO - 2015-11-13 08:00:30,726 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:00:30 INFO - 2015-11-13 08:00:30,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:00:30 INFO - 2015-11-13 08:00:30,727 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:00:30 INFO - 2015-11-13 08:00:30,727 DEBUG : BROWSER_OUTPUT: |0;ai-astar;135;139;134;140;141;139;140;133;124;140 08:00:30 INFO - 2015-11-13 08:00:30,727 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;197;165;196;207;162;189;187;158;207;164 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;208;204;203;200;197;206;208;206;201 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |3;audio-fft;98;98;107;155;87;90;89;91;157;86 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;123;127;172;114;114;119;160;112;113;161 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;157;148;156;156;155;146;141;148;148;155 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;162;162;162;163;169;155;162;171;165 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;130;120;120;120;121;121;119;130;120;126 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;71;73;75;74;75;75;75;75;75 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;82;83;87;90;89;86;87;87;87;85 08:00:30 INFO - 2015-11-13 08:00:30,728 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;104;110;109;122;109;110;110;109;123;111 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;157;157;157;163;159;182;164;170;158 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;199;190;200;201;197;182;188;215;221;197 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;88;89;92;91;93;92;91;93;91;92 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1014 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: __startTimestamp1447430430720__endTimestamp 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:00:30 INFO - 2015-11-13 08:00:30,729 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.50 Median:139.50 stddev:5.23 (3.8%) stddev-sans-first:5.52 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: Values: 135.0 139.0 134.0 140.0 141.0 139.0 140.0 133.0 124.0 140.0 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:183.20 Median:192.50 stddev:19.21 (10.0%) stddev-sans-first:19.71 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: Values: 197.0 165.0 196.0 207.0 162.0 189.0 187.0 158.0 207.0 164.0 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:203.00 Median:205.00 stddev:4.14 (2.0%) stddev-sans-first:3.77 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: Values: 197.0 208.0 204.0 203.0 200.0 197.0 206.0 208.0 206.0 201.0 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:105.80 Median:89.50 stddev:27.21 (30.4%) stddev-sans-first:28.71 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: Values: 98.0 98.0 107.0 155.0 87.0 90.0 89.0 91.0 157.0 86.0 08:00:30 INFO - 2015-11-13 08:00:30,730 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:131.50 Median:125.00 stddev:23.35 (18.7%) stddev-sans-first:24.56 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: Values: 123.0 127.0 172.0 114.0 114.0 119.0 160.0 112.0 113.0 161.0 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:151.00 Median:155.00 stddev:5.48 (3.5%) stddev-sans-first:5.36 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: Values: 157.0 148.0 156.0 156.0 155.0 146.0 141.0 148.0 148.0 155.0 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:163.40 Median:163.00 stddev:4.35 (2.7%) stddev-sans-first:4.61 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 162.0 163.0 169.0 155.0 162.0 171.0 165.0 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.70 Median:121.00 stddev:4.30 (3.6%) stddev-sans-first:3.66 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: Values: 130.0 120.0 120.0 120.0 121.0 121.0 119.0 130.0 120.0 126.0 08:00:30 INFO - 2015-11-13 08:00:30,731 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:75.00 stddev:2.37 (3.2%) stddev-sans-first:1.39 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 73.0 75.0 74.0 75.0 75.0 75.0 75.0 75.0 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:87.00 stddev:2.45 (2.8%) stddev-sans-first:2.05 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 87.0 90.0 89.0 86.0 87.0 87.0 87.0 85.0 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.70 Median:110.00 stddev:6.00 (5.5%) stddev-sans-first:5.68 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: Values: 104.0 110.0 109.0 122.0 109.0 110.0 110.0 109.0 123.0 111.0 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:162.30 Median:161.00 stddev:8.19 (5.1%) stddev-sans-first:8.37 08:00:30 INFO - 2015-11-13 08:00:30,732 DEBUG : BROWSER_OUTPUT: Values: 156.0 157.0 157.0 157.0 163.0 159.0 182.0 164.0 170.0 158.0 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:199.50 stddev:11.76 (5.9%) stddev-sans-first:12.47 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: Values: 199.0 190.0 200.0 201.0 197.0 182.0 188.0 215.0 221.0 197.0 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.20 Median:92.00 stddev:1.62 (1.8%) stddev-sans-first:1.24 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 92.0 91.0 93.0 92.0 91.0 93.0 91.0 92.0 08:00:30 INFO - 2015-11-13 08:00:30,733 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:00:30 INFO - 2015-11-13 08:00:30,734 DEBUG : BROWSER_OUTPUT: 08:00:31 INFO - 2015-11-13 08:00:31,391 INFO : Browser exited with error code: 0 08:00:31 INFO - 2015-11-13 08:00:31,449 INFO : Completed test kraken (00:01:17) 08:00:31 INFO - 2015-11-13 08:00:31,449 INFO : Starting test v8_7 08:00:31 INFO - 2015-11-13 08:00:31,449 DEBUG : operating with platform_type : mac_ 08:00:31 INFO - 2015-11-13 08:00:31,450 INFO : Initialising browser for v8_7 test... 08:00:31 INFO - 2015-11-13 08:00:31,467 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmp4v32MI/profile http://localhost:49273/getInfo.html 08:00:36 INFO - 2015-11-13 08:00:36,498 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:00:36 INFO - 2015-11-13 08:00:36,498 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:00:36 INFO - 2015-11-13 08:00:36,499 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:00:36 INFO - 2015-11-13 08:00:36,499 DEBUG : BROWSER_OUTPUT: __metrics 08:00:36 INFO - 2015-11-13 08:00:36,514 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:37 INFO - 2015-11-13 08:00:37,351 INFO : Browser initialized. 08:00:37 INFO - 2015-11-13 08:00:37,352 INFO : Running cycle 1/1 for v8_7 test... 08:00:37 INFO - 2015-11-13 08:00:37,352 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/T/tmp4v32MI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:00:49 INFO - 2015-11-13 08:00:49,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 229851136 08:00:49 INFO - 2015-11-13 08:00:49,555 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 08:01:12 INFO - 2015-11-13 08:01:12,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 299057152 08:01:12 INFO - 2015-11-13 08:01:12,509 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: |0;Richards;210.3049421661409 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;243.74240583232077 08:01:12 INFO - 2015-11-13 08:01:12,510 DEBUG : BROWSER_OUTPUT: |2;Encrypt;411.0152075626798 08:01:12 INFO - 2015-11-13 08:01:12,511 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7328.467153284671 08:01:12 INFO - 2015-11-13 08:01:12,511 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2408.653846153846 08:01:12 INFO - 2015-11-13 08:01:12,511 DEBUG : BROWSER_OUTPUT: |5;Earley;1018.3299389002036 08:01:12 INFO - 2015-11-13 08:01:12,511 DEBUG : BROWSER_OUTPUT: |6;Boyer;16241.935483870968 08:01:12 INFO - 2015-11-13 08:01:12,512 DEBUG : BROWSER_OUTPUT: |7;RegExp;37666.666666666664 08:01:12 INFO - 2015-11-13 08:01:12,512 DEBUG : BROWSER_OUTPUT: |8;Splay;792.3930269413629 08:01:12 INFO - 2015-11-13 08:01:12,512 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7215.827338129497 08:01:12 INFO - 2015-11-13 08:01:12,512 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:01:12 INFO - 2015-11-13 08:01:12,513 DEBUG : BROWSER_OUTPUT: __startTimestamp1447430472509__endTimestamp 08:01:12 INFO - 2015-11-13 08:01:12,514 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,514 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:01:12 INFO - 2015-11-13 08:01:12,514 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:01:12 INFO - 2015-11-13 08:01:12,514 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:210.30 Median:210.30 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: Values: 210.3 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:243.74 Median:243.74 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: Values: 243.7 08:01:12 INFO - 2015-11-13 08:01:12,515 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:411.02 Median:411.02 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: Values: 411.0 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7328.47 Median:7328.47 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: Values: 7328.5 08:01:12 INFO - 2015-11-13 08:01:12,516 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2408.65 Median:2408.65 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: Values: 2408.7 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1018.33 Median:1018.33 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: Values: 1018.3 08:01:12 INFO - 2015-11-13 08:01:12,517 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,518 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16241.94 Median:16241.94 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,518 DEBUG : BROWSER_OUTPUT: Values: 16241.9 08:01:12 INFO - 2015-11-13 08:01:12,518 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,518 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:37666.67 Median:37666.67 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: Values: 37666.7 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: Values: 792.4 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-13 08:01:12,519 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7215.83 Median:7215.83 stddev:0.00 (0.0%) 08:01:12 INFO - 2015-11-13 08:01:12,520 DEBUG : BROWSER_OUTPUT: Values: 7215.8 08:01:12 INFO - 2015-11-13 08:01:12,520 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:01:12 INFO - 2015-11-13 08:01:12,520 DEBUG : BROWSER_OUTPUT: 08:01:13 INFO - 2015-11-13 08:01:13,273 INFO : Browser exited with error code: 0 08:01:13 INFO - 2015-11-13 08:01:13,298 INFO : Completed test v8_7 (00:00:41) 08:01:13 INFO - 2015-11-13 08:01:13,472 INFO : Completed test suite (00:20:42) 08:01:13 INFO - 2015-11-13 08:01:13,472 DEBUG : Working with test: dromaeo_css 08:01:13 INFO - 2015-11-13 08:01:13,472 DEBUG : Generating results file: dromaeo_css 08:01:13 INFO - 2015-11-13 08:01:13,473 DEBUG : Working with test: kraken 08:01:13 INFO - 2015-11-13 08:01:13,474 DEBUG : Generating results file: kraken 08:01:13 INFO - 2015-11-13 08:01:13,474 INFO : javascript benchmark 08:01:13 INFO - 2015-11-13 08:01:13,474 DEBUG : Working with test: v8_7 08:01:13 INFO - 2015-11-13 08:01:13,474 DEBUG : Generating results file: v8_7 08:01:13 INFO - 2015-11-13 08:01:13,474 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:13 INFO - 2015-11-13 08:01:13,535 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 08:01:13 INFO - 2015-11-13 08:01:13,535 DEBUG : process_Request line: dromaeo_css 5257.68 graph.html#tests=[[72,64,55]] 08:01:13 INFO - 2015-11-13 08:01:13,535 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:13 INFO - 2015-11-13 08:01:13,573 DEBUG : process_Request line: kraken 1921.20 graph.html#tests=[[232,64,55]] 08:01:13 INFO - 2015-11-13 08:01:13,573 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:13 INFO - 2015-11-13 08:01:13,613 DEBUG : process_Request line: v8_7 14719.20 graph.html#tests=[[230,64,55]] 08:01:13 INFO - 2015-11-13 08:01:13,614 INFO : javascript benchmark 08:01:13 INFO - 2015-11-13 08:01:13,616 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [261.29320188889056, 262.32713090921783, 263.7178219305343, 264.7405542568283, 266.5109524023417, 10630.946845265773, 11019.779604407928, 11148.386838723867, 14076.788848167273, 14368.353424095914, 13798.310084495784, 13810.585682429519, 14244.572662820106, 14279.928600356983, 14401.423943042266, 3931.095847954972, 3941.881743547698, 3949.5063117110362, 4054.9594504054876, 4160.66714662827, 3089.5365695145797, 3203.807771533704, 3211.6948889855425, 4213.810378532958, 4573.291139873309, 4630.629549636038, 4649.86050418488, 4697.271922851964, 4700.271457924027, 4732.3374727538, 4503.81984720614, 4620.930686039712, 4638.327442520849, 4725.952740472586, 4733.810647574093, 3988.202359528106, 4001.139754952699, 4017.6183262590007, 4024.6981476389387, 4060.4924384451942, 16748.330066797313, 16805.83194168055, 16893.0, 17417.30330786767, 17488.551602775493, 1477.2023107521925, 1502.0462006625871, 1514.8788096952217, 1535.3244572388114, 1556.9766453503207, 10088.798224035552, 10263.332883362558, 10557.894421055767, 10558.0, 11110.333379997146, 1350.8041334006612, 1392.9442822287097, 1400.0, 1428.307270973577, 1475.8155230596176, 39413.35399407998, 40568.79715601433, 41630.0, 41750.0, 41873.16253674909, 4984.526469985346, 5041.1430056889685, 5120.48795120485, 5128.538431541179, 5212.843614691489, 5850.707464626752, 5876.794312199138, 5881.500072493886, 5887.381824908409, 5913.852153696106, 4047.7166598337835, 4074.1851629674184, 4244.53310135891, 4295.742255464682, 4311.547287534827, 4508.211063063951, 4518.277075667877, 4565.223911934979, 4582.702124361906, 4592.471865735483, 2287.4395773035712, 2287.942801429944, 2320.593896068215, 2320.733115691717, 2328.918487852917, 801.555136899015, 820.8112134209165, 826.6652005937605, 853.9316854651613, 880.1814312689132, 309.57433528897764, 321.77958098702464, 338.0854787798998, 350.6616115448604, 369.56391458079185, 8419.663213471515, 8587.699430519902, 8935.553222338856, 9342.439453632804, 9587.760305992406, 337.6387265625806, 337.7466899825131, 337.85298910200225, 350.41305812763517, 354.33562071116654, 4695.765211739467, 4701.529847015271, 4784.712917224908, 4821.035792841376, 4876.122297986397, 402663.0, 404528.0, 413072.0, 414883.0, 416875.0, 56371.0, 56847.43152568504, 57973.0, 58265.0, 58482.415175847695, 389.96658854035894, 396.58358723340376, 398.1300857626096, 400.27550134257086, 400.93184158693094, 8121.187881211831, 8247.546384948886, 8314.792130196793, 8369.707060252862, 8406.83186336282, 26557.0, 26602.20193394201, 27106.32234194161, 27222.455550889266, 27338.589921151597, 37135.257294853414, 37563.81218094001, 37900.2419951605, 37905.24189516139, 38036.0, 4732.905341893074, 4745.145873742759, 4856.174450343379, 4862.489438609036, 4904.607631389409, 8978.0, 9147.63409463614, 9176.816463670822, 9225.354225204439, 9404.059594040542, 7694.615269236628, 8064.6370913307865, 8075.152109028468, 8124.350051995944, 8134.023917129983, 7618.961905190438, 7715.884261736191, 7739.5743234122665, 7876.6849326028605, 7952.681892724227, 6660.933390666031, 8076.192380761877, 8140.959295203486, 8288.502689838388, 8296.211859873303, 4143.3370660694145, 4371.2568863293955, 4379.58393952574, 4483.080968401535, 4791.281307803718, 7496.437767167593, 7673.731419400518, 7748.883766743391, 7827.686892524235, 7844.294013538809], "dojo.html": [2396.2811156653, 2533.290678609989, 2544.694636643602, 2546.3506805764528, 2588.7411258874126, 3987.700922430815, 4079.4696689430334, 4107.466029416171, 4150.418941348206, 4241.851535196272, 4258.339957306623, 4265.189613973343, 4297.162053399588, 4363.192809330276, 4369.934450983238, 3800.258949504848, 3902.9852238418075, 3908.2965066288198, 3951.9012024699323, 4087.734297270683, 3983.0, 3999.2601368746728, 4040.0505881117915, 4042.0, 4051.5948405159543, 202.46895156777316, 3942.073612701013, 3968.3452230381954, 3984.740991835536, 4014.7390419622775, 3935.822887970048, 3944.349182384903, 3959.307121253769, 3998.7000974926996, 4014.979925100385, 3909.7263191576603, 3923.313420151462, 3932.3904794756572, 3983.24318379507, 4024.9937515621095, 4016.397540368968, 4136.193442278757, 4142.751434913915, 4233.830646774156, 4267.743935363857, 4352.7823608819435, 4437.822487100512, 4440.4893437254805, 4489.663275254369, 4490.371348011281, 4573.245414506636, 4577.9542204577865, 4583.9083218335445, 4588.426446694163, 4629.282461218517, 4090.81591328385, 4159.147374788222, 4203.159368126387, 4280.165367753259, 4294.849680261207, 4565.338025986213, 4638.2115040443205, 4649.883752906205, 4668.766561671903, 4706.788194531186, 4386.1008493258805, 4499.550044995474, 4505.301678239878, 4506.436695413074, 4576.405067341224, 4416.1609294233995, 4543.0232500012, 4550.067236216568, 4629.537046295411, 4644.907101857944, 4430.13612345596, 4507.954920450819, 4518.774061296987, 4549.340345649863, 4585.358049873021, 4417.624501917373, 4466.464024317038, 4481.641468682497, 4489.034857505652, 4531.864044078683, 3365.3101114272004, 3501.439769636846, 3510.5611798525183, 3514.472829075608, 3530.1527633367805, 3084.1826915867314, 3167.762417818673, 3168.683131686813, 3207.887723929651, 3208.6149662040702, 4271.700980931367, 4290.227759003409, 4293.0, 4296.505901821331, 4355.912881742347, 4370.082282720601, 4510.255807791743, 4531.207038768202, 4579.496255411902, 4582.5417458253905, 4202.159568086395, 4277.786110694453, 4282.8715138545895, 4337.783110844445, 4378.014946637045, 4012.3580227163516, 4023.6781057515327, 4027.1140349123148, 4029.5567487576345, 4042.9797851010558, 4512.503624601357, 4623.791929363254, 4645.02454484562, 4667.789949452351, 4756.5956893664425, 4437.689361744647, 4479.7536135511555, 4502.977485112553, 4543.931841022453, 4547.772611369484, 4695.225287827607, 4697.765111744331, 4706.788194531186, 4765.6187504998825, 4775.068861572099, 4283.0, 4385.386045953633, 4390.275604525217, 4518.344839998247, 4526.388937493396, 4407.316865885793, 4443.511213766547, 4455.576720211575, 4489.236829739018, 4514.45826500822, 4355.368471571668, 4426.313921342197, 4437.378766972562, 4454.510003899503, 4480.731156130512, 4244.10873716523, 4343.066240758252, 4350.58669426404, 4430.269005614037, 4437.572708381059, 4172.248995180897, 4213.41012258278, 4253.8723838284905, 4271.786410679516, 4296.742195468282, 4401.471823381215, 4450.977745111254, 4454.420925279693, 4473.46318441776, 4523.004938913434, 4200.936985945152, 4291.291936830388, 4321.675874309502, 4388.4733831940375, 4401.977990110029], "mootools.html": [1002.1531805624245, 1143.5254369436684, 1260.1053252190943, 1315.83552055993, 1441.8918581106416, 5535.612507124503, 5898.056310990242, 6054.5459090568165, 6237.251529816417, 6243.46930510906, 6036.09458581213, 6140.478059364948, 6147.446729794317, 6147.907781383283, 6209.9068513972325, 1748.7988881278688, 1749.9737503937451, 1773.7694099767011, 1776.9555761106012, 1779.4127937780502, 1743.328818404917, 1752.8510076643502, 1766.5936834528065, 1767.8850874693103, 1768.3899054826065, 1654.8841581089328, 1658.8424099710508, 1662.9251683674263, 1668.1659170414794, 1679.7816283883078, 1705.6503416799526, 1708.2142214581309, 1709.350446830209, 1715.759793628893, 1745.3629425259817, 1725.2495164603438, 1757.0424118855126, 1758.9648207035916, 1760.70068088424, 1761.7357396390644, 5481.260029895953, 6128.724207410677, 6149.13912052313, 6176.752929882799, 6207.81376558704, 3223.161977885743, 3344.3144155448076, 3563.6970857476886, 3657.9817100914593, 3680.871169509081, 2277.5786479501344, 2286.634138537843, 2327.615943369342, 2333.0084713996484, 2342.3441436397834, 691.0877641513205, 691.7855464805926, 714.6283932355146, 730.1347902735223, 736.3446532586003, 8305.37709671777, 8401.53791541471, 8426.494410335337, 8427.367947403907, 8444.788880278042, 3194.9840250798597, 3249.902502924916, 3318.253392986607, 3333.283344081034, 3345.749068819848, 7286.7085316586745, 7304.744333948286, 7311.488195826348, 7330.413566914634, 7376.0411146550605, 3713.461548075568, 3724.404095344732, 3745.1198968242443, 3746.3631182699005, 3770.811459427018, 3353.5305057292, 3361.7310615150727, 3371.713404360657, 3372.898813035613, 3392.38936991339, 2674.2244749022566, 2697.905573304964, 2699.838009719423, 2716.8098233123887, 2725.8364498130177, 883.4037025008093, 884.12471653063, 891.3983061433636, 899.4738078224312, 901.2249465459699, 1033.426448321174, 1037.3983089807894, 1038.657243109772, 1068.513826209073, 1072.7639919217759, 5861.853453663607, 5893.941060589425, 5925.229720136354, 5930.11048342752, 5931.377205393458, 332.1082892433823, 344.211755080867, 345.37831902575266, 347.633246924492, 348.6635396842009, 4549.522300158502, 4649.651276154302, 4652.97673511637, 4660.254359302496, 4674.789634466457, 6611.404973552403, 6856.348646878539, 6955.234924158339, 7152.856942861114, 7470.2903224193615, 7195.352418282379, 7220.097487814023, 7261.0, 7287.963560182166, 7300.780976570712, 5715.428457154335, 5795.275590551181, 5922.615030022948, 5933.080372542263, 5935.347111817697, 5865.237519122486, 5880.8235752927485, 5895.086261629454, 5912.290525137011, 5916.023856063702, 6362.713677884599, 6519.315471875574, 6533.150690410216, 6646.9002964956535, 6672.132622759011, 6597.60414375139, 6735.0, 6751.966240168767, 6778.288279730557, 6933.757318493828, 5486.835394938158, 5536.892621475801, 5538.418466061005, 5541.362743284574, 5588.441155884379, 6048.5161187105805, 6066.817995460143, 6100.572959892942, 6115.908261376172, 6134.079888016833, 5500.697461639648, 5619.157126431068, 5675.914861277001, 5695.914561281667, 5774.076147816497, 5468.398476167698, 5501.174823776466, 5521.420250873601, 5559.833205003856, 5610.354809196994, 5524.861878453071, 5561.805336813354, 5565.916511252415, 5579.16312553104, 5633.492985631149, 5051.949480505148, 5071.39143302806, 5084.7966081356335, 5091.516305950929, 5106.923396148986, 5069.721165335942, 5119.5648369887485, 5135.666181698178, 5147.0, 5155.664881782672], "ext.html": [441.3225698552721, 446.8101057050753, 452.6785981952813, 460.89169045274355, 482.65731330755165, 24094.156704515346, 24798.75201247987, 31806.68193318069, 32715.182120447, 32752.344953100925, 34507.30985380291, 35123.0, 35178.82410587944, 35564.0, 35574.46638300428, 6541.7710380136705, 7318.524295920762, 7494.175640679521, 7500.774976750679, 7515.210902855176, 6649.534532582721, 6822.829429264283, 9031.774205644846, 9042.954785226098, 9078.86381704275, 8827.205551500363, 8896.510691911943, 8899.199072083511, 8919.24186444153, 8949.463032218087, 6705.497087718391, 6895.827604309882, 8894.24398926092, 8995.145461181177, 8999.19007289347, 6568.0147977803235, 8727.170918762708, 8968.596413161424, 9020.0, 9029.5620182551, 31998.520022199453, 32525.349493010242, 32577.511337329957, 32596.511052334234, 32674.346513069606, 2218.556288742258, 2300.1374484568287, 2336.6728657987896, 2486.477839653675, 2611.764941155286, 22565.097396104135, 22710.77289227103, 23348.64977025329, 23502.529949400916, 23717.407064823346, 1884.0297246917848, 1888.490107670935, 1907.3229003703625, 1923.2979962313796, 1931.9034048297528, 214361.0, 215818.0, 216021.0, 217470.0, 219686.0, 43481.0, 44521.77739111284, 44602.33096503555, 50646.24030639543, 50864.71108800113, 52602.0, 53761.0, 54098.72950635222, 54117.72941135269, 54169.0, 12592.237086807854, 12683.048771342186, 12728.681782955315, 12735.55425560101, 12784.0, 9448.858267126, 9454.149126578503, 9504.95247523758, 9511.096445837635, 9529.523523823782, 16176.514704558882, 16242.269097890623, 16321.510354689379, 16326.510204693877, 16419.835801642068, 6297.96851015742, 6586.473082153416, 6608.86782264352, 6660.933390666129, 6663.267040625527, 689.5276735436242, 725.9637018149072, 742.3652776875801, 792.5324058805332, 869.8129902071086, 23053.0, 23304.65043024356, 23442.76557234406, 23457.7654223459, 23490.295291141294, 812.9431738739614, 828.3580225325301, 862.8662557303628, 903.1916434790826, 940.9931373430363, 11978.760424791455, 12144.514219431301, 12253.264804111783, 12257.754844903231, 12265.08011899111, 256054.0, 260349.0, 260808.0, 262174.0, 262596.0, 45127.77436112864, 45205.77397112994, 45276.3208551872, 45289.54710452853, 45301.546984529734, 1074.9408782517037, 1093.1637297467444, 1104.690686607751, 1105.8285965675334, 1125.4091601909063, 21530.892345538174, 22962.0, 23577.0, 23583.174588889306, 23739.287821365386, 37116.81441592775, 37415.0, 37465.81267093647, 37951.81024094862, 38087.238255235294, 206309.0, 209181.0, 209928.0, 212702.0, 212947.0, 24707.25878223656, 25338.493230135664, 25420.745792542577, 25488.10791622284, 25724.356891077874, 31818.84090579532, 32040.198995024377, 32164.35671286608, 41157.382639259835, 43190.56809431865, 29964.850175748983, 32289.51565726469, 32361.514577281832, 32452.837735812114, 32489.675103248665, 25334.746652533977, 31321.373572527966, 32155.0, 32469.512957305185, 35061.47407788936, 31617.84191079122, 31954.20114497156, 32363.51454728134, 32853.67146328506, 33246.50130248097, 26894.462110758068, 28778.712212877603, 29535.26161845971, 29959.101226963227, 29962.25094372658, 20990.580188396452, 21079.15683372709, 21273.468163296042, 21290.467738306048, 21406.0], "prototype.html": [227.3509131429768, 233.61920070285433, 239.67643681030611, 240.81216651012207, 253.58412203985478, 4974.228994505853, 4982.800687972482, 5008.424031236414, 5040.1935690289565, 5063.6202284828605, 4771.522847715227, 4859.173940430126, 4896.53482919123, 4907.1412502812045, 4949.133901567229, 3752.8311225994757, 3798.620137986193, 3807.5240594925635, 3809.371453710148, 3818.179091495328, 3812.3137835189655, 3820.2550502651993, 3826.598207188233, 3838.2323535292912, 3848.26882892251, 3544.8227588620593, 3606.6573675500786, 3647.106458917569, 3655.94516082259, 3780.2250538639514, 3788.8295026723863, 3791.0, 3792.469054332396, 3795.0512371907025, 3803.6766874815676, 3284.868605255787, 3295.1103202135528, 3304.041827869915, 3315.4529502632035, 3333.28334408101, 4834.709917404932, 4838.588719958808, 4863.610911127137, 4868.440129385131, 4868.561829435333, 4123.546409894909, 4319.438472998521, 4321.524632290446, 4340.956590434087, 4348.326009468537, 5200.349956255468, 5203.791848326063, 5207.791688332462, 5209.531142197183, 5229.869253268661, 3412.9488057679155, 3454.9481757773656, 3469.809160496172, 3476.2699833035094, 3478.7738796978115, 5366.302380690485, 5460.099083651193, 5471.945280547184, 5473.863153421196, 5541.113421852484, 3404.6595340465756, 3433.9828300858835, 3435.811030393352, 3441.346144232588, 3447.1554469155217, 3366.360391525602, 3466.7226621870695, 3562.4656301554455, 3611.620779818134, 3612.6206748291575, 4207.474065741782, 4211.220924129046, 4212.262854000538, 4225.514065882463, 4231.830726770895, 5204.375474943031, 5226.137687281556, 5232.790688372423, 5233.6074794389815, 5238.607104467104, 1252.661781319057, 1262.5391732017747, 1265.6709255593428, 1268.6320966919675, 1272.0904553244475, 795.327947884037, 815.4251252866715, 817.8814071959532, 829.5852073963018, 829.788403956987, 5022.874428139253, 5022.949770502249, 5032.823851165192, 5034.194528875362, 5054.721990290495, 5428.6199966002005, 5444.802143528417, 5446.128619420873, 5454.318210223722, 5482.122860342406, 4863.440704318978, 5019.887669644843, 5029.321041659402, 5031.823886163967, 5037.949620503748, 2869.9426011479654, 2887.97112028877, 2899.4635992341487, 2986.357933044406, 2994.5807586937844, 5645.68948707825, 5651.830445086572, 5655.066913959233, 5668.433156684298, 5727.11229759388, 5635.267415235993, 5638.210650508932, 5643.379228284885, 5647.068233741386, 5662.292213473316, 5409.215663728737, 5567.220589117608, 5649.915251271316, 5682.6306290091015, 5685.260916080966, 5473.2063850742215, 5480.753366098615, 5482.862928426821, 5490.0, 5511.779528818803, 5367.892642147213, 5394.0, 5400.675959442446, 5407.567394608343, 5411.0, 5437.238786569805, 5620.690862002465, 5633.2113504110275, 5642.2665053544415, 5643.746031428514, 3486.3201675673, 3558.323918455485, 3559.7864128152396, 3566.465030245484, 3568.2149927016017, 5458.208559758892, 5480.588955828409, 5481.561475082063, 5490.396056433869, 5497.862553436036, 5286.9471305288, 5293.338332708411, 5301.390340110936, 5319.494648008433, 5320.255164277081, 5151.742412879266, 5309.442508536703, 5312.920306195333, 5321.2816269804625, 5328.440513746156, 5158.123119069842, 5161.122609156528, 5165.070287348313, 5170.405403378509, 5176.948230517647, 5295.973520132375, 5302.973485132549, 5317.468253174807, 5334.732738586008, 5434.646747961528, 5174.301469301747, 5180.6891586504935, 5187.533122019036, 5194.610404219623, 5202.297689811979], "yui.html": [522.4749127127237, 579.4263678957831, 585.8506080949358, 590.8316129902978, 594.7977687586219, 10597.894021059787, 10731.248812583122, 10741.892581074197, 10750.0, 10780.838287425695, 9951.253655975812, 10121.797564048733, 10251.897481025188, 10278.229132815031, 10291.279610427273, 548.2954403591386, 561.9578531610125, 704.2148004974442, 717.9030830837848, 721.4480922094601, 556.0769123255396, 704.2429388407456, 720.881054625986, 721.4516967105012, 721.7149226055705, 714.0895358418032, 738.9150247721527, 743.2938708227178, 744.0439035838948, 744.9962750186269, 567.5487987050304, 575.7294071786254, 576.815419065899, 737.2185483387626, 741.5587725303436, 536.088649296198, 538.5341679447289, 542.1975476295105, 552.2323969682145, 552.353746117044, 10554.366737995744, 10926.890731092746, 10927.235093543455, 11021.118310535137, 11047.83428248577, 9261.490618016007, 9306.0, 9545.188658963996, 9729.951350243275, 9829.950850245774, 7479.4016478682115, 7501.924980750232, 7656.61716914152, 7933.880991785128, 8018.318442932357, 2650.496405682914, 2666.5066962611786, 2673.692525359589, 2709.322669332667, 2730.4539092181444, 32731.836340818383, 32999.34001319984, 38041.239175216615, 38181.618183818086, 38847.0, 5438.864028399243, 5480.0, 5486.1222204447095, 5522.91715624266, 5585.8603534911135, 9794.902050979399, 9819.214462842956, 9828.705138845846, 9875.259355548362, 9878.703638890845, 4696.436427628638, 4740.478547359788, 4819.108464933998, 4832.903341933212, 4835.903281934412, 2738.3017330580574, 2846.6868644449096, 2914.519104347759, 3009.714077162666, 3025.1227144128397, 2096.8217701495546, 2121.2363549122306, 2123.58590074937, 2130.041481333406, 2156.676498525234, 318.05696111030903, 324.02468569605657, 326.89049168528334, 327.20978836110527, 329.7378584025705, 391.6866506794553, 393.8936487148511, 427.04768366542163, 455.41024373436477, 468.28118837584145, 6018.337982821886, 6353.30113687494, 6463.773767918195, 6476.6114033158165, 6532.150820393318, 310.58847027688404, 432.565271901743, 433.3543020898901, 445.14976395085233, 472.3906161052273, 2966.2732630505666, 2993.191838203673, 3216.9195770105935, 3316.9668303316657, 3318.618358888759, 44460.77769611196, 44690.776546117064, 44944.550554494694, 45326.773366132955, 45457.31814022792, 36946.44580331297, 38048.0, 39878.60121398807, 39955.40066898999, 40108.0, 35731.285374292886, 37044.888653340444, 37331.0, 37470.62529374726, 37564.24871502555, 6255.78104766331, 6317.620942743266, 6318.399752023551, 6365.936340636719, 6481.4814814815645, 25990.74009259959, 26089.73910260873, 26874.462510749283, 27288.72711272862, 27367.589486158122, 33083.66916330902, 33219.0, 33577.66422335745, 33686.0, 34889.65110348864, 6058.84852878664, 6071.696415179135, 6108.969455152695, 6377.76852457714, 6426.871462570629, 8531.91468085336, 8739.606717697592, 8779.25376343018, 8838.29293656493, 9136.862947055666, 8435.32517398619, 8581.570921453778, 8584.484930904166, 8632.438891472286, 8641.82716345657, 8339.20777526134, 8368.790780230544, 8412.0, 8422.368322375723, 8461.915380846112, 8335.374846886387, 8414.284785793276, 8480.32157427392, 8545.700900468453, 8569.48583085017, 6978.825529361807, 7160.212376638669, 7239.529430587206, 7555.168931417649, 7860.882086768589, 6208.286047104641, 6710.328967103251, 6842.571135886692, 6967.09427774386, 6983.685734142077]}, "summary": {"lowerIsBetter": false, "suite": 5257.679903671614, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5439.92402443407, "unit": "ms", "value": 5439.92402443407}, "dojo.html": {"lowerIsBetter": false, "filtered": 4165.171020104584, "unit": "ms", "value": 4165.171020104584}, "mootools.html": {"lowerIsBetter": false, "filtered": 3425.7085466201393, "unit": "ms", "value": 3425.7085466201393}, "ext.html": {"lowerIsBetter": false, "filtered": 15178.423411638581, "unit": "ms", "value": 15178.423411638581}, "prototype.html": {"lowerIsBetter": false, "filtered": 3908.4163919003004, "unit": "ms", "value": 3908.4163919003004}, "yui.html": {"lowerIsBetter": false, "filtered": 4586.819136886301, "unit": "ms", "value": 4586.819136886301}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0103"}, "testrun": {"date": 1447429230, "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": "20151113053738", "branch": "Fx-Team", "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 208.0, 204.0, 203.0, 200.0, 197.0, 206.0, 208.0, 206.0, 201.0], "ai-astar": [135.0, 139.0, 134.0, 140.0, 141.0, 139.0, 140.0, 133.0, 124.0, 140.0], "imaging-gaussian-blur": [157.0, 148.0, 156.0, 156.0, 155.0, 146.0, 141.0, 148.0, 148.0, 155.0], "audio-beat-detection": [197.0, 165.0, 196.0, 207.0, 162.0, 189.0, 187.0, 158.0, 207.0, 164.0], "json-stringify-tinderbox": [82.0, 83.0, 87.0, 90.0, 89.0, 86.0, 87.0, 87.0, 87.0, 85.0], "stanford-crypto-pbkdf2": [199.0, 190.0, 200.0, 201.0, 197.0, 182.0, 188.0, 215.0, 221.0, 197.0], "json-parse-financial": [68.0, 71.0, 73.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 75.0], "stanford-crypto-sha256-iterative": [88.0, 89.0, 92.0, 91.0, 93.0, 92.0, 91.0, 93.0, 91.0, 92.0], "audio-fft": [98.0, 98.0, 107.0, 155.0, 87.0, 90.0, 89.0, 91.0, 157.0, 86.0], "imaging-darkroom": [163.0, 162.0, 162.0, 162.0, 163.0, 169.0, 155.0, 162.0, 171.0, 165.0], "stanford-crypto-ccm": [156.0, 157.0, 157.0, 157.0, 163.0, 159.0, 182.0, 164.0, 170.0, 158.0], "audio-oscillator": [123.0, 127.0, 172.0, 114.0, 114.0, 119.0, 160.0, 112.0, 113.0, 161.0], "stanford-crypto-aes": [104.0, 110.0, 109.0, 122.0, 109.0, 110.0, 110.0, 109.0, 123.0, 111.0], "imaging-desaturate": [130.0, 120.0, 120.0, 120.0, 121.0, 121.0, 119.0, 130.0, 120.0, 126.0]}, "summary": {"lowerIsBetter": true, "suite": 1921.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 105.8, "unit": "ms", "value": 105.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 199.0, "unit": "ms", "value": 199.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 183.2, "unit": "ms", "value": 183.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 163.4, "unit": "ms", "value": 163.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.6, "unit": "ms", "value": 73.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 131.5, "unit": "ms", "value": 131.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 136.5, "unit": "ms", "value": 136.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 203.0, "unit": "ms", "value": 203.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 91.2, "unit": "ms", "value": 91.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 86.3, "unit": "ms", "value": 86.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 151.0, "unit": "ms", "value": 151.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 111.7, "unit": "ms", "value": 111.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 122.7, "unit": "ms", "value": 122.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0103"}, "testrun": {"date": 1447429230, "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": "20151113053738", "branch": "Fx-Team", "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [243.74240583232077], "Encrypt": [411.0152075626798], "NavierStokes": [7215.827338129497], "Decrypt": [7328.467153284671], "Splay": [792.3930269413629], "Richards": [210.3049421661409], "RegExp": [37666.666666666664], "Earley": [1018.3299389002036], "Boyer": [16241.935483870968], "RayTrace": [2408.653846153846]}, "summary": {"lowerIsBetter": false, "suite": 14719.20176129515, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 271.2617846460618, "unit": "score", "value": 271.2617846460618}, "Encrypt": {"lowerIsBetter": false, "filtered": 647.6183730000004, "unit": "score", "value": 647.6183730000004}, "NavierStokes": {"lowerIsBetter": false, "filtered": 205.65902293120644, "unit": "score", "value": 205.65902293120644}, "Decrypt": {"lowerIsBetter": false, "filtered": 36.32151095617529, "unit": "score", "value": 36.32151095617529}, "Splay": {"lowerIsBetter": false, "filtered": 102.84164200000004, "unit": "score", "value": 102.84164200000004}, "RegExp": {"lowerIsBetter": false, "filtered": 24.185442477876116, "unit": "score", "value": 24.185442477876116}, "Richards": {"lowerIsBetter": false, "filtered": 167.86101, "unit": "score", "value": 167.86101}, "Earley": {"lowerIsBetter": false, "filtered": 654.4666659999999, "unit": "score", "value": 654.4666659999999}, "Boyer": {"lowerIsBetter": false, "filtered": 41.033471698113175, "unit": "score", "value": 41.033471698113175}, "RayTrace": {"lowerIsBetter": false, "filtered": 307.2209820359282, "unit": "score", "value": 307.2209820359282}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0103"}, "testrun": {"date": 1447429230, "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": "20151113053738", "branch": "Fx-Team", "revision": "55174ceac7e5b3d3f00afbce746966c0efb2890d"}}] 08:01:13 INFO - RETURN: dromaeo_css: 5257.68 08:01:13 INFO - RETURN: kraken: 1921.20 08:01:13 INFO - RETURN: v8_7: 14719.20 08:01:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14719.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1921.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5257.68"}}} 08:01:13 INFO - Return code: 0 08:01:13 INFO - # TBPL SUCCESS # 08:01:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:01:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:01:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:01:13 INFO - 2015-11-13 08:01:13.744 screenresolution[1663:9895] starting screenresolution argv=screenresolution get 08:01:13 INFO - 2015-11-13 08:01:13.748 screenresolution[1663:9895] Display 0: 1600x1200x32@60 08:01:13 INFO - 2015-11-13 08:01:13.755 screenresolution[1664:9898] starting screenresolution argv=screenresolution list 08:01:13 INFO - Available Modes on Display 0 08:01:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:01:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:01:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:01:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:01:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:01:14 INFO - Intel HD Graphics 3000: 08:01:14 INFO - Chipset Model: Intel HD Graphics 3000 08:01:14 INFO - Type: GPU 08:01:14 INFO - Bus: Built-In 08:01:14 INFO - VRAM (Total): 512 MB 08:01:14 INFO - VRAM (Dynamic, Max): 10 08:01:14 INFO - Vendor: Intel (0x8086) 08:01:14 INFO - Device ID: 0x0116 08:01:14 INFO - Revision ID: 0x0009 08:01:14 INFO - Displays: 08:01:14 INFO - Display: 08:01:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:01:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:01:14 INFO - Display Serial Number: 1600x1200 60 08:01:14 INFO - Main Display: Yes 08:01:14 INFO - Mirror: Off 08:01:14 INFO - Online: Yes 08:01:14 INFO - Rotation: Supported 08:01:14 INFO - Return code: 0 08:01:14 INFO - Running post-action listener: _resource_record_post_action 08:01:14 INFO - Running post-run listener: _resource_record_post_run 08:01:15 INFO - Total resource usage - Wall time: 1338s; CPU: 29.0%; Read bytes: 39670784; Write bytes: 665316352; Read time: 22955; Write time: 1275034 08:01:15 INFO - install - Wall time: 94s; CPU: 23.0%; Read bytes: 342987264; Write bytes: 346351616; Read time: 39745; Write time: 948027 08:01:15 INFO - run-tests - Wall time: 1245s; CPU: 30.0%; Read bytes: 38573056; Write bytes: 316747776; Read time: 18340; Write time: 258288 08:01:15 INFO - Running post-run listener: _upload_blobber_files 08:01:15 INFO - Blob upload gear active. 08:01:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:01:15 INFO - Copying logs to upload dir... 08:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1518.049274 ========= master_lag: 4.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 22 secs) (at 2015-11-13 08:01:19.192690) ========= ========= Started set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-13 08:01:19.196044) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010709 build_url: 'https://queue.taskcluster.net/v1/task/lxn0xktCQ6KUSQgTrEl4BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 4.20 ========= ========= Finished set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-13 08:01:23.403396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-13 08:01:23.403743) ========= 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.ni2UJanpiS/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.nXe2FUNxZP/Listeners TMPDIR=/var/folders/_s/j0pbs4jn69927l1gpmf9xcrm00000w/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.005674 ========= master_lag: 3.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-13 08:01:26.951960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:01:26.952455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:01:27.143366) ========= ========= Total master_lag: 12.01 =========